builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-058 starttime: 1464619700.77 results: success (0) buildid: 20160530064349 builduid: 2ffdc8a934f44a749eb2490bfaed357e revision: f84a95dce3aaaec51ccaf98398eed74f41e30245 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-30 07:48:20.767396) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-30 07:48:20.767870) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-30 07:48:20.768144) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-30 07:48:20.784951) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 07:48:20.785266) ========= 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=0e2a256762fed810e2f0f810000001b3-1464619700.395097-1071734211 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-30 07:48:21-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.2M=0s 2016-05-30 07:48:21 (46.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.095135 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 07:48:20.894715) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 07:48:20.895105) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', '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=0e2a256762fed810e2f0f810000001b3-1464619700.395097-1071734211 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020924 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 07:48:20.945124) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-30 07:48:20.945548) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev f84a95dce3aaaec51ccaf98398eed74f41e30245 --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 f84a95dce3aaaec51ccaf98398eed74f41e30245 --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=0e2a256762fed810e2f0f810000001b3-1464619700.395097-1071734211 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-30 07:48:21,270 truncating revision to first 12 chars 2016-05-30 07:48:21,270 Setting DEBUG logging. 2016-05-30 07:48:21,270 attempt 1/10 2016-05-30 07:48:21,270 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/f84a95dce3aa?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-30 07:48:22,178 unpacking tar archive at: fx-team-f84a95dce3aa/testing/mozharness/ program finished with exit code 0 elapsedTime=1.231457 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-30 07:48:22.190416) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-30 07:48:22.190756) ========= script_repo_revision: f84a95dce3aaaec51ccaf98398eed74f41e30245 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-30 07:48:22.191150) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-30 07:48:22.191425) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-30 07:48:22.200832) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-05-30 07:48:22.201125) ========= /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=0e2a256762fed810e2f0f810000001b3-1464619700.395097-1071734211 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:48:22 INFO - MultiFileLogger online at 20160530 07:48:22 in /builds/slave/test 07:48:22 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 07:48:22 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:48:22 INFO - {'append_to_log': False, 07:48:22 INFO - 'base_work_dir': '/builds/slave/test', 07:48:22 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 07:48:22 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:48:22 INFO - 'branch': 'Fx-Team-Non-PGO', 07:48:22 INFO - 'buildbot_json_path': 'buildprops.json', 07:48:22 INFO - 'config_files': ('talos/linux_config.py',), 07:48:22 INFO - 'default_actions': ('clobber', 07:48:22 INFO - 'read-buildbot-config', 07:48:22 INFO - 'download-and-extract', 07:48:22 INFO - 'populate-webroot', 07:48:22 INFO - 'create-virtualenv', 07:48:22 INFO - 'install', 07:48:22 INFO - 'run-tests'), 07:48:22 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:48:22 INFO - 'download_minidump_stackwalk': True, 07:48:22 INFO - 'download_symbols': 'ondemand', 07:48:22 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:48:22 INFO - 'tooltool.py': '/tools/tooltool.py', 07:48:22 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:48:22 INFO - '/tools/misc-python/virtualenv.py')}, 07:48:22 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:48:22 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:48:22 INFO - 'installer_path': 'installer.exe', 07:48:22 INFO - 'log_level': 'info', 07:48:22 INFO - 'log_name': 'talos', 07:48:22 INFO - 'log_to_console': True, 07:48:22 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:48:22 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:48:22 INFO - 'opt_config_files': (), 07:48:22 INFO - 'pip_index': False, 07:48:22 INFO - 'sps_profile': False, 07:48:22 INFO - 'sps_profile_interval': 0, 07:48:22 INFO - 'suite': 'dromaeojs', 07:48:22 INFO - 'system_bits': '32', 07:48:22 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:48:22 INFO - 'title': 'talos-linux64-ix-058', 07:48:22 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:48:22 INFO - 'use_talos_json': True, 07:48:22 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:48:22 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:48:22 INFO - 'work_dir': 'build'} 07:48:22 INFO - ##### 07:48:22 INFO - ##### Running clobber step. 07:48:22 INFO - ##### 07:48:22 INFO - Running pre-action listener: _resource_record_pre_action 07:48:22 INFO - Running main action method: clobber 07:48:22 INFO - rmtree: /builds/slave/test/build 07:48:22 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:48:23 INFO - Running post-action listener: _resource_record_post_action 07:48:23 INFO - ##### 07:48:23 INFO - ##### Finished clobber step (success) 07:48:23 INFO - ##### 07:48:23 INFO - ##### 07:48:23 INFO - ##### Running read-buildbot-config step. 07:48:23 INFO - ##### 07:48:23 INFO - Running pre-action listener: _resource_record_pre_action 07:48:23 INFO - Running main action method: read_buildbot_config 07:48:23 INFO - Using buildbot properties: 07:48:23 INFO - { 07:48:23 INFO - "project": "", 07:48:23 INFO - "product": "firefox", 07:48:23 INFO - "script_repo_revision": "production", 07:48:23 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 07:48:23 INFO - "repository": "", 07:48:23 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 07:48:23 INFO - "buildid": "20160530064349", 07:48:23 INFO - "pgo_build": "False", 07:48:23 INFO - "basedir": "/builds/slave/test", 07:48:23 INFO - "buildnumber": 3013, 07:48:23 INFO - "slavename": "talos-linux64-ix-058", 07:48:23 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 07:48:23 INFO - "platform": "ubuntu64_hw", 07:48:23 INFO - "scheduler": "tests-fx-team-linux64-talos", 07:48:23 INFO - "branch": "fx-team", 07:48:23 INFO - "repo_path": "integration/fx-team", 07:48:23 INFO - "revision": "f84a95dce3aaaec51ccaf98398eed74f41e30245", 07:48:23 INFO - "stage_platform": "linux64", 07:48:23 INFO - "builduid": "2ffdc8a934f44a749eb2490bfaed357e", 07:48:23 INFO - "slavebuilddir": "test" 07:48:23 INFO - } 07:48:23 INFO - Found installer url https://queue.taskcluster.net/v1/task/X_Eve2J4SzS1ECMZh6ZRjw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 07:48:23 INFO - Running post-action listener: _resource_record_post_action 07:48:23 INFO - ##### 07:48:23 INFO - ##### Finished read-buildbot-config step (success) 07:48:23 INFO - ##### 07:48:23 INFO - ##### 07:48:23 INFO - ##### Running download-and-extract step. 07:48:23 INFO - ##### 07:48:23 INFO - Running pre-action listener: _resource_record_pre_action 07:48:23 INFO - Running main action method: download_and_extract 07:48:23 INFO - mkdir: /builds/slave/test/build/tests 07:48: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')]} 07:48:23 INFO - https://queue.taskcluster.net/v1/task/X_Eve2J4SzS1ECMZh6ZRjw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:48:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X_Eve2J4SzS1ECMZh6ZRjw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 07:48:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X_Eve2J4SzS1ECMZh6ZRjw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 07:48:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X_Eve2J4SzS1ECMZh6ZRjw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 07:48:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X_Eve2J4SzS1ECMZh6ZRjw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 07:48:24 INFO - Downloaded 1361 bytes. 07:48:24 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 07:48:24 INFO - Using the following test package requirements: 07:48:24 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 07:48:24 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:48:24 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:48:24 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:48:24 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:48:24 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:48:24 INFO - u'jsshell-linux-x86_64.zip'], 07:48:24 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:48:24 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:48:24 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 07:48:24 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:48:24 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:48:24 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:48:24 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:48:24 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:48:24 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:48:24 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:48:24 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:48:24 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:48:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:48:24 INFO - https://queue.taskcluster.net/v1/task/X_Eve2J4SzS1ECMZh6ZRjw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:48:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X_Eve2J4SzS1ECMZh6ZRjw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:48:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X_Eve2J4SzS1ECMZh6ZRjw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:48:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X_Eve2J4SzS1ECMZh6ZRjw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:48:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X_Eve2J4SzS1ECMZh6ZRjw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:48:26 INFO - Downloaded 22838217 bytes. 07:48:26 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:48:26 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:48:27 INFO - Return code: 0 07:48:27 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 07:48: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')]} 07:48:27 INFO - https://queue.taskcluster.net/v1/task/X_Eve2J4SzS1ECMZh6ZRjw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:48:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X_Eve2J4SzS1ECMZh6ZRjw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:48:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X_Eve2J4SzS1ECMZh6ZRjw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:48:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X_Eve2J4SzS1ECMZh6ZRjw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:48:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X_Eve2J4SzS1ECMZh6ZRjw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:48:28 INFO - Downloaded 22838217 bytes. 07:48:28 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:48:28 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:48:29 INFO - Return code: 0 07:48:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:48:29 INFO - https://queue.taskcluster.net/v1/task/X_Eve2J4SzS1ECMZh6ZRjw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:48:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X_Eve2J4SzS1ECMZh6ZRjw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 07:48:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X_Eve2J4SzS1ECMZh6ZRjw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 07:48:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X_Eve2J4SzS1ECMZh6ZRjw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 07:48:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X_Eve2J4SzS1ECMZh6ZRjw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:48:30 INFO - Downloaded 10834055 bytes. 07:48:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:48:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 07:48:30 INFO - Return code: 0 07:48: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')]} 07:48:30 INFO - https://queue.taskcluster.net/v1/task/X_Eve2J4SzS1ECMZh6ZRjw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:48:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X_Eve2J4SzS1ECMZh6ZRjw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:48:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X_Eve2J4SzS1ECMZh6ZRjw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:48:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X_Eve2J4SzS1ECMZh6ZRjw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:48:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X_Eve2J4SzS1ECMZh6ZRjw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 07:48:32 INFO - Downloaded 55002715 bytes. 07:48:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/X_Eve2J4SzS1ECMZh6ZRjw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:48:32 INFO - mkdir: /builds/slave/test/properties 07:48:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:48:32 INFO - Writing to file /builds/slave/test/properties/build_url 07:48:32 INFO - Contents: 07:48:32 INFO - build_url:https://queue.taskcluster.net/v1/task/X_Eve2J4SzS1ECMZh6ZRjw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:48:33 INFO - Running post-action listener: _resource_record_post_action 07:48:33 INFO - Running post-action listener: set_extra_try_arguments 07:48:33 INFO - ##### 07:48:33 INFO - ##### Finished download-and-extract step (success) 07:48:33 INFO - ##### 07:48:33 INFO - ##### 07:48:33 INFO - ##### Running populate-webroot step. 07:48:33 INFO - ##### 07:48:33 INFO - Running pre-action listener: _resource_record_pre_action 07:48:33 INFO - Running main action method: populate_webroot 07:48:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:48:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:48:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:48:33 INFO - '--tppagecycles', 07:48:33 INFO - '7'], 07:48:33 INFO - 'tests': ['tsvgm']}}, 07:48:33 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:48:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:48:33 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:48:33 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:48:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:48:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:48:33 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:48:33 INFO - 'talos_options': ['--disable-e10s'], 07:48:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:48:33 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:48:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:48:33 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:48:33 INFO - 'talos_options': ['--disable-e10s'], 07:48:33 INFO - 'tests': ['damp', 'tps']}, 07:48:33 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:48:33 INFO - 'tests': ['damp', 'tps']}, 07:48:33 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:48:33 INFO - 'tests': ['dromaeo_dom']}, 07:48:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:48:33 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:48:33 INFO - 'tests': ['a11yr', 07:48:33 INFO - 'ts_paint', 07:48:33 INFO - 'tpaint', 07:48:33 INFO - 'sessionrestore', 07:48:33 INFO - 'sessionrestore_no_auto_restore', 07:48:33 INFO - 'tabpaint']}, 07:48:33 INFO - 'other-e10s': {'tests': ['a11yr', 07:48:33 INFO - 'ts_paint', 07:48:33 INFO - 'tpaint', 07:48:33 INFO - 'sessionrestore', 07:48:33 INFO - 'sessionrestore_no_auto_restore', 07:48:33 INFO - 'tabpaint']}, 07:48:33 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:48:33 INFO - 'ts_paint', 07:48:33 INFO - 'tpaint', 07:48:33 INFO - 'sessionrestore', 07:48:33 INFO - 'sessionrestore_no_auto_restore', 07:48:33 INFO - 'tabpaint']}, 07:48:33 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:48:33 INFO - 'ts_paint', 07:48:33 INFO - 'tpaint', 07:48:33 INFO - 'sessionrestore', 07:48:33 INFO - 'sessionrestore_no_auto_restore', 07:48:33 INFO - 'tabpaint']}, 07:48:33 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:48:33 INFO - 'tests': ['a11yr', 07:48:33 INFO - 'ts_paint', 07:48:33 INFO - 'tpaint', 07:48:33 INFO - 'sessionrestore', 07:48:33 INFO - 'sessionrestore_no_auto_restore', 07:48:33 INFO - 'tabpaint']}, 07:48:33 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:48:33 INFO - 'tests': ['a11yr', 07:48:33 INFO - 'ts_paint', 07:48:33 INFO - 'tpaint', 07:48:33 INFO - 'sessionrestore', 07:48:33 INFO - 'sessionrestore_no_auto_restore', 07:48:33 INFO - 'tabpaint']}, 07:48:33 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:48:33 INFO - 'tests': ['tsvgx', 07:48:33 INFO - 'tsvgr_opacity', 07:48:33 INFO - 'tart', 07:48:33 INFO - 'tscrollx', 07:48:33 INFO - 'cart']}, 07:48:33 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:48:33 INFO - 'tsvgr_opacity', 07:48:33 INFO - 'tart', 07:48:33 INFO - 'tscrollx', 07:48:33 INFO - 'cart']}, 07:48:33 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:48:33 INFO - 'talos_options': ['--disable-e10s'], 07:48:33 INFO - 'tests': ['tp5o']}, 07:48:33 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:48:33 INFO - 'tests': ['tp5o']}, 07:48:33 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:48:33 INFO - 'talos_options': ['--disable-e10s', 07:48:33 INFO - '--xperf_path', 07:48:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:48:33 INFO - 'tests': ['tp5n']}, 07:48:33 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:48:33 INFO - 'talos_options': ['--xperf_path', 07:48:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:48:33 INFO - 'tests': ['tp5n']}}, 07:48:33 INFO - 'talos.zip': {'path': '', 07:48:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:48:33 INFO - Running post-action listener: _resource_record_post_action 07:48:33 INFO - ##### 07:48:33 INFO - ##### Finished populate-webroot step (success) 07:48:33 INFO - ##### 07:48:33 INFO - ##### 07:48:33 INFO - ##### Running create-virtualenv step. 07:48:33 INFO - ##### 07:48:33 INFO - Running pre-action listener: _resource_record_pre_action 07:48:33 INFO - Running main action method: create_virtualenv 07:48:33 INFO - Creating virtualenv /builds/slave/test/build/venv 07:48:33 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 07:48:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:48:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:48:33 INFO - Using real prefix '/usr' 07:48:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:48:33 INFO - Installing distribute.............................................................................................................................................................................................done. 07:48:35 INFO - Installing pip.................done. 07:48:35 INFO - Return code: 0 07:48:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:48:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:48:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:48:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:48:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:48:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:48:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:48:35 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 0x7f25de7ccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x214c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2217770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a69c0>, '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 0x22a78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a7d50>, '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': '0e2a256762fed810e2f0f810000001b3-1464619700.395097-1071734211', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:48:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:48:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:48:35 INFO - Using env: {'DISPLAY': ':0', 07:48:35 INFO - 'HOME': '/home/cltbld', 07:48:35 INFO - 'LANG': 'en_US.UTF-8', 07:48:35 INFO - 'LANGUAGE': 'en_US:en', 07:48:35 INFO - 'LOGNAME': 'cltbld', 07:48:35 INFO - 'MAIL': '/var/mail/cltbld', 07:48:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:48:35 INFO - 'MOZ_NO_REMOTE': '1', 07:48:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:48:35 INFO - 'NO_EM_RESTART': '1', 07:48:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:48:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:48:35 INFO - 'PWD': '/builds/slave/test', 07:48:35 INFO - 'SHELL': '/bin/bash', 07:48:35 INFO - 'SHLVL': '1', 07:48:35 INFO - 'TERM': 'linux', 07:48:35 INFO - 'TMOUT': '86400', 07:48:35 INFO - 'USER': 'cltbld', 07:48:35 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1464619700.395097-1071734211', 07:48:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:48:35 INFO - '_': '/tools/buildbot/bin/python'} 07:48:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:48:35 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 07:48:35 INFO - Cleaning up... 07:48:35 INFO - Return code: 0 07:48:35 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:48:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:48:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:48:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:48:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:48:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:48:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:48:35 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>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f25de7ccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x214c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2217770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a69c0>, '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 0x22a78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a7d50>, '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': '0e2a256762fed810e2f0f810000001b3-1464619700.395097-1071734211', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:48:35 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>=3.1.1'] in /builds/slave/test/build 07:48:35 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>=3.1.1 07:48:35 INFO - Using env: {'DISPLAY': ':0', 07:48:35 INFO - 'HOME': '/home/cltbld', 07:48:35 INFO - 'LANG': 'en_US.UTF-8', 07:48:35 INFO - 'LANGUAGE': 'en_US:en', 07:48:35 INFO - 'LOGNAME': 'cltbld', 07:48:35 INFO - 'MAIL': '/var/mail/cltbld', 07:48:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:48:35 INFO - 'MOZ_NO_REMOTE': '1', 07:48:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:48:35 INFO - 'NO_EM_RESTART': '1', 07:48:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:48:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:48:35 INFO - 'PWD': '/builds/slave/test', 07:48:35 INFO - 'SHELL': '/bin/bash', 07:48:35 INFO - 'SHLVL': '1', 07:48:35 INFO - 'TERM': 'linux', 07:48:35 INFO - 'TMOUT': '86400', 07:48:35 INFO - 'USER': 'cltbld', 07:48:35 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1464619700.395097-1071734211', 07:48:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:48:35 INFO - '_': '/tools/buildbot/bin/python'} 07:48:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:48:36 INFO - Downloading/unpacking psutil>=3.1.1 07:48:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:48:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:48:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:48:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:48:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:48:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:48:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:48:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:48:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:48:38 INFO - Installing collected packages: psutil 07:48:38 INFO - Running setup.py install for psutil 07:48:38 INFO - building 'psutil._psutil_linux' extension 07:48:38 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 07:48:38 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 07:48:38 INFO - building 'psutil._psutil_posix' extension 07:48:38 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 07:48:38 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 07:48:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:48:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:48:38 INFO - Successfully installed psutil 07:48:38 INFO - Cleaning up... 07:48:38 INFO - Return code: 0 07:48:38 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:48:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:48:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:48:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:48:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:48:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:48:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:48:38 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.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f25de7ccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x214c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2217770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a69c0>, '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 0x22a78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a7d50>, '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': '0e2a256762fed810e2f0f810000001b3-1464619700.395097-1071734211', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:48:38 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.3'] in /builds/slave/test/build 07:48:38 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.3 07:48:38 INFO - Using env: {'DISPLAY': ':0', 07:48:38 INFO - 'HOME': '/home/cltbld', 07:48:38 INFO - 'LANG': 'en_US.UTF-8', 07:48:38 INFO - 'LANGUAGE': 'en_US:en', 07:48:38 INFO - 'LOGNAME': 'cltbld', 07:48:38 INFO - 'MAIL': '/var/mail/cltbld', 07:48:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:48:38 INFO - 'MOZ_NO_REMOTE': '1', 07:48:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:48:38 INFO - 'NO_EM_RESTART': '1', 07:48:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:48:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:48:38 INFO - 'PWD': '/builds/slave/test', 07:48:38 INFO - 'SHELL': '/bin/bash', 07:48:38 INFO - 'SHLVL': '1', 07:48:38 INFO - 'TERM': 'linux', 07:48:38 INFO - 'TMOUT': '86400', 07:48:38 INFO - 'USER': 'cltbld', 07:48:38 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1464619700.395097-1071734211', 07:48:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:48:38 INFO - '_': '/tools/buildbot/bin/python'} 07:48:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:48:38 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:48:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:48:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:48:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:48:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:48:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:48:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:48:40 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:48:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:48:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:48:40 INFO - Installing collected packages: mozsystemmonitor 07:48:40 INFO - Running setup.py install for mozsystemmonitor 07:48:40 INFO - Successfully installed mozsystemmonitor 07:48:40 INFO - Cleaning up... 07:48:41 INFO - Return code: 0 07:48:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:48:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:48:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:48:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:48:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:48:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:48:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:48:41 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 0x7f25de7ccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x214c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2217770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a69c0>, '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 0x22a78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a7d50>, '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': '0e2a256762fed810e2f0f810000001b3-1464619700.395097-1071734211', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:48:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:48:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:48:41 INFO - Using env: {'DISPLAY': ':0', 07:48:41 INFO - 'HOME': '/home/cltbld', 07:48:41 INFO - 'LANG': 'en_US.UTF-8', 07:48:41 INFO - 'LANGUAGE': 'en_US:en', 07:48:41 INFO - 'LOGNAME': 'cltbld', 07:48:41 INFO - 'MAIL': '/var/mail/cltbld', 07:48:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:48:41 INFO - 'MOZ_NO_REMOTE': '1', 07:48:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:48:41 INFO - 'NO_EM_RESTART': '1', 07:48:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:48:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:48:41 INFO - 'PWD': '/builds/slave/test', 07:48:41 INFO - 'SHELL': '/bin/bash', 07:48:41 INFO - 'SHLVL': '1', 07:48:41 INFO - 'TERM': 'linux', 07:48:41 INFO - 'TMOUT': '86400', 07:48:41 INFO - 'USER': 'cltbld', 07:48:41 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1464619700.395097-1071734211', 07:48:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:48:41 INFO - '_': '/tools/buildbot/bin/python'} 07:48:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:48:41 INFO - Downloading/unpacking blobuploader==1.2.4 07:48: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 07:48: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 07:48: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 07:48: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 07:48: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 07:48: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 07:48:43 INFO - Downloading blobuploader-1.2.4.tar.gz 07:48:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:48:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:48:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:48:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:48:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:48:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:48:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:48:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:48:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:48:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:48:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:48:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:48:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:48:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:48:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:48:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:48:43 INFO - Downloading docopt-0.6.1.tar.gz 07:48:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:48:43 INFO - Installing collected packages: blobuploader, requests, docopt 07:48:43 INFO - Running setup.py install for blobuploader 07:48:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:48:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:48:44 INFO - Running setup.py install for requests 07:48:44 INFO - Running setup.py install for docopt 07:48:44 INFO - Successfully installed blobuploader requests docopt 07:48:44 INFO - Cleaning up... 07:48:44 INFO - Return code: 0 07:48:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:48:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:48:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:48:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:48:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:48:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:48:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:48:44 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 0x7f25de7ccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x214c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2217770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a69c0>, '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 0x22a78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a7d50>, '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': '0e2a256762fed810e2f0f810000001b3-1464619700.395097-1071734211', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:48:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:48:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:48:44 INFO - Using env: {'DISPLAY': ':0', 07:48:44 INFO - 'HOME': '/home/cltbld', 07:48:44 INFO - 'LANG': 'en_US.UTF-8', 07:48:44 INFO - 'LANGUAGE': 'en_US:en', 07:48:44 INFO - 'LOGNAME': 'cltbld', 07:48:44 INFO - 'MAIL': '/var/mail/cltbld', 07:48:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:48:44 INFO - 'MOZ_NO_REMOTE': '1', 07:48:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:48:44 INFO - 'NO_EM_RESTART': '1', 07:48:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:48:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:48:44 INFO - 'PWD': '/builds/slave/test', 07:48:44 INFO - 'SHELL': '/bin/bash', 07:48:44 INFO - 'SHLVL': '1', 07:48:44 INFO - 'TERM': 'linux', 07:48:44 INFO - 'TMOUT': '86400', 07:48:44 INFO - 'USER': 'cltbld', 07:48:44 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1464619700.395097-1071734211', 07:48:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:48:44 INFO - '_': '/tools/buildbot/bin/python'} 07:48:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:48:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:48:44 INFO - Running setup.py (path:/tmp/pip-2Kdt1b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:48:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:48:44 INFO - Running setup.py (path:/tmp/pip-PQDQQs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:48:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:48:44 INFO - Running setup.py (path:/tmp/pip-v8Uhvj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:48:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:48:44 INFO - Running setup.py (path:/tmp/pip-_xYd67-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:48:45 INFO - Running setup.py (path:/tmp/pip-ioGqdr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:48:45 INFO - Running setup.py (path:/tmp/pip-kgDC8A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:48:45 INFO - Running setup.py (path:/tmp/pip-9tMHmE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:48:45 INFO - Running setup.py (path:/tmp/pip-8sKxOF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:48:45 INFO - Running setup.py (path:/tmp/pip-6ykVI8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:48:45 INFO - Running setup.py (path:/tmp/pip-aMfSsG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:48:45 INFO - Running setup.py (path:/tmp/pip-fB3LgB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:48:45 INFO - Running setup.py (path:/tmp/pip-hxo49P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:48:45 INFO - Running setup.py (path:/tmp/pip-EL7uZp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:48:45 INFO - Running setup.py (path:/tmp/pip-vmUuGy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:48:45 INFO - Running setup.py (path:/tmp/pip-1l8pVw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:48:45 INFO - Running setup.py (path:/tmp/pip-PjcUHs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:48:45 INFO - Running setup.py (path:/tmp/pip-cwmCWp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:48:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:48:45 INFO - Running setup.py install for manifestparser 07:48:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:48:46 INFO - Running setup.py install for mozcrash 07:48:46 INFO - Running setup.py install for mozdebug 07:48:46 INFO - Running setup.py install for mozdevice 07:48:46 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:48:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:48:46 INFO - Running setup.py install for mozfile 07:48:46 INFO - Running setup.py install for mozhttpd 07:48:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:48:46 INFO - Running setup.py install for mozinfo 07:48:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:48:46 INFO - Running setup.py install for mozInstall 07:48:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:48:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:48:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:48:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:48:46 INFO - Running setup.py install for mozleak 07:48:46 INFO - Running setup.py install for mozlog 07:48:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:48:47 INFO - Running setup.py install for moznetwork 07:48:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:48:47 INFO - Running setup.py install for mozprocess 07:48:47 INFO - Running setup.py install for mozprofile 07:48:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:48:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:48:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:48:47 INFO - Running setup.py install for mozrunner 07:48:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:48:47 INFO - Running setup.py install for mozscreenshot 07:48:47 INFO - Running setup.py install for moztest 07:48:47 INFO - Running setup.py install for mozversion 07:48:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:48:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:48:47 INFO - Cleaning up... 07:48:47 INFO - Return code: 0 07:48:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:48:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:48:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:48:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:48:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:48:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:48:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:48:47 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 0x7f25de7ccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x214c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2217770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a69c0>, '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 0x22a78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a7d50>, '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': '0e2a256762fed810e2f0f810000001b3-1464619700.395097-1071734211', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:48:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:48:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:48:47 INFO - Using env: {'DISPLAY': ':0', 07:48:47 INFO - 'HOME': '/home/cltbld', 07:48:47 INFO - 'LANG': 'en_US.UTF-8', 07:48:47 INFO - 'LANGUAGE': 'en_US:en', 07:48:47 INFO - 'LOGNAME': 'cltbld', 07:48:47 INFO - 'MAIL': '/var/mail/cltbld', 07:48:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:48:47 INFO - 'MOZ_NO_REMOTE': '1', 07:48:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:48:47 INFO - 'NO_EM_RESTART': '1', 07:48:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:48:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:48:47 INFO - 'PWD': '/builds/slave/test', 07:48:47 INFO - 'SHELL': '/bin/bash', 07:48:47 INFO - 'SHLVL': '1', 07:48:47 INFO - 'TERM': 'linux', 07:48:47 INFO - 'TMOUT': '86400', 07:48:47 INFO - 'USER': 'cltbld', 07:48:47 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1464619700.395097-1071734211', 07:48:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:48:47 INFO - '_': '/tools/buildbot/bin/python'} 07:48:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:48:48 INFO - Running setup.py (path:/tmp/pip-Jr5mWQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:48:48 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 07:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:48:48 INFO - Running setup.py (path:/tmp/pip-p_YJ5I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:48:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:48:48 INFO - Running setup.py (path:/tmp/pip-1dKPc0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:48:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:48:48 INFO - Running setup.py (path:/tmp/pip-dMhwEj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:48:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:48:48 INFO - Running setup.py (path:/tmp/pip-5agN10-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:48:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 07:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:48:48 INFO - Running setup.py (path:/tmp/pip-5ULEtY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:48:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 07:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:48:48 INFO - Running setup.py (path:/tmp/pip-JNJX8N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:48:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 07:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:48:48 INFO - Running setup.py (path:/tmp/pip-imraTV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:48:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 07:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:48:48 INFO - Running setup.py (path:/tmp/pip-coDP5c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:48:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 07:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:48:48 INFO - Running setup.py (path:/tmp/pip-0Fo7D0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:48:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:48:48 INFO - Running setup.py (path:/tmp/pip-NLNvVW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:48:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 07:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:48:48 INFO - Running setup.py (path:/tmp/pip-ZgzQWS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:48:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:48:48 INFO - Running setup.py (path:/tmp/pip-tk1QRz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:48:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 07:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:48:48 INFO - Running setup.py (path:/tmp/pip-GZks9K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:48:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:48:49 INFO - Running setup.py (path:/tmp/pip-7_sSGg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:48:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 07:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:48:49 INFO - Running setup.py (path:/tmp/pip-DXNOmB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:48:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 07:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:48:49 INFO - Running setup.py (path:/tmp/pip-HjmgUf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:48:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 07:48:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:48:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:48:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:48:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:48:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:48:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:48: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 07:48: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 07:48: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 07:48: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 07:48: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 07:48: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 07:48:51 INFO - Downloading blessings-1.6.tar.gz 07:48:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:48:51 INFO - Installing collected packages: blessings 07:48:51 INFO - Running setup.py install for blessings 07:48:51 INFO - Successfully installed blessings 07:48:51 INFO - Cleaning up... 07:48:51 INFO - Return code: 0 07:48:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:48:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:48:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:48:51 INFO - Reading from file tmpfile_stdout 07:48:51 INFO - Current package versions: 07:48:51 INFO - argparse == 1.2.1 07:48:51 INFO - blessings == 1.6 07:48:51 INFO - blobuploader == 1.2.4 07:48:51 INFO - docopt == 0.6.1 07:48:51 INFO - manifestparser == 1.1 07:48:51 INFO - mozInstall == 1.12 07:48:51 INFO - mozcrash == 0.17 07:48:51 INFO - mozdebug == 0.1 07:48:51 INFO - mozdevice == 0.48 07:48:51 INFO - mozfile == 1.2 07:48:51 INFO - mozhttpd == 0.7 07:48:51 INFO - mozinfo == 0.9 07:48:51 INFO - mozleak == 0.1 07:48:51 INFO - mozlog == 3.2 07:48:51 INFO - moznetwork == 0.27 07:48:51 INFO - mozprocess == 0.22 07:48:51 INFO - mozprofile == 0.28 07:48:51 INFO - mozrunner == 6.11 07:48:51 INFO - mozscreenshot == 0.1 07:48:51 INFO - mozsystemmonitor == 0.3 07:48:51 INFO - moztest == 0.7 07:48:51 INFO - mozversion == 1.4 07:48:51 INFO - psutil == 3.1.1 07:48:51 INFO - requests == 1.2.3 07:48:51 INFO - wsgiref == 0.1.2 07:48:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:48:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:48:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:48:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:48:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:48:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:48:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:48:51 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 0x7f25de7ccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x214c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2217770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a69c0>, '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 0x22a78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a7d50>, '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': '0e2a256762fed810e2f0f810000001b3-1464619700.395097-1071734211', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:48:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 07:48:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:48:51 INFO - Using env: {'DISPLAY': ':0', 07:48:51 INFO - 'HOME': '/home/cltbld', 07:48:51 INFO - 'LANG': 'en_US.UTF-8', 07:48:51 INFO - 'LANGUAGE': 'en_US:en', 07:48:51 INFO - 'LOGNAME': 'cltbld', 07:48:51 INFO - 'MAIL': '/var/mail/cltbld', 07:48:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:48:51 INFO - 'MOZ_NO_REMOTE': '1', 07:48:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:48:51 INFO - 'NO_EM_RESTART': '1', 07:48:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:48:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:48:51 INFO - 'PWD': '/builds/slave/test', 07:48:51 INFO - 'SHELL': '/bin/bash', 07:48:51 INFO - 'SHLVL': '1', 07:48:51 INFO - 'TERM': 'linux', 07:48:51 INFO - 'TMOUT': '86400', 07:48:51 INFO - 'USER': 'cltbld', 07:48:51 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1464619700.395097-1071734211', 07:48:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:48:51 INFO - '_': '/tools/buildbot/bin/python'} 07:48:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:48:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:48:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 07:48:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 07:48:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:48:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 07:48:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 07:48:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 07:48:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 07:48:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 07:48:51 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:48:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:48:51 INFO - Cleaning up... 07:48:51 INFO - Return code: 0 07:48:51 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:48:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:48:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:48:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:48:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:48:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:48:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:48:51 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 0x7f25de7ccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x214c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2217770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a69c0>, '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 0x22a78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a7d50>, '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': '0e2a256762fed810e2f0f810000001b3-1464619700.395097-1071734211', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:48:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:48:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:48:51 INFO - Using env: {'DISPLAY': ':0', 07:48:51 INFO - 'HOME': '/home/cltbld', 07:48:51 INFO - 'LANG': 'en_US.UTF-8', 07:48:51 INFO - 'LANGUAGE': 'en_US:en', 07:48:51 INFO - 'LOGNAME': 'cltbld', 07:48:51 INFO - 'MAIL': '/var/mail/cltbld', 07:48:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:48:51 INFO - 'MOZ_NO_REMOTE': '1', 07:48:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:48:51 INFO - 'NO_EM_RESTART': '1', 07:48:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:48:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:48:51 INFO - 'PWD': '/builds/slave/test', 07:48:51 INFO - 'SHELL': '/bin/bash', 07:48:51 INFO - 'SHLVL': '1', 07:48:51 INFO - 'TERM': 'linux', 07:48:51 INFO - 'TMOUT': '86400', 07:48:51 INFO - 'USER': 'cltbld', 07:48:51 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1464619700.395097-1071734211', 07:48:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:48:51 INFO - '_': '/tools/buildbot/bin/python'} 07:48:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:48:52 INFO - Downloading/unpacking jsonschema 07:48:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:48:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:48:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:48:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:48:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:48:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:48:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:48:53 INFO - Downloading/unpacking functools32 (from jsonschema) 07:48:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:48:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:48:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:48:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:48:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:48:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:48:54 INFO - Downloading functools32-3.2.3-2.tar.gz 07:48:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:48:54 INFO - warning: no files found matching '*.txt' 07:48:54 INFO - no previously-included directories found matching 'build' 07:48:54 INFO - no previously-included directories found matching 'dist' 07:48:54 INFO - no previously-included directories found matching '.git*' 07:48:54 INFO - Installing collected packages: jsonschema, functools32 07:48:54 INFO - Running setup.py install for functools32 07:48:54 INFO - warning: no files found matching '*.txt' 07:48:54 INFO - no previously-included directories found matching 'build' 07:48:54 INFO - no previously-included directories found matching 'dist' 07:48:54 INFO - no previously-included directories found matching '.git*' 07:48:54 INFO - Successfully installed jsonschema functools32 07:48:54 INFO - Cleaning up... 07:48:54 INFO - Return code: 0 07:48:54 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:48:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:48:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:48:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:48:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:48:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:48:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:48:54 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 0x7f25de7ccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x214c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2217770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a69c0>, '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 0x22a78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a7d50>, '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': '0e2a256762fed810e2f0f810000001b3-1464619700.395097-1071734211', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:48:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 07:48:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 07:48:54 INFO - Using env: {'DISPLAY': ':0', 07:48:54 INFO - 'HOME': '/home/cltbld', 07:48:54 INFO - 'LANG': 'en_US.UTF-8', 07:48:54 INFO - 'LANGUAGE': 'en_US:en', 07:48:54 INFO - 'LOGNAME': 'cltbld', 07:48:54 INFO - 'MAIL': '/var/mail/cltbld', 07:48:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:48:54 INFO - 'MOZ_NO_REMOTE': '1', 07:48:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:48:54 INFO - 'NO_EM_RESTART': '1', 07:48:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:48:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:48:54 INFO - 'PWD': '/builds/slave/test', 07:48:54 INFO - 'SHELL': '/bin/bash', 07:48:54 INFO - 'SHLVL': '1', 07:48:54 INFO - 'TERM': 'linux', 07:48:54 INFO - 'TMOUT': '86400', 07:48:54 INFO - 'USER': 'cltbld', 07:48:54 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1464619700.395097-1071734211', 07:48:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:48:54 INFO - '_': '/tools/buildbot/bin/python'} 07:48:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:48:54 INFO - Downloading/unpacking flake8 07:48:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:48:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:48:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:48:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:48:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:48:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:48:56 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:48:56 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:48:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:48:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:48:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:48:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:48:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:48:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:48:56 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:48:56 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:48:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:48:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:48:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:48:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:48:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:48:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:48:56 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:48:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:48:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:48:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:48:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:48:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:48:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:48:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:48:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:48:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:48:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:48:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:48:57 INFO - no previously-included directories found matching 'docs/_build' 07:48:57 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:48:57 INFO - Running setup.py install for pep8 07:48:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:48:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:48:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:48:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:48:57 INFO - no previously-included directories found matching 'docs/_build' 07:48:57 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:48:57 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:48:57 INFO - Cleaning up... 07:48:57 INFO - Return code: 0 07:48:57 INFO - Running post-action listener: _resource_record_post_action 07:48:57 INFO - Running post-action listener: _start_resource_monitoring 07:48:57 INFO - Starting resource monitoring. 07:48:57 INFO - ##### 07:48:57 INFO - ##### Finished create-virtualenv step (success) 07:48:57 INFO - ##### 07:48:57 INFO - ##### 07:48:57 INFO - ##### Running install step. 07:48:57 INFO - ##### 07:48:57 INFO - Running pre-action listener: _resource_record_pre_action 07:48:57 INFO - Running main action method: install 07:48:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:48:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:48:57 INFO - Reading from file tmpfile_stdout 07:48:57 INFO - Detecting whether we're running mozinstall >=1.0... 07:48:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:48:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:48:57 INFO - Reading from file tmpfile_stdout 07:48:57 INFO - Output received: 07:48:57 INFO - Usage: mozinstall [options] installer 07:48:57 INFO - Options: 07:48:57 INFO - -h, --help show this help message and exit 07:48:57 INFO - -d DEST, --destination=DEST 07:48:57 INFO - Directory to install application into. [default: 07:48:57 INFO - "/builds/slave/test"] 07:48:57 INFO - --app=APP Application being installed. [default: firefox] 07:48:57 INFO - mkdir: /builds/slave/test/build/application 07:48:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 07:48:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 07:49:13 INFO - Reading from file tmpfile_stdout 07:49:13 INFO - Output received: 07:49:13 INFO - /builds/slave/test/build/application/firefox/firefox 07:49:13 INFO - Running post-action listener: _resource_record_post_action 07:49:13 INFO - ##### 07:49:13 INFO - ##### Finished install step (success) 07:49:13 INFO - ##### 07:49:13 INFO - ##### 07:49:13 INFO - ##### Running run-tests step. 07:49:13 INFO - ##### 07:49:13 INFO - Running pre-action listener: _resource_record_pre_action 07:49:13 INFO - Running main action method: run_tests 07:49:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:49:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:49:13 INFO - Python 2.7.3 07:49:13 INFO - Return code: 0 07:49:13 INFO - grabbing minidump binary from tooltool 07:49: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')]} 07:49:13 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: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a69c0>, '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 0x22a78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a7d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:49:13 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 07:49:13 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 07:49:13 INFO - Calling ['/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'] with output_timeout 600 07:49:13 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:49:13 INFO - Return code: 0 07:49:13 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:49:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:49:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:49:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:49:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:49:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:49:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:49:14 INFO - Return code: 0 07:49:14 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/X_Eve2J4SzS1ECMZh6ZRjw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 07:49:14 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/X_Eve2J4SzS1ECMZh6ZRjw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-058 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 07:49:14 INFO - Using env: {'DISPLAY': ':0', 07:49:14 INFO - 'HOME': '/home/cltbld', 07:49:14 INFO - 'LANG': 'en_US.UTF-8', 07:49:14 INFO - 'LANGUAGE': 'en_US:en', 07:49:14 INFO - 'LOGNAME': 'cltbld', 07:49:14 INFO - 'MAIL': '/var/mail/cltbld', 07:49:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:49:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:49:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:49:14 INFO - 'MOZ_NO_REMOTE': '1', 07:49:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:49:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:49:14 INFO - 'NO_EM_RESTART': '1', 07:49:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:49:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:49:14 INFO - 'PWD': '/builds/slave/test', 07:49:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:49:14 INFO - 'SHELL': '/bin/bash', 07:49:14 INFO - 'SHLVL': '1', 07:49:14 INFO - 'TERM': 'linux', 07:49:14 INFO - 'TMOUT': '86400', 07:49:14 INFO - 'USER': 'cltbld', 07:49:14 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1464619700.395097-1071734211', 07:49:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:49:14 INFO - '_': '/tools/buildbot/bin/python'} 07:49:14 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/X_Eve2J4SzS1ECMZh6ZRjw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 07:49:14 INFO - mozversion application_buildid: 20160530064349 07:49:14 INFO - mozversion application_changeset: f84a95dce3aaaec51ccaf98398eed74f41e30245 07:49:14 INFO - mozversion application_display_name: Nightly 07:49:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:49:14 INFO - mozversion application_name: Firefox 07:49:14 INFO - mozversion application_remotingname: firefox 07:49:14 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 07:49:14 INFO - mozversion application_vendor: Mozilla 07:49:14 INFO - mozversion application_version: 49.0a1 07:49:14 INFO - mozversion platform_buildid: 20160530064349 07:49:14 INFO - mozversion platform_changeset: f84a95dce3aaaec51ccaf98398eed74f41e30245 07:49:14 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 07:49:14 INFO - mozversion platform_version: 49.0a1 07:49:14 INFO - using testdate: 1464619754 07:49:14 INFO - actual date: 1464619754 07:49:14 INFO - starting webserver on 'localhost:52832' 07:49:14 INFO - SUITE-START | Running 2 tests 07:49:14 INFO - TEST-START | dromaeo_css 07:49:14 INFO - operating with platform_type : linux_ 07:49:14 INFO - Initialising browser for dromaeo_css test... 07:49:14 INFO - TEST-INFO | started process 30846 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSmhtVk/profile http://localhost:52832/getInfo.html) 07:49:19 INFO - PROCESS | 30846 | __metrics Screen width/height:1600/1200 07:49:19 INFO - PROCESS | 30846 | colorDepth:24 07:49:19 INFO - PROCESS | 30846 | Browser inner width/height: 1024/697 07:49:19 INFO - PROCESS | 30846 | __metrics 07:49:20 ERROR - PROCESS | 30846 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:49:21 INFO - TEST-INFO | 30846: exit 0 07:49:21 INFO - Browser initialized. 07:49:21 INFO - Running cycle 1/1 for dromaeo_css test... 07:49:21 INFO - TEST-INFO | started process 30926 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSmhtVk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:49:33 INFO - PROCESS | 30926 | RSS: Main: 157364224 07:49:33 INFO - PROCESS | 30926 | 07:50:24 INFO - PROCESS | 30926 | 1464619824750 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 07:52:36 INFO - PROCESS | 30926 | Cycle 1(1): loaded http://localhost:52832/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52832/tests/dromaeo/cssquery-ext.html) 07:52:37 INFO - PROCESS | 30926 | RSS: Main: 239812608 07:52:37 INFO - PROCESS | 30926 | 07:55:39 INFO - PROCESS | 30926 | Cycle 1(1): loaded http://localhost:52832/tests/dromaeo/cssquery-ext.html (next: http://localhost:52832/tests/dromaeo/cssquery-jquery.html) 07:55:40 INFO - PROCESS | 30926 | RSS: Main: 250937344 07:55:40 INFO - PROCESS | 30926 | 07:58:42 INFO - PROCESS | 30926 | Cycle 1(1): loaded http://localhost:52832/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52832/tests/dromaeo/cssquery-mootools.html) 07:58:43 INFO - PROCESS | 30926 | RSS: Main: 245669888 07:58:43 INFO - PROCESS | 30926 | 08:01:45 INFO - PROCESS | 30926 | Cycle 1(1): loaded http://localhost:52832/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52832/tests/dromaeo/cssquery-prototype.html) 08:01:46 INFO - PROCESS | 30926 | RSS: Main: 246026240 08:01:46 INFO - PROCESS | 30926 | 08:04:48 INFO - PROCESS | 30926 | Cycle 1(1): loaded http://localhost:52832/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52832/tests/dromaeo/cssquery-yui.html) 08:04:49 INFO - PROCESS | 30926 | RSS: Main: 224129024 08:04:49 INFO - PROCESS | 30926 | 08:07:52 INFO - PROCESS | 30926 | Cycle 1(1): loaded http://localhost:52832/tests/dromaeo/cssquery-yui.html (next: http://localhost:52832/tests/dromaeo/cssquery-dojo.html) 08:07:52 INFO - PROCESS | 30926 | RSS: Main: 278749184 08:07:52 INFO - PROCESS | 30926 | 08:07:52 INFO - PROCESS | 30926 | __start_tp_report 08:07:52 INFO - PROCESS | 30926 | _x_x_mozilla_page_load 08:07:52 INFO - PROCESS | 30926 | _x_x_mozilla_page_load_details 08:07:52 INFO - PROCESS | 30926 | |i|pagename|runs| 08:07:52 INFO - PROCESS | 30926 | |0;dojo.html;2626.8292560983537;2649.0860653074683;2664.5470270054093;2684.3691732442885;2692.919212423628;4560.954390456094;4580.404547408836;4643.837465688697;4668.113058518879;4702.083093796711;4654.930176047362;4667.486576476594;4680.859574212771;4698;4722.433308003036;4103.384492326145;4275.7648329341955;4375.059362237118;4411.889702757425;4490.899729566261;4404.207242696313;4451.554844515539;4462.754548499831;4470.82116715331;4498.752568608726;4207.284761590522;4251.043515209084;4313.352997050436;4346.109047645256;4352.390665306828;4286.442762440894;4287.592678695519;4293.592108749664;4337.913241735179;4349.956500435019;4320.351947207912;4340.197063543223;4344.7827608619755;4376.6936314458;4388.056567837898;4463.799129039168;4562.726236425792;4569.977150114261;4595.058013107305;4633.027064316498;5062.038212739568;5079.060373830816;5092.083424983502;5093.516115968977;5093.745312734349;5060.038592667382;5103.055934652101;5125.103106956268;5128.8461346159675;5149.716765577892;4591.173588754023;4678.251479763256;4724.6692731508465;4725.338452616567;4797.424309082932;5292.52367286946;5300.310959575308;5308.867278317995;5310.044192045469;5313.229581710631;4814.229723244264;5001.8499445016705;5003.324551185616;5044.8234311798915;5049.772760225798;4913.70517768935;4947.356843610308;4968.72672003036;4990.6506544541535;4993.1262029144755;4937.23472861707;4941.407031156285;4945.67853089548;4953.702777833341;5007.724575148329;4858.295547145644;4871.5128487151005;4951.257311403247;4957.7769000395065;5008.17365134756;4159.625633692982;4169.457970463881;4177.540470548237;4193.182329445729;4214.241436541452;3628.346897558412;3652.7808331500196;3660.524131862894;3683.226522430266;3703.9259214816093;4216.852410165691;4263.87208383749;4302.849400271038;4302.89242768927;4317.676174286941;5054.9241761373605;5081.18701007837;5086.720230387365;5092.032513822362;5136.43499215086;4329.1125319310095;4360;4361.847335343247;4398.582134697199;4408.625266852354;4315.4605674290715;4331.7834108294455;4431.756253406029;4515.458145022619;4528.162289976365;4599.264117741145;4617.376654151646;4627.8843028923875;4668.2297420926525;4679.578837904605;4884.92672609904;4890.119778439773;4890.828820991248;4898.583620392306;4940.036692844861;4625.028743963805;4649.930251046169;4742.478327384054;4767.523247675204;4782.545658162469;5000.5999520037585;5021.347224860745;5023.799048038038;5024.321716568363;5054.545090941833;5032.798688052583;5057.519535644108;5064.164412871983;5067.189249720027;5146.356705411824;4783.258594917794;4868.3427737255015;4900.877478062935;4913.287573301923;4943.505649435027;4904.2643603459765;4923.581495572773;4940.925886111783;4944.134776414185;4981.850544483671;4755.120302744003;4842.17682993899;4853.781579828987;4904.215325547895;4907.631927605373;4923.6799608026795;4960.107180707363;4960.950390496048;4965.776540055634;4987.825426110068;4877.170880950176;4897.58370538494;4898.53463920927;4901.14230009754;4942.4316203637045 08:07:52 INFO - PROCESS | 30926 | |1;ext.html;581.4243898540444;603.9818805435835;607.3380015782795;609.357128229718;622.9906551401729;27722.306942326453;30060.849695751545;40258.99999999996;41339.173216535724;41537.58462415375;42067.78966105173;42321.15357692852;42682.57317426825;42821.785891070576;42865.571344286545;7715.922840771576;7914.089879663826;7917.129115797257;7920.643571039288;7922.722704705337;7744.457887947818;7845.215478452138;7867.527948323119;7869.05571331441;7869.252421019994;7823.3350165236025;7850.685972561091;7888.921110788876;7895.328897043758;7917.485363451386;7838.059432868064;7873.842523149562;7874.370050395954;7875.251851074138;7888.368930485576;7776.961115194388;7810.765677029698;7838.137804841463;7839.294463498312;7845.411594130406;38623;38944.805275973726;38989.61010389916;38996.61003389958;39023.219535609416;3069.493533566959;3121.9219519511967;3160.083575763026;3179.1098492422157;3200.2959348943195;29475;29518.114456566338;30195.849020754755;30547.541786873215;31288.687113128806;3224.5324427957817;3260;3266.787658802194;3306.702396784301;3333.666633336671;256945;257067;257215.99999999814;257684;257776;56248.71875640596;56319.43680563224;56476.435235647936;56480.71759641258;56617.43382566204;50479;57387.71306143443;59362.40637593655;59539;66565.33434665688;13440;13523.120997135155;13566.389512471962;13581.117227380386;13582.25297608641;9110.498922559324;10055.547500362502;10071.798564028679;10146.49267536635;10147.949260253652;17180.140992950302;17537.736933946002;17747.82252177462;18354.449366519028;18390;6127.6936153193055;6168.321484636686;6168.568200225941;6281.371862813773;6433.365148690975;751.2299892610009;810.2464707821664;833.4249367936104;843.3843294395126;1018.2617602238317;27387;27877;28088.85955570209;28210.576841346985;28296.434071318457;934.56075644447;943.4716558727134;984.1437948984286;1027.609508386823;1039.838824982129;14407.351669174912;14613.853861461463;14905.552833415015;15117.697646047238;15136.54590362291;272841;274238;275113;276481;276875;44069;44111.33832992508;44153.77923110364;44321.335179972324;44390.33414498785;1070.0583486531957;1172.5720112159001;1188.4176753390777;1211.684961909892;1218.03775017735;27756.167314979775;29029.564556532092;29694.257643559085;29817.850910745306;30040;42489;42762.57237427586;43358.13283734245;43375.34936976011;43444.348334774375;296143;296363;298506;298528;298893;20804.68792968137;25692.201545892356;26608.60087098734;26953.59569606418;26960.595591066543;42896.571034289256;43107.396722481535;43283.35074973941;43716;44078.779606103046;36626.08434789045;37073.86789529942;37177.62822371742;37336.626633733315;37548.812255938545;35520.82239588785;36726;36869.44695829511;37151.62848371482;37210.813945930095;36673.63326366809;36684.44973325349;36726.816365918;37013.259734805695;37464.625353746116;31659.683403165673;31947.722091117026;32957.34085318328;33239.16902077467;33327.33345333128;24796;25772.495076625044;26205.606915895896;27336.228053615443;27523 08:07:52 INFO - PROCESS | 30926 | |2;jquery.html;361.8516408272608;363.28432987015583;366.34058694350165;372.04941374787444;379.9735109850044;15435.69128617427;16968.91515542422;17181.656366872685;17582.736258956127;17652.823471765278;15731.921340393283;16097.517074487754;16764.245608947596;16775.24511396987;16805.32778688854;4988.176950803122;5116;5118.897622047557;5153.665011774241;5174.042802081608;3636.2545678136053;3818.77087374757;5042.848714538552;5591.692456914868;5941.940580594203;5952.077427998667;6007.279126504825;6016.8495787605225;6024.48791852693;6028.306744724369;5910.556708246877;5936.495397891184;5987.970060149715;6010.8497287567725;6013.428724271209;3316.469364901628;3493.3886569850174;3497.6502349765074;5085.821996230115;5234.136367499358;18021.549461263443;18413.63172736551;19482.902585487125;19511.804881951142;19528.21887124513;1845.344902559599;1898.6107847891149;2199.274239500961;2354.1407386304045;2387.5344307859973;8999.730008099768;9056.683016094405;9076.455412675261;9145.954270228607;9411.43531388119;1697.125980120239;1715.759793628893;1715.9227834747467;1744.790625124993;1753.3950786978598;63163;64331.67834160846;65444.3455565443;65764.67117664381;66938.3306166937;9384.390014649163;9417.764555886157;9495.335326527214;9529.332946693665;9797.510124493747;13031.543895963596;13108.80336794949;13135.671608209872;13463.596092117055;13523.729525409437;6900.7929762107215;6977.058097156819;7044.049053377831;7173.390261827699;7179.246179151219;6589.439897608757;6647.60114393138;6704.161979752531;6718.260991290954;6739.056532085512;3992.920141597152;4130.648894843972;4131.8224306073225;4232.074406145197;4236.576342365739;1590.658008528172;1630.7064728349012;1703.6166862455848;1743.3810997096102;1764.4442000769973;817.2930415190817;826.338928856912;838.8633401740675;840.1010918317464;911.2983003087586;16005.519834404986;16332.183390830649;16387;16766.497005089866;16965.236564354633;808.3735105293445;846.3652260804397;890.7238755985536;899.8965119011267;928.7306681062552;9246.306527010502;9308.674196403093;9339.579718912666;9612.086851749073;9670.323077384515;385051;388108;388203;392249;392596;47886.52113478821;47905;48388.27417588739;74330.62834685792;75870.62064689641;934.5233930695258;936.7236665183788;946.2288235088381;964.6141543382703;969.1858838575489;14722.24837352663;14860;15018.849811501745;15033.774493382389;15208.695826083638;31290.843545782125;32930.5060424089;33015.83492082524;33440.83279583684;34327.4850877232;45381.31928021016;47279.527204727514;47332.05335893332;50387.24419133789;51397;6219.813405597839;6558.672066396565;6604.570702904296;6653.068570400244;6677.69950352245;6209.658468784261;7469.477136600386;8946.642134314814;9048.547572621474;9986.550605222637;6533.575317604341;6538.901916471162;6658.600483970978;8486.278666313185;9196.632134714804;6157.4458298753325;6459.61242325462;6490.513211509061;6740.39336459721;6801.421879140328;6826.112605361272;6911.7926462206215;6913.5506192097355;6918.757843475454;6919.688614012281;9671.613135474503;9722.1736152425;9730.318877678494;9751.463669498246;9816.85274720894;9228.907710922806;9257.444553326823;9381.390209636353;9475.05249475047;9635.759106022406 08:07:52 INFO - PROCESS | 30926 | |3;mootools.html;1224.3082658298067;1394.8047273381726;1441.3874103506012;1520.7870898074273;1733.4539620019693;6557;7190.964045179773;7351.742689005886;7384.040074790277;7574.35617972473;7276.16324122726;7448.851022979537;7449.739259125919;7450.180480147193;7453.180150183475;1886.0852486544015;1946.7079938009342;1948.743060725831;2174.83688723346;2216.1024784962115;1944.931927382542;2134.882581458019;2205.5368372641765;2207.0619986505753;2224.9777502224933;2151;2165.85921915075;2172.7392712874475;2173.1307477009245;2174.13034786086;1783.1351794379716;2159.6220661384273;2164.7943445372666;2167.783221677835;2167.8590891592075;2078.864873783199;2144.624690679125;2145.6352420088624;2160.524684569408;2163.2753027735725;7473;7528.435367347471;7529.548227106391;7542.2834830691545;7544.283293087148;4338.089001309729;4477.619402350804;4478.104379124188;4480.305552639346;4481.8655440336515;2748.2030211238716;2859.5567687008547;2896.826190428581;2896.9710302897124;2901.680815110336;926.393212445849;968.5738275158908;981.342500524643;985.935914165577;1010.1514727628827;10012.54943527543;10012.799744005079;10016.449095299682;10020.69937901864;10033.648822291185;4066.674666026711;4091.9590804091577;4213.136307057046;4230.534641189467;4234.1108367242605;8566.143385661384;8612.48325100496;8649.481031138152;8662.090480499583;8667.739967800977;4478.701176658732;4508.368828364031;4535.365048893158;4536.705114167568;4538.205813982539;3589.6948759355746;3733.3653278942643;4021.034951611592;4054.0878302382316;4054.2499637567144;3567.1438854674693;3645.2709458108484;3693.021349342426;3693.7045036397026;3695.150115473456;1174.1135442740676;1190.4047976011993;1192.0344520938067;1200.1299058182922;1206.5656363709058;675.1021141881287;691.4952084977995;773.2808488106003;799.0930294116104;882.188386684252;5052.418971818214;5187.481251874782;5206.245094461282;5234.9476505235225;5252.9737351313;395.320049514834;399.14981090277524;399.279300861947;401.684677528139;410.9486314210724;3509.2455122148863;3554.111472131967;3561.5013898054294;3589.3180295743723;3638.6179451157245;8973.102689730975;9010.909890901139;9239.491827949392;9245.352825302165;9247.352685311964;9097.954510227406;9183.63265469387;9185.908140918506;9219.815603687888;9242.983271840092;7010.614416207158;7086.610236437045;7182.892256616155;7187.353138217585;7203.315685009916;5063.797448102035;5080.669756465818;5097.464766199644;5302.39022512416;5331.1470164775;8544.444611100258;8727.956360218159;8743.956280218557;8771.605277762388;8774.473531588124;8535.53054582004;8617.138286171332;8727.127287271222;8832.249258813074;8843.955780221058;5912.379200184091;6442.645654489048;6555.901661474986;6702.061711360511;6824.351686589766;7115.288471152843;7126.786196414116;7201.13586369618;7214.026106475559;7214.71141154348;6401.711922963571;6572.34276572339;6643.900341494785;6669.433098186709;6751.594904305561;6551.344865513411;6557.245916719447;6590.439812615789;6624.701888414937;6661.533692641468;6284.937150628618;6303.1175635412;6325.430711236011;6334.303226644974;6339.936600633934;4479.3057076153245;4495.7976891039325;4607.055553611434;4652.302154676826;4714.292856071616;4573.291139873325;4609.976950115228;4623.56076172763;4662.930056049094;4673.836415725434 08:07:52 INFO - PROCESS | 30926 | |4;prototype.html;278.9302674331416;294.5155219663653;295.53600846670724;298.57751281936055;299.42958663745543;4729.597984171345;4734.171519984006;4749.90500189996;4760.666753327268;4760.928586071207;4386.846460373888;4470.26240670289;4566.817327306912;4637.420322459692;4665.09030739006;3705.2589482103554;3735.0849041984616;3736.2153947670886;3750.9624903751023;3755.7746535207907;3733.383991641376;3735.2342769732277;3745.4194599836933;3747.4566187902738;3756.9812150939206;3460.2041530448014;3522.630123836999;3609.4405367168133;3635.654612811779;3646.4894914711963;3723.590405055442;3726.6211501744256;3730.3658378075793;3732.757370770891;3736.4208547675153;3275.24669326054;3276.1318250663594;3277.80387140614;3281.983590082058;3288.9835550822095;4365.890852728708;4506.5493450655;4540.387047748544;4541.909161816745;4560.749158796265;4161.835845360426;4191.476065491814;4197.118605092935;4198.454200953887;4207.726497777635;4860.1737704590305;4871;4907.901841963177;4908.337374454439;4923.852284431473;3554.875579354736;3555.8933232003083;3559.94660080099;3571.3750093733493;3581.7492775505466;4991.950080499185;5010.248462730583;5099.413567439755;5104.336436263299;5127.154019586764;3603.621609737613;3624.6737793598704;3626.0934766308424;3631.9636803631624;3646.08847788053;3717.1450566369886;3718.2749363874327;3730.309892669865;3738.813059347076;3741.494898188764;3867.245887052054;4186;4192.496900371975;4195.244855925963;4225.556316586714;4932.8520144395725;4938.8765280868265;4941.912779188573;4967.602591792648;4968.503149685075;1214.3199808107488;1219.8594314315965;1233.7224124571899;1234.4013153620488;1239.423667994387;783.9725609603637;793.6785601831267;821.9465734727223;838.33771320656;844.1811442900377;4296.217069916012;4356.455443069616;4359.651227901761;4362.650987920959;4380.474343078788;5017.1185805323;5032.8172879373315;5046.949530504721;5048.495150484922;5063.974680126576;4232.661387089025;4290.334998075304;4350.563684336718;4372.672049596293;4377.606015458624;2679.7722193613763;2683.490136873988;2691.3675286307703;2694.9730502695115;2696.649435573402;4786.875084355173;4797.6806378245565;4820.662553621213;4821.421429428421;4834.105690447279;4887.511248875084;5103.336566246364;5138.689634143269;5171.974140129275;5173.637845350864;4725.196716558262;4769.785359658893;4775.6657034007985;4776.880577985578;4781.856544303677;5007.7245751484015;5014.297998280316;5022.347094877642;5027.446980832178;5044.1424957758;4744.715317080848;4908.92636610444;4937.876553086202;4941.234108713155;5018.949810501848;4830.637702172421;4838.685485443435;4873.561379475864;4876.317315575893;4878.365747474494;3537.9646203537636;3559.661832125944;3588.551431071116;3590.856365745341;3607.296577167427;4908.852734417973;5094.414142373675;5124.590032797293;5136.280920671184;5148.43367229612;4955.950440495549;4960.330355402119;4973.850784476472;4977.4773648767805;4993.501949415234;4941.975290123526;4974.602031837517;4987.551120399182;4989.351384320015;4994.350734404504;4769.57073863354;4833.9033219334715;4909.4354149273295;4913.459519452929;4932.260160975882;4970.850874473772;4980.900381992267;5008.198688209869;5012.8496145115705;5013.273075404119;4854.247591623304;4867.5132486751045;4894.2658601210105;4897.853064408074;4905.583025442877 08:07:52 INFO - PROCESS | 30926 | |5;yui.html;621.6580880515717;693.6115775165907;724.9565026098431;729.8321386081203;760.8820632801915;11975.940120299398;12740.80888786669;12935.935320323397;12958.80561791574;12961.546345877896;11507.539698412054;11540.480678369473;11584.247023943437;13217.339133043357;13816.240106794123;810.8783682447621;819.6967122164777;819.737683941139;819.9672013119468;820.0077905734039;626.6177631644694;785.0422484568845;791.5369508837337;813.9430239883211;819.1808191808192;846.1707526623912;847.0259201917813;848.3933987199151;848.8344772769312;848.8429640516524;837.409626213518;839.0518713853306;840.815020695446;842.1788755962917;842.2672275120653;483.34989439204213;607.4259824465881;623.7473823101651;623.9313675495691;625.171647566971;13028;13034.478620855154;13048;13048.543300984515;13095.14881532707;11244.606438774603;11615.767684646344;11755.294682319089;11823.527058917633;11998.880011199864;11289.49197286124;11340.829887551694;11385.203035787497;11414.486348114355;11430.199886007982;3960.5049368828895;4087.0804069084516;4093.9385909211387;4251.383549385322;4258.659307255443;47279.290810637525;47602.76198618985;47944.28083578749;47959.28061079052;48034.519654803706;9459.38513996588;9560.091791279818;9773.12041916231;9783.608655653836;9946.701598952042;16470.505884823473;16476.340946362012;16476.42332518356;16524.6695066098;16575.336986520404;6490.383413575702;6496.935030649727;6545.5090868184125;6546.803595892131;6708.899366509506;3685.152414944524;3756.530433695788;3763.3790424580184;3774.169682669808;3849.2493963676816;2681.825681330707;2768.0865314446182;2769.155407600701;2771.237909574843;2774.875130619127;519.236722018632;520.0353344545889;528.7779132764248;529.2748933960498;532.7123353389127;522.3914140026902;546.4617351908367;549.5190461705745;565.0591764711791;569.1860639285778;7009.684564194624;7179.425645948311;7332.450066245053;7529.4729368944745;8497.277731392776;512.9615278854101;608.9604175728564;610.4780412747126;618.6999305336908;620.9068639703991;3617.2042150726797;3752.7373083883867;3762.097096696773;3794.715396345285;3799.5820459749407;54768.72615636896;55741.442585574434;56612.43387566072;56649.86700265972;56944.14583781164;50131.74934125379;50929.745351273006;51370.486295137314;51415.74292128516;52459.47540524546;46204.306935395995;46990;47076.5292347079;47156;48419.5158048422;7455.739049133254;7547.245275472409;7600.3539699123985;7739.226077392215;7922.366210703015;32208.35583288368;32541.511877321387;32627.67372326341;32760.83619581887;33383;38417.61582384141;40418.19163616652;40962.79518602388;41133.382999254434;41730.58269417267;9323.580438880132;9489.288303377412;9674.661386851709;9715.805683886425;9874.55564499585;10506.527206275583;10560.524776385235;10592.046715795615;10705.357678539001;10913.017828395483;9723.173530250007;9954.63383020108;10108.797824043331;10311.484425778832;10443.112335451571;9965.053319934595;10093.19254459656;10371.58513659445;10377.273590848568;10405.47972601382;8517.190866867637;8659.00421451516;8906.153915378029;9213.677521286723;9583.281253905845;8231.135730748185;8824;8960;8969.14793094655;9011.143941325563;8073.959630201812;8824.691135810215;8974.685885993958;8987.775305617412;9026.81946361056 08:07:52 INFO - PROCESS | 30926 | __end_tp_report 08:07:52 INFO - PROCESS | 30926 | __start_cc_report 08:07:52 INFO - PROCESS | 30926 | _x_x_mozilla_cycle_collect,903 08:07:52 INFO - PROCESS | 30926 | __end_cc_report 08:07:52 INFO - PROCESS | 30926 | __startTimestamp1464620872761__endTimestamp 08:07:52 INFO - PROCESS | 30926 | 08:07:52 INFO - PROCESS | 30926 | ------- Summary: start ------- 08:07:52 INFO - PROCESS | 30926 | Number of tests: 6 08:07:52 INFO - PROCESS | 30926 | 08:07:52 INFO - PROCESS | 30926 | [#0] dojo.html Cycles:165 Average:4643.45 Median:4755.12 stddev:496.42 (10.4%) stddev-sans-first:472.06 08:07:52 INFO - PROCESS | 30926 | Values: 2626.8 2649.1 2664.5 2684.4 2692.9 4561.0 4580.4 4643.8 4668.1 4702.1 4654.9 4667.5 4680.9 4698.0 4722.4 4103.4 4275.8 4375.1 4411.9 4490.9 4404.2 4451.6 4462.8 4470.8 4498.8 4207.3 4251.0 4313.4 4346.1 4352.4 4286.4 4287.6 4293.6 4337.9 4350.0 4320.4 4340.2 4344.8 4376.7 4388.1 4463.8 4562.7 4570.0 4595.1 4633.0 5062.0 5079.1 5092.1 5093.5 5093.7 5060.0 5103.1 5125.1 5128.8 5149.7 4591.2 4678.3 4724.7 4725.3 4797.4 5292.5 5300.3 5308.9 5310.0 5313.2 4814.2 5001.8 5003.3 5044.8 5049.8 4913.7 4947.4 4968.7 4990.7 4993.1 4937.2 4941.4 4945.7 4953.7 5007.7 4858.3 4871.5 4951.3 4957.8 5008.2 4159.6 4169.5 4177.5 4193.2 4214.2 3628.3 3652.8 3660.5 3683.2 3703.9 4216.9 4263.9 4302.8 4302.9 4317.7 5054.9 5081.2 5086.7 5092.0 5136.4 4329.1 4360.0 4361.8 4398.6 4408.6 4315.5 4331.8 4431.8 4515.5 4528.2 4599.3 4617.4 4627.9 4668.2 4679.6 4884.9 4890.1 4890.8 4898.6 4940.0 4625.0 4649.9 4742.5 4767.5 4782.5 5000.6 5021.3 5023.8 5024.3 5054.5 5032.8 5057.5 5064.2 5067.2 5146.4 4783.3 4868.3 4900.9 4913.3 4943.5 4904.3 4923.6 4940.9 4944.1 4981.9 4755.1 4842.2 4853.8 4904.2 4907.6 4923.7 4960.1 4961.0 4965.8 4987.8 4877.2 4897.6 4898.5 4901.1 4942.4 08:07:52 INFO - PROCESS | 30926 | 08:07:52 INFO - PROCESS | 30926 | [#1] ext.html Cycles:180 Average:44106.57 Median:36941.35 stddev:72420.00 (196.0%) stddev-sans-first:72549.42 08:07:52 INFO - PROCESS | 30926 | Values: 581.4 604.0 607.3 609.4 623.0 27722.3 30060.8 40259.0 41339.2 41537.6 42067.8 42321.2 42682.6 42821.8 42865.6 7715.9 7914.1 7917.1 7920.6 7922.7 7744.5 7845.2 7867.5 7869.1 7869.3 7823.3 7850.7 7888.9 7895.3 7917.5 7838.1 7873.8 7874.4 7875.3 7888.4 7777.0 7810.8 7838.1 7839.3 7845.4 38623.0 38944.8 38989.6 38996.6 39023.2 3069.5 3121.9 3160.1 3179.1 3200.3 29475.0 29518.1 30195.8 30547.5 31288.7 3224.5 3260.0 3266.8 3306.7 3333.7 256945.0 257067.0 257216.0 257684.0 257776.0 56248.7 56319.4 56476.4 56480.7 56617.4 50479.0 57387.7 59362.4 59539.0 66565.3 13440.0 13523.1 13566.4 13581.1 13582.3 9110.5 10055.5 10071.8 10146.5 10147.9 17180.1 17537.7 17747.8 18354.4 18390.0 6127.7 6168.3 6168.6 6281.4 6433.4 751.2 810.2 833.4 843.4 1018.3 27387.0 27877.0 28088.9 28210.6 28296.4 934.6 943.5 984.1 1027.6 1039.8 14407.4 14613.9 14905.6 15117.7 15136.5 272841.0 274238.0 275113.0 276481.0 276875.0 44069.0 44111.3 44153.8 44321.3 44390.3 1070.1 1172.6 1188.4 1211.7 1218.0 27756.2 29029.6 29694.3 29817.9 30040.0 42489.0 42762.6 43358.1 43375.3 43444.3 296143.0 296363.0 298506.0 298528.0 298893.0 20804.7 25692.2 26608.6 26953.6 26960.6 42896.6 43107.4 43283.4 43716.0 44078.8 36626.1 37073.9 37177.6 37336.6 37548.8 35520.8 36726.0 36869.4 37151.6 37210.8 36673.6 36684.4 36726.8 37013.3 37464.6 31659.7 31947.7 32957.3 33239.2 33327.3 24796.0 25772.5 26205.6 27336.2 27523.0 08:07:52 INFO - PROCESS | 30926 | 08:07:52 INFO - PROCESS | 30926 | [#2] jquery.html Cycles:180 Average:22978.13 Median:5970.02 stddev:63946.48 (1071.1%) stddev-sans-first:64103.32 08:07:52 INFO - PROCESS | 30926 | Values: 361.9 363.3 366.3 372.0 380.0 15435.7 16968.9 17181.7 17582.7 17652.8 15731.9 16097.5 16764.2 16775.2 16805.3 4988.2 5116.0 5118.9 5153.7 5174.0 3636.3 3818.8 5042.8 5591.7 5941.9 5952.1 6007.3 6016.8 6024.5 6028.3 5910.6 5936.5 5988.0 6010.8 6013.4 3316.5 3493.4 3497.7 5085.8 5234.1 18021.5 18413.6 19482.9 19511.8 19528.2 1845.3 1898.6 2199.3 2354.1 2387.5 8999.7 9056.7 9076.5 9146.0 9411.4 1697.1 1715.8 1715.9 1744.8 1753.4 63163.0 64331.7 65444.3 65764.7 66938.3 9384.4 9417.8 9495.3 9529.3 9797.5 13031.5 13108.8 13135.7 13463.6 13523.7 6900.8 6977.1 7044.0 7173.4 7179.2 6589.4 6647.6 6704.2 6718.3 6739.1 3992.9 4130.6 4131.8 4232.1 4236.6 1590.7 1630.7 1703.6 1743.4 1764.4 817.3 826.3 838.9 840.1 911.3 16005.5 16332.2 16387.0 16766.5 16965.2 808.4 846.4 890.7 899.9 928.7 9246.3 9308.7 9339.6 9612.1 9670.3 385051.0 388108.0 388203.0 392249.0 392596.0 47886.5 47905.0 48388.3 74330.6 75870.6 934.5 936.7 946.2 964.6 969.2 14722.2 14860.0 15018.8 15033.8 15208.7 31290.8 32930.5 33015.8 33440.8 34327.5 45381.3 47279.5 47332.1 50387.2 51397.0 6219.8 6558.7 6604.6 6653.1 6677.7 6209.7 7469.5 8946.6 9048.5 9986.6 6533.6 6538.9 6658.6 8486.3 9196.6 6157.4 6459.6 6490.5 6740.4 6801.4 6826.1 6911.8 6913.6 6918.8 6919.7 9671.6 9722.2 9730.3 9751.5 9816.9 9228.9 9257.4 9381.4 9475.1 9635.8 08:07:52 INFO - PROCESS | 30926 | 08:07:52 INFO - PROCESS | 30926 | [#3] mootools.html Cycles:180 Average:4970.56 Median:4883.36 stddev:2754.92 (56.4%) stddev-sans-first:2748.26 08:07:52 INFO - PROCESS | 30926 | Values: 1224.3 1394.8 1441.4 1520.8 1733.5 6557.0 7191.0 7351.7 7384.0 7574.4 7276.2 7448.9 7449.7 7450.2 7453.2 1886.1 1946.7 1948.7 2174.8 2216.1 1944.9 2134.9 2205.5 2207.1 2225.0 2151.0 2165.9 2172.7 2173.1 2174.1 1783.1 2159.6 2164.8 2167.8 2167.9 2078.9 2144.6 2145.6 2160.5 2163.3 7473.0 7528.4 7529.5 7542.3 7544.3 4338.1 4477.6 4478.1 4480.3 4481.9 2748.2 2859.6 2896.8 2897.0 2901.7 926.4 968.6 981.3 985.9 1010.2 10012.5 10012.8 10016.4 10020.7 10033.6 4066.7 4092.0 4213.1 4230.5 4234.1 8566.1 8612.5 8649.5 8662.1 8667.7 4478.7 4508.4 4535.4 4536.7 4538.2 3589.7 3733.4 4021.0 4054.1 4054.2 3567.1 3645.3 3693.0 3693.7 3695.2 1174.1 1190.4 1192.0 1200.1 1206.6 675.1 691.5 773.3 799.1 882.2 5052.4 5187.5 5206.2 5234.9 5253.0 395.3 399.1 399.3 401.7 410.9 3509.2 3554.1 3561.5 3589.3 3638.6 8973.1 9010.9 9239.5 9245.4 9247.4 9098.0 9183.6 9185.9 9219.8 9243.0 7010.6 7086.6 7182.9 7187.4 7203.3 5063.8 5080.7 5097.5 5302.4 5331.1 8544.4 8728.0 8744.0 8771.6 8774.5 8535.5 8617.1 8727.1 8832.2 8844.0 5912.4 6442.6 6555.9 6702.1 6824.4 7115.3 7126.8 7201.1 7214.0 7214.7 6401.7 6572.3 6643.9 6669.4 6751.6 6551.3 6557.2 6590.4 6624.7 6661.5 6284.9 6303.1 6325.4 6334.3 6339.9 4479.3 4495.8 4607.1 4652.3 4714.3 4573.3 4610.0 4623.6 4662.9 4673.8 08:07:52 INFO - PROCESS | 30926 | 08:07:52 INFO - PROCESS | 30926 | [#4] prototype.html Cycles:180 Average:4099.72 Median:4727.40 stddev:1187.37 (25.1%) stddev-sans-first:1155.55 08:07:52 INFO - PROCESS | 30926 | Values: 278.9 294.5 295.5 298.6 299.4 4729.6 4734.2 4749.9 4760.7 4760.9 4386.8 4470.3 4566.8 4637.4 4665.1 3705.3 3735.1 3736.2 3751.0 3755.8 3733.4 3735.2 3745.4 3747.5 3757.0 3460.2 3522.6 3609.4 3635.7 3646.5 3723.6 3726.6 3730.4 3732.8 3736.4 3275.2 3276.1 3277.8 3282.0 3289.0 4365.9 4506.5 4540.4 4541.9 4560.7 4161.8 4191.5 4197.1 4198.5 4207.7 4860.2 4871.0 4907.9 4908.3 4923.9 3554.9 3555.9 3559.9 3571.4 3581.7 4992.0 5010.2 5099.4 5104.3 5127.2 3603.6 3624.7 3626.1 3632.0 3646.1 3717.1 3718.3 3730.3 3738.8 3741.5 3867.2 4186.0 4192.5 4195.2 4225.6 4932.9 4938.9 4941.9 4967.6 4968.5 1214.3 1219.9 1233.7 1234.4 1239.4 784.0 793.7 821.9 838.3 844.2 4296.2 4356.5 4359.7 4362.7 4380.5 5017.1 5032.8 5046.9 5048.5 5064.0 4232.7 4290.3 4350.6 4372.7 4377.6 2679.8 2683.5 2691.4 2695.0 2696.6 4786.9 4797.7 4820.7 4821.4 4834.1 4887.5 5103.3 5138.7 5172.0 5173.6 4725.2 4769.8 4775.7 4776.9 4781.9 5007.7 5014.3 5022.3 5027.4 5044.1 4744.7 4908.9 4937.9 4941.2 5018.9 4830.6 4838.7 4873.6 4876.3 4878.4 3538.0 3559.7 3588.6 3590.9 3607.3 4908.9 5094.4 5124.6 5136.3 5148.4 4956.0 4960.3 4973.9 4977.5 4993.5 4942.0 4974.6 4987.6 4989.4 4994.4 4769.6 4833.9 4909.4 4913.5 4932.3 4970.9 4980.9 5008.2 5012.8 5013.3 4854.2 4867.5 4894.3 4897.9 4905.6 08:07:52 INFO - PROCESS | 30926 | 08:07:52 INFO - PROCESS | 30926 | [#5] yui.html Cycles:180 Average:13124.30 Median:26490.93 stddev:15663.19 (59.1%) stddev-sans-first:15678.99 08:07:52 INFO - PROCESS | 30926 | Values: 621.7 693.6 725.0 729.8 760.9 11975.9 12740.8 12935.9 12958.8 12961.5 11507.5 11540.5 11584.2 13217.3 13816.2 810.9 819.7 819.7 820.0 820.0 626.6 785.0 791.5 813.9 819.2 846.2 847.0 848.4 848.8 848.8 837.4 839.1 840.8 842.2 842.3 483.3 607.4 623.7 623.9 625.2 13028.0 13034.5 13048.0 13048.5 13095.1 11244.6 11615.8 11755.3 11823.5 11998.9 11289.5 11340.8 11385.2 11414.5 11430.2 3960.5 4087.1 4093.9 4251.4 4258.7 47279.3 47602.8 47944.3 47959.3 48034.5 9459.4 9560.1 9773.1 9783.6 9946.7 16470.5 16476.3 16476.4 16524.7 16575.3 6490.4 6496.9 6545.5 6546.8 6708.9 3685.2 3756.5 3763.4 3774.2 3849.2 2681.8 2768.1 2769.2 2771.2 2774.9 519.2 520.0 528.8 529.3 532.7 522.4 546.5 549.5 565.1 569.2 7009.7 7179.4 7332.5 7529.5 8497.3 513.0 609.0 610.5 618.7 620.9 3617.2 3752.7 3762.1 3794.7 3799.6 54768.7 55741.4 56612.4 56649.9 56944.1 50131.7 50929.7 51370.5 51415.7 52459.5 46204.3 46990.0 47076.5 47156.0 48419.5 7455.7 7547.2 7600.4 7739.2 7922.4 32208.4 32541.5 32627.7 32760.8 33383.0 38417.6 40418.2 40962.8 41133.4 41730.6 9323.6 9489.3 9674.7 9715.8 9874.6 10506.5 10560.5 10592.0 10705.4 10913.0 9723.2 9954.6 10108.8 10311.5 10443.1 9965.1 10093.2 10371.6 10377.3 10405.5 8517.2 8659.0 8906.2 9213.7 9583.3 8231.1 8824.0 8960.0 8969.1 9011.1 8074.0 8824.7 8974.7 8987.8 9026.8 08:07:52 INFO - PROCESS | 30926 | -------- Summary: end -------- 08:07:52 INFO - PROCESS | 30926 | 08:07:53 INFO - TEST-INFO | 30926: exit 0 08:07:53 INFO - TEST-OK | dromaeo_css | took 1118661ms 08:07:53 INFO - TEST-START | kraken 08:07:53 INFO - operating with platform_type : linux_ 08:07:53 INFO - Initialising browser for kraken test... 08:07:53 INFO - TEST-INFO | started process 31106 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfisjJp/profile http://localhost:52832/getInfo.html) 08:07:57 INFO - PROCESS | 31106 | __metrics Screen width/height:1600/1200 08:07:57 INFO - PROCESS | 31106 | colorDepth:24 08:07:57 INFO - PROCESS | 31106 | Browser inner width/height: 1024/697 08:07:57 INFO - PROCESS | 31106 | __metrics 08:07:58 ERROR - PROCESS | 31106 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 08:07:59 INFO - TEST-INFO | 31106: exit 0 08:07:59 INFO - Browser initialized. 08:07:59 INFO - Running cycle 1/1 for kraken test... 08:07:59 INFO - TEST-INFO | started process 31188 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfisjJp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:08:11 INFO - PROCESS | 31188 | RSS: Main: 157302784 08:08:11 INFO - PROCESS | 31188 | 08:08:14 INFO - PROCESS | 31188 | Cycle 1(1): loaded http://localhost:52832/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52832/tests/kraken/driver.html?testName=audio-beat-detection) 08:08:15 INFO - PROCESS | 31188 | RSS: Main: 215412736 08:08:15 INFO - PROCESS | 31188 | 08:08:18 INFO - PROCESS | 31188 | Cycle 1(1): loaded http://localhost:52832/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52832/tests/kraken/driver.html?testName=audio-dft) 08:08:18 INFO - PROCESS | 31188 | RSS: Main: 203411456 08:08:18 INFO - PROCESS | 31188 | 08:08:22 INFO - PROCESS | 31188 | Cycle 1(1): loaded http://localhost:52832/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52832/tests/kraken/driver.html?testName=audio-fft) 08:08:22 INFO - PROCESS | 31188 | RSS: Main: 270667776 08:08:22 INFO - PROCESS | 31188 | 08:08:24 INFO - PROCESS | 31188 | Cycle 1(1): loaded http://localhost:52832/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52832/tests/kraken/driver.html?testName=audio-oscillator) 08:08:25 INFO - PROCESS | 31188 | RSS: Main: 181379072 08:08:25 INFO - PROCESS | 31188 | 08:08:27 INFO - PROCESS | 31188 | Cycle 1(1): loaded http://localhost:52832/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52832/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:08:28 INFO - PROCESS | 31188 | RSS: Main: 184418304 08:08:28 INFO - PROCESS | 31188 | 08:08:31 INFO - PROCESS | 31188 | Cycle 1(1): loaded http://localhost:52832/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52832/tests/kraken/driver.html?testName=imaging-darkroom) 08:08:32 INFO - PROCESS | 31188 | RSS: Main: 220282880 08:08:32 INFO - PROCESS | 31188 | 08:08:35 INFO - PROCESS | 31188 | Cycle 1(1): loaded http://localhost:52832/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52832/tests/kraken/driver.html?testName=imaging-desaturate) 08:08:36 INFO - PROCESS | 31188 | RSS: Main: 216727552 08:08:36 INFO - PROCESS | 31188 | 08:08:39 INFO - PROCESS | 31188 | Cycle 1(1): loaded http://localhost:52832/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52832/tests/kraken/driver.html?testName=json-parse-financial) 08:08:39 INFO - PROCESS | 31188 | RSS: Main: 219766784 08:08:39 INFO - PROCESS | 31188 | 08:08:41 INFO - PROCESS | 31188 | Cycle 1(1): loaded http://localhost:52832/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52832/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:08:42 INFO - PROCESS | 31188 | RSS: Main: 209788928 08:08:42 INFO - PROCESS | 31188 | 08:08:44 INFO - PROCESS | 31188 | Cycle 1(1): loaded http://localhost:52832/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52832/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:08:44 INFO - PROCESS | 31188 | RSS: Main: 211501056 08:08:44 INFO - PROCESS | 31188 | 08:08:46 INFO - PROCESS | 31188 | Cycle 1(1): loaded http://localhost:52832/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52832/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:08:47 INFO - PROCESS | 31188 | RSS: Main: 218411008 08:08:47 INFO - PROCESS | 31188 | 08:08:50 INFO - PROCESS | 31188 | Cycle 1(1): loaded http://localhost:52832/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52832/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:08:50 INFO - PROCESS | 31188 | RSS: Main: 222633984 08:08:50 INFO - PROCESS | 31188 | 08:08:53 INFO - PROCESS | 31188 | Cycle 1(1): loaded http://localhost:52832/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52832/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:08:54 INFO - PROCESS | 31188 | RSS: Main: 222347264 08:08:54 INFO - PROCESS | 31188 | 08:08:56 INFO - PROCESS | 31188 | Cycle 1(1): loaded http://localhost:52832/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52832/tests/kraken/driver.html?testName=ai-astar) 08:08:56 INFO - PROCESS | 31188 | RSS: Main: 265191424 08:08:56 INFO - PROCESS | 31188 | 08:08:56 INFO - PROCESS | 31188 | __start_tp_report 08:08:56 INFO - PROCESS | 31188 | _x_x_mozilla_page_load 08:08:56 INFO - PROCESS | 31188 | _x_x_mozilla_page_load_details 08:08:56 INFO - PROCESS | 31188 | |i|pagename|runs| 08:08:56 INFO - PROCESS | 31188 | |0;ai-astar;116;110;114;114;115;114;114;114;115;113 08:08:56 INFO - PROCESS | 31188 | |1;audio-beat-detection;154;130;131;204;134;131;154;130;200;129 08:08:56 INFO - PROCESS | 31188 | |2;audio-dft;161;162;159;161;161;162;162;161;164;162 08:08:56 INFO - PROCESS | 31188 | |3;audio-fft;78;77;78;113;77;77;74;75;102;76 08:08:56 INFO - PROCESS | 31188 | |4;audio-oscillator;86;84;115;86;85;84;115;83;85;129 08:08:56 INFO - PROCESS | 31188 | |5;imaging-gaussian-blur;117;118;117;116;117;117;117;116;117;117 08:08:56 INFO - PROCESS | 31188 | |6;imaging-darkroom;146;147;146;146;145;147;147;145;146;146 08:08:56 INFO - PROCESS | 31188 | |7;imaging-desaturate;95;94;95;94;95;95;95;95;95;95 08:08:56 INFO - PROCESS | 31188 | |8;json-parse-financial;66;64;63;64;64;62;63;63;62;64 08:08:56 INFO - PROCESS | 31188 | |9;json-stringify-tinderbox;66;65;65;65;66;66;66;65;66;65 08:08:56 INFO - PROCESS | 31188 | |10;stanford-crypto-aes;82;82;83;83;83;84;84;84;149;83 08:08:56 INFO - PROCESS | 31188 | |11;stanford-crypto-ccm;132;132;136;128;129;129;128;140;136;136 08:08:56 INFO - PROCESS | 31188 | |12;stanford-crypto-pbkdf2;174;170;173;168;168;170;168;176;177;172 08:08:56 INFO - PROCESS | 31188 | |13;stanford-crypto-sha256-iterative;67;67;67;69;68;70;67;66;67;65 08:08:56 INFO - PROCESS | 31188 | __end_tp_report 08:08:56 INFO - PROCESS | 31188 | __start_cc_report 08:08:56 INFO - PROCESS | 31188 | _x_x_mozilla_cycle_collect,1901 08:08:56 INFO - PROCESS | 31188 | __end_cc_report 08:08:56 INFO - PROCESS | 31188 | __startTimestamp1464620936486__endTimestamp 08:08:56 INFO - PROCESS | 31188 | 08:08:56 INFO - PROCESS | 31188 | ------- Summary: start ------- 08:08:56 INFO - PROCESS | 31188 | Number of tests: 14 08:08:56 INFO - PROCESS | 31188 | 08:08:56 INFO - PROCESS | 31188 | [#0] ai-astar Cycles:10 Average:113.90 Median:114.00 stddev:1.60 (1.4%) stddev-sans-first:1.50 08:08:56 INFO - PROCESS | 31188 | Values: 116.0 110.0 114.0 114.0 115.0 114.0 114.0 114.0 115.0 113.0 08:08:56 INFO - PROCESS | 31188 | 08:08:56 INFO - PROCESS | 31188 | [#1] audio-beat-detection Cycles:10 Average:149.70 Median:144.00 stddev:29.19 (20.3%) stddev-sans-first:30.91 08:08:56 INFO - PROCESS | 31188 | Values: 154.0 130.0 131.0 204.0 134.0 131.0 154.0 130.0 200.0 129.0 08:08:56 INFO - PROCESS | 31188 | 08:08:56 INFO - PROCESS | 31188 | [#2] audio-dft Cycles:10 Average:161.50 Median:162.00 stddev:1.27 (0.8%) stddev-sans-first:1.33 08:08:56 INFO - PROCESS | 31188 | Values: 161.0 162.0 159.0 161.0 161.0 162.0 162.0 161.0 164.0 162.0 08:08:56 INFO - PROCESS | 31188 | 08:08:56 INFO - PROCESS | 31188 | [#3] audio-fft Cycles:10 Average:82.70 Median:77.00 stddev:13.38 (17.4%) stddev-sans-first:14.09 08:08:56 INFO - PROCESS | 31188 | Values: 78.0 77.0 78.0 113.0 77.0 77.0 74.0 75.0 102.0 76.0 08:08:56 INFO - PROCESS | 31188 | 08:08:56 INFO - PROCESS | 31188 | [#4] audio-oscillator Cycles:10 Average:95.20 Median:84.50 stddev:17.33 (20.5%) stddev-sans-first:18.06 08:08:56 INFO - PROCESS | 31188 | Values: 86.0 84.0 115.0 86.0 85.0 84.0 115.0 83.0 85.0 129.0 08:08:56 INFO - PROCESS | 31188 | 08:08:56 INFO - PROCESS | 31188 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 08:08:56 INFO - PROCESS | 31188 | Values: 117.0 118.0 117.0 116.0 117.0 117.0 117.0 116.0 117.0 117.0 08:08:56 INFO - PROCESS | 31188 | 08:08:56 INFO - PROCESS | 31188 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 08:08:56 INFO - PROCESS | 31188 | Values: 146.0 147.0 146.0 146.0 145.0 147.0 147.0 145.0 146.0 146.0 08:08:56 INFO - PROCESS | 31188 | 08:08:56 INFO - PROCESS | 31188 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 08:08:56 INFO - PROCESS | 31188 | Values: 95.0 94.0 95.0 94.0 95.0 95.0 95.0 95.0 95.0 95.0 08:08:56 INFO - PROCESS | 31188 | 08:08:56 INFO - PROCESS | 31188 | [#8] json-parse-financial Cycles:10 Average:63.50 Median:64.00 stddev:1.18 (1.8%) stddev-sans-first:0.83 08:08:56 INFO - PROCESS | 31188 | Values: 66.0 64.0 63.0 64.0 64.0 62.0 63.0 63.0 62.0 64.0 08:08:56 INFO - PROCESS | 31188 | 08:08:56 INFO - PROCESS | 31188 | [#9] json-stringify-tinderbox Cycles:10 Average:65.50 Median:66.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 08:08:56 INFO - PROCESS | 31188 | Values: 66.0 65.0 65.0 65.0 66.0 66.0 66.0 65.0 66.0 65.0 08:08:56 INFO - PROCESS | 31188 | 08:08:56 INFO - PROCESS | 31188 | [#10] stanford-crypto-aes Cycles:10 Average:89.70 Median:83.00 stddev:20.85 (25.1%) stddev-sans-first:21.93 08:08:56 INFO - PROCESS | 31188 | Values: 82.0 82.0 83.0 83.0 83.0 84.0 84.0 84.0 149.0 83.0 08:08:56 INFO - PROCESS | 31188 | 08:08:56 INFO - PROCESS | 31188 | [#11] stanford-crypto-ccm Cycles:10 Average:132.60 Median:134.00 stddev:4.20 (3.1%) stddev-sans-first:4.44 08:08:56 INFO - PROCESS | 31188 | Values: 132.0 132.0 136.0 128.0 129.0 129.0 128.0 140.0 136.0 136.0 08:08:56 INFO - PROCESS | 31188 | 08:08:56 INFO - PROCESS | 31188 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.60 Median:172.50 stddev:3.34 (1.9%) stddev-sans-first:3.43 08:08:56 INFO - PROCESS | 31188 | Values: 174.0 170.0 173.0 168.0 168.0 170.0 168.0 176.0 177.0 172.0 08:08:56 INFO - PROCESS | 31188 | 08:08:56 INFO - PROCESS | 31188 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:67.00 stddev:1.42 (2.1%) stddev-sans-first:1.50 08:08:56 INFO - PROCESS | 31188 | Values: 67.0 67.0 67.0 69.0 68.0 70.0 67.0 66.0 67.0 65.0 08:08:56 INFO - PROCESS | 31188 | -------- Summary: end -------- 08:08:56 INFO - PROCESS | 31188 | 08:08:57 INFO - TEST-INFO | 31188: exit 0 08:08:57 INFO - TEST-OK | kraken | took 64080ms 08:08:57 INFO - SUITE-END | took 1182s 08:08:57 INFO - Completed test suite (00:19:42) 08:08:57 INFO - javascript benchmark 08:08:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2626.8292560983537, 2649.0860653074683, 2664.5470270054093, 2684.3691732442885, 2692.919212423628, 4560.954390456094, 4580.404547408836, 4643.837465688697, 4668.113058518879, 4702.083093796711, 4654.930176047362, 4667.486576476594, 4680.859574212771, 4698.0, 4722.433308003036, 4103.384492326145, 4275.7648329341955, 4375.059362237118, 4411.889702757425, 4490.899729566261, 4404.207242696313, 4451.554844515539, 4462.754548499831, 4470.82116715331, 4498.752568608726, 4207.284761590522, 4251.043515209084, 4313.352997050436, 4346.109047645256, 4352.390665306828, 4286.442762440894, 4287.592678695519, 4293.592108749664, 4337.913241735179, 4349.956500435019, 4320.351947207912, 4340.197063543223, 4344.7827608619755, 4376.6936314458, 4388.056567837898, 4463.799129039168, 4562.726236425792, 4569.977150114261, 4595.058013107305, 4633.027064316498, 5062.038212739568, 5079.060373830816, 5092.083424983502, 5093.516115968977, 5093.745312734349, 5060.038592667382, 5103.055934652101, 5125.103106956268, 5128.8461346159675, 5149.716765577892, 4591.173588754023, 4678.251479763256, 4724.6692731508465, 4725.338452616567, 4797.424309082932, 5292.52367286946, 5300.310959575308, 5308.867278317995, 5310.044192045469, 5313.229581710631, 4814.229723244264, 5001.8499445016705, 5003.324551185616, 5044.8234311798915, 5049.772760225798, 4913.70517768935, 4947.356843610308, 4968.72672003036, 4990.6506544541535, 4993.1262029144755, 4937.23472861707, 4941.407031156285, 4945.67853089548, 4953.702777833341, 5007.724575148329, 4858.295547145644, 4871.5128487151005, 4951.257311403247, 4957.7769000395065, 5008.17365134756, 4159.625633692982, 4169.457970463881, 4177.540470548237, 4193.182329445729, 4214.241436541452, 3628.346897558412, 3652.7808331500196, 3660.524131862894, 3683.226522430266, 3703.9259214816093, 4216.852410165691, 4263.87208383749, 4302.849400271038, 4302.89242768927, 4317.676174286941, 5054.9241761373605, 5081.18701007837, 5086.720230387365, 5092.032513822362, 5136.43499215086, 4329.1125319310095, 4360.0, 4361.847335343247, 4398.582134697199, 4408.625266852354, 4315.4605674290715, 4331.7834108294455, 4431.756253406029, 4515.458145022619, 4528.162289976365, 4599.264117741145, 4617.376654151646, 4627.8843028923875, 4668.2297420926525, 4679.578837904605, 4884.92672609904, 4890.119778439773, 4890.828820991248, 4898.583620392306, 4940.036692844861, 4625.028743963805, 4649.930251046169, 4742.478327384054, 4767.523247675204, 4782.545658162469, 5000.5999520037585, 5021.347224860745, 5023.799048038038, 5024.321716568363, 5054.545090941833, 5032.798688052583, 5057.519535644108, 5064.164412871983, 5067.189249720027, 5146.356705411824, 4783.258594917794, 4868.3427737255015, 4900.877478062935, 4913.287573301923, 4943.505649435027, 4904.2643603459765, 4923.581495572773, 4940.925886111783, 4944.134776414185, 4981.850544483671, 4755.120302744003, 4842.17682993899, 4853.781579828987, 4904.215325547895, 4907.631927605373, 4923.6799608026795, 4960.107180707363, 4960.950390496048, 4965.776540055634, 4987.825426110068, 4877.170880950176, 4897.58370538494, 4898.53463920927, 4901.14230009754, 4942.4316203637045], "value": 4611.755120657662, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [581.4243898540444, 603.9818805435835, 607.3380015782795, 609.357128229718, 622.9906551401729, 27722.306942326453, 30060.849695751545, 40258.99999999996, 41339.173216535724, 41537.58462415375, 42067.78966105173, 42321.15357692852, 42682.57317426825, 42821.785891070576, 42865.571344286545, 7715.922840771576, 7914.089879663826, 7917.129115797257, 7920.643571039288, 7922.722704705337, 7744.457887947818, 7845.215478452138, 7867.527948323119, 7869.05571331441, 7869.252421019994, 7823.3350165236025, 7850.685972561091, 7888.921110788876, 7895.328897043758, 7917.485363451386, 7838.059432868064, 7873.842523149562, 7874.370050395954, 7875.251851074138, 7888.368930485576, 7776.961115194388, 7810.765677029698, 7838.137804841463, 7839.294463498312, 7845.411594130406, 38623.0, 38944.805275973726, 38989.61010389916, 38996.61003389958, 39023.219535609416, 3069.493533566959, 3121.9219519511967, 3160.083575763026, 3179.1098492422157, 3200.2959348943195, 29475.0, 29518.114456566338, 30195.849020754755, 30547.541786873215, 31288.687113128806, 3224.5324427957817, 3260.0, 3266.787658802194, 3306.702396784301, 3333.666633336671, 256945.0, 257067.0, 257215.99999999814, 257684.0, 257776.0, 56248.71875640596, 56319.43680563224, 56476.435235647936, 56480.71759641258, 56617.43382566204, 50479.0, 57387.71306143443, 59362.40637593655, 59539.0, 66565.33434665688, 13440.0, 13523.120997135155, 13566.389512471962, 13581.117227380386, 13582.25297608641, 9110.498922559324, 10055.547500362502, 10071.798564028679, 10146.49267536635, 10147.949260253652, 17180.140992950302, 17537.736933946002, 17747.82252177462, 18354.449366519028, 18390.0, 6127.6936153193055, 6168.321484636686, 6168.568200225941, 6281.371862813773, 6433.365148690975, 751.2299892610009, 810.2464707821664, 833.4249367936104, 843.3843294395126, 1018.2617602238317, 27387.0, 27877.0, 28088.85955570209, 28210.576841346985, 28296.434071318457, 934.56075644447, 943.4716558727134, 984.1437948984286, 1027.609508386823, 1039.838824982129, 14407.351669174912, 14613.853861461463, 14905.552833415015, 15117.697646047238, 15136.54590362291, 272841.0, 274238.0, 275113.0, 276481.0, 276875.0, 44069.0, 44111.33832992508, 44153.77923110364, 44321.335179972324, 44390.33414498785, 1070.0583486531957, 1172.5720112159001, 1188.4176753390777, 1211.684961909892, 1218.03775017735, 27756.167314979775, 29029.564556532092, 29694.257643559085, 29817.850910745306, 30040.0, 42489.0, 42762.57237427586, 43358.13283734245, 43375.34936976011, 43444.348334774375, 296143.0, 296363.0, 298506.0, 298528.0, 298893.0, 20804.68792968137, 25692.201545892356, 26608.60087098734, 26953.59569606418, 26960.595591066543, 42896.571034289256, 43107.396722481535, 43283.35074973941, 43716.0, 44078.779606103046, 36626.08434789045, 37073.86789529942, 37177.62822371742, 37336.626633733315, 37548.812255938545, 35520.82239588785, 36726.0, 36869.44695829511, 37151.62848371482, 37210.813945930095, 36673.63326366809, 36684.44973325349, 36726.816365918, 37013.259734805695, 37464.625353746116, 31659.683403165673, 31947.722091117026, 32957.34085318328, 33239.16902077467, 33327.33345333128, 24796.0, 25772.495076625044, 26205.606915895896, 27336.228053615443, 27523.0], "value": 17316.05037382366, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [361.8516408272608, 363.28432987015583, 366.34058694350165, 372.04941374787444, 379.9735109850044, 15435.69128617427, 16968.91515542422, 17181.656366872685, 17582.736258956127, 17652.823471765278, 15731.921340393283, 16097.517074487754, 16764.245608947596, 16775.24511396987, 16805.32778688854, 4988.176950803122, 5116.0, 5118.897622047557, 5153.665011774241, 5174.042802081608, 3636.2545678136053, 3818.77087374757, 5042.848714538552, 5591.692456914868, 5941.940580594203, 5952.077427998667, 6007.279126504825, 6016.8495787605225, 6024.48791852693, 6028.306744724369, 5910.556708246877, 5936.495397891184, 5987.970060149715, 6010.8497287567725, 6013.428724271209, 3316.469364901628, 3493.3886569850174, 3497.6502349765074, 5085.821996230115, 5234.136367499358, 18021.549461263443, 18413.63172736551, 19482.902585487125, 19511.804881951142, 19528.21887124513, 1845.344902559599, 1898.6107847891149, 2199.274239500961, 2354.1407386304045, 2387.5344307859973, 8999.730008099768, 9056.683016094405, 9076.455412675261, 9145.954270228607, 9411.43531388119, 1697.125980120239, 1715.759793628893, 1715.9227834747467, 1744.790625124993, 1753.3950786978598, 63163.0, 64331.67834160846, 65444.3455565443, 65764.67117664381, 66938.3306166937, 9384.390014649163, 9417.764555886157, 9495.335326527214, 9529.332946693665, 9797.510124493747, 13031.543895963596, 13108.80336794949, 13135.671608209872, 13463.596092117055, 13523.729525409437, 6900.7929762107215, 6977.058097156819, 7044.049053377831, 7173.390261827699, 7179.246179151219, 6589.439897608757, 6647.60114393138, 6704.161979752531, 6718.260991290954, 6739.056532085512, 3992.920141597152, 4130.648894843972, 4131.8224306073225, 4232.074406145197, 4236.576342365739, 1590.658008528172, 1630.7064728349012, 1703.6166862455848, 1743.3810997096102, 1764.4442000769973, 817.2930415190817, 826.338928856912, 838.8633401740675, 840.1010918317464, 911.2983003087586, 16005.519834404986, 16332.183390830649, 16387.0, 16766.497005089866, 16965.236564354633, 808.3735105293445, 846.3652260804397, 890.7238755985536, 899.8965119011267, 928.7306681062552, 9246.306527010502, 9308.674196403093, 9339.579718912666, 9612.086851749073, 9670.323077384515, 385051.0, 388108.0, 388203.0, 392249.0, 392596.0, 47886.52113478821, 47905.0, 48388.27417588739, 74330.62834685792, 75870.62064689641, 934.5233930695258, 936.7236665183788, 946.2288235088381, 964.6141543382703, 969.1858838575489, 14722.24837352663, 14860.0, 15018.849811501745, 15033.774493382389, 15208.695826083638, 31290.843545782125, 32930.5060424089, 33015.83492082524, 33440.83279583684, 34327.4850877232, 45381.31928021016, 47279.527204727514, 47332.05335893332, 50387.24419133789, 51397.0, 6219.813405597839, 6558.672066396565, 6604.570702904296, 6653.068570400244, 6677.69950352245, 6209.658468784261, 7469.477136600386, 8946.642134314814, 9048.547572621474, 9986.550605222637, 6533.575317604341, 6538.901916471162, 6658.600483970978, 8486.278666313185, 9196.632134714804, 6157.4458298753325, 6459.61242325462, 6490.513211509061, 6740.39336459721, 6801.421879140328, 6826.112605361272, 6911.7926462206215, 6913.5506192097355, 6918.757843475454, 6919.688614012281, 9671.613135474503, 9722.1736152425, 9730.318877678494, 9751.463669498246, 9816.85274720894, 9228.907710922806, 9257.444553326823, 9381.390209636353, 9475.05249475047, 9635.759106022406], "value": 7652.718864819433, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1224.3082658298067, 1394.8047273381726, 1441.3874103506012, 1520.7870898074273, 1733.4539620019693, 6557.0, 7190.964045179773, 7351.742689005886, 7384.040074790277, 7574.35617972473, 7276.16324122726, 7448.851022979537, 7449.739259125919, 7450.180480147193, 7453.180150183475, 1886.0852486544015, 1946.7079938009342, 1948.743060725831, 2174.83688723346, 2216.1024784962115, 1944.931927382542, 2134.882581458019, 2205.5368372641765, 2207.0619986505753, 2224.9777502224933, 2151.0, 2165.85921915075, 2172.7392712874475, 2173.1307477009245, 2174.13034786086, 1783.1351794379716, 2159.6220661384273, 2164.7943445372666, 2167.783221677835, 2167.8590891592075, 2078.864873783199, 2144.624690679125, 2145.6352420088624, 2160.524684569408, 2163.2753027735725, 7473.0, 7528.435367347471, 7529.548227106391, 7542.2834830691545, 7544.283293087148, 4338.089001309729, 4477.619402350804, 4478.104379124188, 4480.305552639346, 4481.8655440336515, 2748.2030211238716, 2859.5567687008547, 2896.826190428581, 2896.9710302897124, 2901.680815110336, 926.393212445849, 968.5738275158908, 981.342500524643, 985.935914165577, 1010.1514727628827, 10012.54943527543, 10012.799744005079, 10016.449095299682, 10020.69937901864, 10033.648822291185, 4066.674666026711, 4091.9590804091577, 4213.136307057046, 4230.534641189467, 4234.1108367242605, 8566.143385661384, 8612.48325100496, 8649.481031138152, 8662.090480499583, 8667.739967800977, 4478.701176658732, 4508.368828364031, 4535.365048893158, 4536.705114167568, 4538.205813982539, 3589.6948759355746, 3733.3653278942643, 4021.034951611592, 4054.0878302382316, 4054.2499637567144, 3567.1438854674693, 3645.2709458108484, 3693.021349342426, 3693.7045036397026, 3695.150115473456, 1174.1135442740676, 1190.4047976011993, 1192.0344520938067, 1200.1299058182922, 1206.5656363709058, 675.1021141881287, 691.4952084977995, 773.2808488106003, 799.0930294116104, 882.188386684252, 5052.418971818214, 5187.481251874782, 5206.245094461282, 5234.9476505235225, 5252.9737351313, 395.320049514834, 399.14981090277524, 399.279300861947, 401.684677528139, 410.9486314210724, 3509.2455122148863, 3554.111472131967, 3561.5013898054294, 3589.3180295743723, 3638.6179451157245, 8973.102689730975, 9010.909890901139, 9239.491827949392, 9245.352825302165, 9247.352685311964, 9097.954510227406, 9183.63265469387, 9185.908140918506, 9219.815603687888, 9242.983271840092, 7010.614416207158, 7086.610236437045, 7182.892256616155, 7187.353138217585, 7203.315685009916, 5063.797448102035, 5080.669756465818, 5097.464766199644, 5302.39022512416, 5331.1470164775, 8544.444611100258, 8727.956360218159, 8743.956280218557, 8771.605277762388, 8774.473531588124, 8535.53054582004, 8617.138286171332, 8727.127287271222, 8832.249258813074, 8843.955780221058, 5912.379200184091, 6442.645654489048, 6555.901661474986, 6702.061711360511, 6824.351686589766, 7115.288471152843, 7126.786196414116, 7201.13586369618, 7214.026106475559, 7214.71141154348, 6401.711922963571, 6572.34276572339, 6643.900341494785, 6669.433098186709, 6751.594904305561, 6551.344865513411, 6557.245916719447, 6590.439812615789, 6624.701888414937, 6661.533692641468, 6284.937150628618, 6303.1175635412, 6325.430711236011, 6334.303226644974, 6339.936600633934, 4479.3057076153245, 4495.7976891039325, 4607.055553611434, 4652.302154676826, 4714.292856071616, 4573.291139873325, 4609.976950115228, 4623.56076172763, 4662.930056049094, 4673.836415725434], "value": 3954.093974652451, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [278.9302674331416, 294.5155219663653, 295.53600846670724, 298.57751281936055, 299.42958663745543, 4729.597984171345, 4734.171519984006, 4749.90500189996, 4760.666753327268, 4760.928586071207, 4386.846460373888, 4470.26240670289, 4566.817327306912, 4637.420322459692, 4665.09030739006, 3705.2589482103554, 3735.0849041984616, 3736.2153947670886, 3750.9624903751023, 3755.7746535207907, 3733.383991641376, 3735.2342769732277, 3745.4194599836933, 3747.4566187902738, 3756.9812150939206, 3460.2041530448014, 3522.630123836999, 3609.4405367168133, 3635.654612811779, 3646.4894914711963, 3723.590405055442, 3726.6211501744256, 3730.3658378075793, 3732.757370770891, 3736.4208547675153, 3275.24669326054, 3276.1318250663594, 3277.80387140614, 3281.983590082058, 3288.9835550822095, 4365.890852728708, 4506.5493450655, 4540.387047748544, 4541.909161816745, 4560.749158796265, 4161.835845360426, 4191.476065491814, 4197.118605092935, 4198.454200953887, 4207.726497777635, 4860.1737704590305, 4871.0, 4907.901841963177, 4908.337374454439, 4923.852284431473, 3554.875579354736, 3555.8933232003083, 3559.94660080099, 3571.3750093733493, 3581.7492775505466, 4991.950080499185, 5010.248462730583, 5099.413567439755, 5104.336436263299, 5127.154019586764, 3603.621609737613, 3624.6737793598704, 3626.0934766308424, 3631.9636803631624, 3646.08847788053, 3717.1450566369886, 3718.2749363874327, 3730.309892669865, 3738.813059347076, 3741.494898188764, 3867.245887052054, 4186.0, 4192.496900371975, 4195.244855925963, 4225.556316586714, 4932.8520144395725, 4938.8765280868265, 4941.912779188573, 4967.602591792648, 4968.503149685075, 1214.3199808107488, 1219.8594314315965, 1233.7224124571899, 1234.4013153620488, 1239.423667994387, 783.9725609603637, 793.6785601831267, 821.9465734727223, 838.33771320656, 844.1811442900377, 4296.217069916012, 4356.455443069616, 4359.651227901761, 4362.650987920959, 4380.474343078788, 5017.1185805323, 5032.8172879373315, 5046.949530504721, 5048.495150484922, 5063.974680126576, 4232.661387089025, 4290.334998075304, 4350.563684336718, 4372.672049596293, 4377.606015458624, 2679.7722193613763, 2683.490136873988, 2691.3675286307703, 2694.9730502695115, 2696.649435573402, 4786.875084355173, 4797.6806378245565, 4820.662553621213, 4821.421429428421, 4834.105690447279, 4887.511248875084, 5103.336566246364, 5138.689634143269, 5171.974140129275, 5173.637845350864, 4725.196716558262, 4769.785359658893, 4775.6657034007985, 4776.880577985578, 4781.856544303677, 5007.7245751484015, 5014.297998280316, 5022.347094877642, 5027.446980832178, 5044.1424957758, 4744.715317080848, 4908.92636610444, 4937.876553086202, 4941.234108713155, 5018.949810501848, 4830.637702172421, 4838.685485443435, 4873.561379475864, 4876.317315575893, 4878.365747474494, 3537.9646203537636, 3559.661832125944, 3588.551431071116, 3590.856365745341, 3607.296577167427, 4908.852734417973, 5094.414142373675, 5124.590032797293, 5136.280920671184, 5148.43367229612, 4955.950440495549, 4960.330355402119, 4973.850784476472, 4977.4773648767805, 4993.501949415234, 4941.975290123526, 4974.602031837517, 4987.551120399182, 4989.351384320015, 4994.350734404504, 4769.57073863354, 4833.9033219334715, 4909.4354149273295, 4913.459519452929, 4932.260160975882, 4970.850874473772, 4980.900381992267, 5008.198688209869, 5012.8496145115705, 5013.273075404119, 4854.247591623304, 4867.5132486751045, 4894.2658601210105, 4897.853064408074, 4905.583025442877], "value": 3719.2817243433274, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [621.6580880515717, 693.6115775165907, 724.9565026098431, 729.8321386081203, 760.8820632801915, 11975.940120299398, 12740.80888786669, 12935.935320323397, 12958.80561791574, 12961.546345877896, 11507.539698412054, 11540.480678369473, 11584.247023943437, 13217.339133043357, 13816.240106794123, 810.8783682447621, 819.6967122164777, 819.737683941139, 819.9672013119468, 820.0077905734039, 626.6177631644694, 785.0422484568845, 791.5369508837337, 813.9430239883211, 819.1808191808192, 846.1707526623912, 847.0259201917813, 848.3933987199151, 848.8344772769312, 848.8429640516524, 837.409626213518, 839.0518713853306, 840.815020695446, 842.1788755962917, 842.2672275120653, 483.34989439204213, 607.4259824465881, 623.7473823101651, 623.9313675495691, 625.171647566971, 13028.0, 13034.478620855154, 13048.0, 13048.543300984515, 13095.14881532707, 11244.606438774603, 11615.767684646344, 11755.294682319089, 11823.527058917633, 11998.880011199864, 11289.49197286124, 11340.829887551694, 11385.203035787497, 11414.486348114355, 11430.199886007982, 3960.5049368828895, 4087.0804069084516, 4093.9385909211387, 4251.383549385322, 4258.659307255443, 47279.290810637525, 47602.76198618985, 47944.28083578749, 47959.28061079052, 48034.519654803706, 9459.38513996588, 9560.091791279818, 9773.12041916231, 9783.608655653836, 9946.701598952042, 16470.505884823473, 16476.340946362012, 16476.42332518356, 16524.6695066098, 16575.336986520404, 6490.383413575702, 6496.935030649727, 6545.5090868184125, 6546.803595892131, 6708.899366509506, 3685.152414944524, 3756.530433695788, 3763.3790424580184, 3774.169682669808, 3849.2493963676816, 2681.825681330707, 2768.0865314446182, 2769.155407600701, 2771.237909574843, 2774.875130619127, 519.236722018632, 520.0353344545889, 528.7779132764248, 529.2748933960498, 532.7123353389127, 522.3914140026902, 546.4617351908367, 549.5190461705745, 565.0591764711791, 569.1860639285778, 7009.684564194624, 7179.425645948311, 7332.450066245053, 7529.4729368944745, 8497.277731392776, 512.9615278854101, 608.9604175728564, 610.4780412747126, 618.6999305336908, 620.9068639703991, 3617.2042150726797, 3752.7373083883867, 3762.097096696773, 3794.715396345285, 3799.5820459749407, 54768.72615636896, 55741.442585574434, 56612.43387566072, 56649.86700265972, 56944.14583781164, 50131.74934125379, 50929.745351273006, 51370.486295137314, 51415.74292128516, 52459.47540524546, 46204.306935395995, 46990.0, 47076.5292347079, 47156.0, 48419.5158048422, 7455.739049133254, 7547.245275472409, 7600.3539699123985, 7739.226077392215, 7922.366210703015, 32208.35583288368, 32541.511877321387, 32627.67372326341, 32760.83619581887, 33383.0, 38417.61582384141, 40418.19163616652, 40962.79518602388, 41133.382999254434, 41730.58269417267, 9323.580438880132, 9489.288303377412, 9674.661386851709, 9715.805683886425, 9874.55564499585, 10506.527206275583, 10560.524776385235, 10592.046715795615, 10705.357678539001, 10913.017828395483, 9723.173530250007, 9954.63383020108, 10108.797824043331, 10311.484425778832, 10443.112335451571, 9965.053319934595, 10093.19254459656, 10371.58513659445, 10377.273590848568, 10405.47972601382, 8517.190866867637, 8659.00421451516, 8906.153915378029, 9213.677521286723, 9583.281253905845, 8231.135730748185, 8824.0, 8960.0, 8969.14793094655, 9011.143941325563, 8073.959630201812, 8824.691135810215, 8974.685885993958, 8987.775305617412, 9026.81946361056], "value": 5893.65818952133, "unit": "score"}], "name": "dromaeo_css", "value": 6128.377193457027, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 110.0, 114.0, 114.0, 115.0, 114.0, 114.0, 114.0, 115.0, 113.0], "value": 113.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 130.0, 131.0, 204.0, 134.0, 131.0, 154.0, 130.0, 200.0, 129.0], "value": 149.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 159.0, 161.0, 161.0, 162.0, 162.0, 161.0, 164.0, 162.0], "value": 161.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 77.0, 78.0, 113.0, 77.0, 77.0, 74.0, 75.0, 102.0, 76.0], "value": 82.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 115.0, 86.0, 85.0, 84.0, 115.0, 83.0, 85.0, 129.0], "value": 95.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 116.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 146.0, 145.0, 147.0, 147.0, 145.0, 146.0, 146.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 64.0, 63.0, 64.0, 64.0, 62.0, 63.0, 63.0, 62.0, 64.0], "value": 63.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 65.0, 65.0, 66.0, 66.0, 66.0, 65.0, 66.0, 65.0], "value": 65.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 83.0, 83.0, 83.0, 84.0, 84.0, 84.0, 149.0, 83.0], "value": 89.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 132.0, 136.0, 128.0, 129.0, 129.0, 128.0, 140.0, 136.0, 136.0], "value": 132.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 170.0, 173.0, 168.0, 168.0, 170.0, 168.0, 176.0, 177.0, 172.0], "value": 171.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 67.0, 69.0, 68.0, 70.0, 67.0, 66.0, 67.0, 65.0], "value": 67.3, "unit": "score"}], "name": "kraken", "value": 1550.9999999999998, "alertThreshold": 2.0}]} 08:08:57 INFO - Return code: 0 08:08:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 08:08:57 ERROR - # TBPL SUCCESS # 08:08:57 INFO - Running post-action listener: _resource_record_post_action 08:08:57 INFO - ##### 08:08:57 INFO - ##### Finished run-tests step (success) 08:08:57 INFO - ##### 08:08:57 INFO - Running post-run listener: _resource_record_post_run 08:08:57 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 0; Write bytes: 534142976; Read time: 0; Write time: 692052 08:08:57 INFO - TinderboxPrint: CPU usage
13.1% 08:08:57 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 08:08:57 INFO - TinderboxPrint: I/O write bytes / time
534,142,976 / 692,052 08:08:57 INFO - TinderboxPrint: CPU idle
8,322.3 (86.9%) 08:08:57 INFO - TinderboxPrint: CPU user
1,210.1 (12.6%) 08:08:57 INFO - TinderboxPrint: Swap in / out
0 / 0 08:08:57 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 243511296; Read time: 0; Write time: 363224 08:08:57 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 0; Write bytes: 290627584; Read time: 0; Write time: 328828 08:08:58 INFO - Running post-run listener: _upload_blobber_files 08:08:58 INFO - Blob upload gear active. 08:08:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:08:58 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 08:08:58 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'] 08:08:58 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 08:08:58 INFO - (blobuploader) - INFO - Open directory for files ... 08:08:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:08:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:08:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:08:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:08:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:08:59 INFO - (blobuploader) - INFO - Done attempting. 08:08:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:08:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:08:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:09:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:09:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:09:00 INFO - (blobuploader) - INFO - Done attempting. 08:09:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:09:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:09:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:09:04 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:09:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:09:04 INFO - (blobuploader) - INFO - Done attempting. 08:09:04 INFO - (blobuploader) - INFO - Iteration through files over. 08:09:04 INFO - Return code: 0 08:09:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:09:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:09:04 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2c4c12ea1c44d425134e1418e046fb2245b2d508b61ec843ddecb4ad645e086e6601045410032af8caf25e35ad2d0aff9c3308e54af73d36ebe385a82055ec7c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/10c60891cb0e0cca0055f714a5fb7834ad6ecaa32db48f1a0a4452b3dceb7506ed41edf9d93ef5b5e5c6bff1363e979631e7b1ad6f70aabf745465a95aa002ef", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3373452394e19e01c26cbdd79932bfbc7fd76b40d477885364f4478941a3c3a01dbd0d65fadfc977787b8c89c296c0c44009d473de1e4e64c07418104ab10616"} 08:09:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:09:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:09:04 INFO - Contents: 08:09:04 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2c4c12ea1c44d425134e1418e046fb2245b2d508b61ec843ddecb4ad645e086e6601045410032af8caf25e35ad2d0aff9c3308e54af73d36ebe385a82055ec7c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/10c60891cb0e0cca0055f714a5fb7834ad6ecaa32db48f1a0a4452b3dceb7506ed41edf9d93ef5b5e5c6bff1363e979631e7b1ad6f70aabf745465a95aa002ef", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3373452394e19e01c26cbdd79932bfbc7fd76b40d477885364f4478941a3c3a01dbd0d65fadfc977787b8c89c296c0c44009d473de1e4e64c07418104ab10616"} 08:09:04 INFO - Running post-run listener: copy_logs_to_upload_dir 08:09:04 INFO - Copying logs to upload dir... 08:09:04 INFO - mkdir: /builds/slave/test/build/upload/logs 08:09:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.049967 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-05-30 08:09:04.261351) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-30 08:09:04.265138) ========= 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=0e2a256762fed810e2f0f810000001b3-1464619700.395097-1071734211 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/2c4c12ea1c44d425134e1418e046fb2245b2d508b61ec843ddecb4ad645e086e6601045410032af8caf25e35ad2d0aff9c3308e54af73d36ebe385a82055ec7c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/10c60891cb0e0cca0055f714a5fb7834ad6ecaa32db48f1a0a4452b3dceb7506ed41edf9d93ef5b5e5c6bff1363e979631e7b1ad6f70aabf745465a95aa002ef", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3373452394e19e01c26cbdd79932bfbc7fd76b40d477885364f4478941a3c3a01dbd0d65fadfc977787b8c89c296c0c44009d473de1e4e64c07418104ab10616"} build_url:https://queue.taskcluster.net/v1/task/X_Eve2J4SzS1ECMZh6ZRjw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011479 build_url: 'https://queue.taskcluster.net/v1/task/X_Eve2J4SzS1ECMZh6ZRjw/artifacts/public/build/firefox-49.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/2c4c12ea1c44d425134e1418e046fb2245b2d508b61ec843ddecb4ad645e086e6601045410032af8caf25e35ad2d0aff9c3308e54af73d36ebe385a82055ec7c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/10c60891cb0e0cca0055f714a5fb7834ad6ecaa32db48f1a0a4452b3dceb7506ed41edf9d93ef5b5e5c6bff1363e979631e7b1ad6f70aabf745465a95aa002ef", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3373452394e19e01c26cbdd79932bfbc7fd76b40d477885364f4478941a3c3a01dbd0d65fadfc977787b8c89c296c0c44009d473de1e4e64c07418104ab10616"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-30 08:09:04.290856) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 08:09:04.291184) ========= 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=0e2a256762fed810e2f0f810000001b3-1464619700.395097-1071734211 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004382 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 08:09:04.375029) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-30 08:09:04.375342) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-30 08:09:04.375637) ========= ========= Total master_lag: 0.16 =========