builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-066 starttime: 1464211828.15 results: success (0) buildid: 20160525135343 builduid: 7b118da9cbef4c0daa98c34ea0a5c59e revision: 3531b8206f7051e2286f860e2c449bb5ff7f4a4c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-25 14:30:28.149914) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-25 14:30:28.150386) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-25 14:30:28.150696) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-25 14:30:28.166374) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 14:30:28.166815) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1464211827.826212-1070013129 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-25 14:30:28-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 71.1M=0s 2016-05-25 14:30:28 (71.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.124487 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 14:30:28.307348) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 14:30:28.307722) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1464211827.826212-1070013129 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013835 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 14:30:28.361888) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 14:30:28.362254) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 3531b8206f7051e2286f860e2c449bb5ff7f4a4c --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 3531b8206f7051e2286f860e2c449bb5ff7f4a4c --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=82c74bd3bc9a11c5833d2010000001e6-1464211827.826212-1070013129 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-25 14:30:28,943 truncating revision to first 12 chars 2016-05-25 14:30:28,943 Setting DEBUG logging. 2016-05-25 14:30:28,944 attempt 1/10 2016-05-25 14:30:28,944 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/3531b8206f70?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-25 14:30:29,247 unpacking tar archive at: fx-team-3531b8206f70/testing/mozharness/ program finished with exit code 0 elapsedTime=0.632692 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 14:30:29.009689) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-25 14:30:29.010256) ========= script_repo_revision: 3531b8206f7051e2286f860e2c449bb5ff7f4a4c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-25 14:30:29.010860) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-25 14:30:29.011286) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-25 14:30:29.023231) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-05-25 14:30:29.023740) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=82c74bd3bc9a11c5833d2010000001e6-1464211827.826212-1070013129 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:30:29 INFO - MultiFileLogger online at 20160525 14:30:29 in /builds/slave/test 14:30:29 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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 14:30:29 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:30:29 INFO - {'append_to_log': False, 14:30:29 INFO - 'base_work_dir': '/builds/slave/test', 14:30:29 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 14:30:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:30:29 INFO - 'branch': 'Fx-Team-Non-PGO', 14:30:29 INFO - 'buildbot_json_path': 'buildprops.json', 14:30:29 INFO - 'config_files': ('talos/linux_config.py',), 14:30:29 INFO - 'default_actions': ('clobber', 14:30:29 INFO - 'read-buildbot-config', 14:30:29 INFO - 'download-and-extract', 14:30:29 INFO - 'populate-webroot', 14:30:29 INFO - 'create-virtualenv', 14:30:29 INFO - 'install', 14:30:29 INFO - 'run-tests'), 14:30:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:30:29 INFO - 'download_minidump_stackwalk': True, 14:30:29 INFO - 'download_symbols': 'ondemand', 14:30:29 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:30:29 INFO - 'tooltool.py': '/tools/tooltool.py', 14:30:29 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:30:29 INFO - '/tools/misc-python/virtualenv.py')}, 14:30:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:30:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:30:29 INFO - 'installer_path': 'installer.exe', 14:30:29 INFO - 'log_level': 'info', 14:30:29 INFO - 'log_name': 'talos', 14:30:29 INFO - 'log_to_console': True, 14:30:29 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:30:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:30:29 INFO - 'opt_config_files': (), 14:30:29 INFO - 'pip_index': False, 14:30:29 INFO - 'sps_profile': False, 14:30:29 INFO - 'sps_profile_interval': 0, 14:30:29 INFO - 'suite': 'dromaeojs-e10s', 14:30:29 INFO - 'system_bits': '32', 14:30:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:30:29 INFO - 'title': 'talos-linux64-ix-066', 14:30:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:30:29 INFO - 'use_talos_json': True, 14:30:29 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:30:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:30:29 INFO - 'work_dir': 'build'} 14:30:29 INFO - ##### 14:30:29 INFO - ##### Running clobber step. 14:30:29 INFO - ##### 14:30:29 INFO - Running pre-action listener: _resource_record_pre_action 14:30:29 INFO - Running main action method: clobber 14:30:29 INFO - rmtree: /builds/slave/test/build 14:30:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:30:30 INFO - Running post-action listener: _resource_record_post_action 14:30:30 INFO - ##### 14:30:30 INFO - ##### Finished clobber step (success) 14:30:30 INFO - ##### 14:30:30 INFO - ##### 14:30:30 INFO - ##### Running read-buildbot-config step. 14:30:30 INFO - ##### 14:30:30 INFO - Running pre-action listener: _resource_record_pre_action 14:30:30 INFO - Running main action method: read_buildbot_config 14:30:30 INFO - Using buildbot properties: 14:30:30 INFO - { 14:30:30 INFO - "project": "", 14:30:30 INFO - "product": "firefox", 14:30:30 INFO - "script_repo_revision": "production", 14:30:30 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 14:30:30 INFO - "repository": "", 14:30:30 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 14:30:30 INFO - "buildid": "20160525135343", 14:30:30 INFO - "pgo_build": "False", 14:30:30 INFO - "basedir": "/builds/slave/test", 14:30:30 INFO - "buildnumber": 1306, 14:30:30 INFO - "slavename": "talos-linux64-ix-066", 14:30:30 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 14:30:30 INFO - "platform": "ubuntu64_hw", 14:30:30 INFO - "scheduler": "tests-fx-team-linux64-talos", 14:30:30 INFO - "branch": "fx-team", 14:30:30 INFO - "repo_path": "integration/fx-team", 14:30:30 INFO - "revision": "3531b8206f7051e2286f860e2c449bb5ff7f4a4c", 14:30:30 INFO - "stage_platform": "linux64", 14:30:30 INFO - "builduid": "7b118da9cbef4c0daa98c34ea0a5c59e", 14:30:30 INFO - "slavebuilddir": "test" 14:30:30 INFO - } 14:30:30 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZpuQaJRHT0StAa9eksnCSg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 14:30:30 INFO - Running post-action listener: _resource_record_post_action 14:30:30 INFO - ##### 14:30:30 INFO - ##### Finished read-buildbot-config step (success) 14:30:30 INFO - ##### 14:30:30 INFO - ##### 14:30:30 INFO - ##### Running download-and-extract step. 14:30:30 INFO - ##### 14:30:30 INFO - Running pre-action listener: _resource_record_pre_action 14:30:30 INFO - Running main action method: download_and_extract 14:30:30 INFO - mkdir: /builds/slave/test/build/tests 14:30: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')]} 14:30:30 INFO - https://queue.taskcluster.net/v1/task/ZpuQaJRHT0StAa9eksnCSg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 14:30:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZpuQaJRHT0StAa9eksnCSg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 14:30:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZpuQaJRHT0StAa9eksnCSg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 14:30:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZpuQaJRHT0StAa9eksnCSg/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 14:30:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZpuQaJRHT0StAa9eksnCSg/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 14:30:31 INFO - Downloaded 1361 bytes. 14:30:31 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 14:30:31 INFO - Using the following test package requirements: 14:30:31 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 14:30:31 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:30:31 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:30:31 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:30:31 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:30:31 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:30:31 INFO - u'jsshell-linux-x86_64.zip'], 14:30:31 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:30:31 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:30:31 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 14:30:31 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:30:31 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:30:31 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:30:31 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:30:31 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:30:31 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:30:31 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:30:31 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:30:31 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:30:31 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')]} 14:30:31 INFO - https://queue.taskcluster.net/v1/task/ZpuQaJRHT0StAa9eksnCSg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:30:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZpuQaJRHT0StAa9eksnCSg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:30:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZpuQaJRHT0StAa9eksnCSg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:30:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZpuQaJRHT0StAa9eksnCSg/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 14:30:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZpuQaJRHT0StAa9eksnCSg/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 14:30:32 INFO - Downloaded 22848271 bytes. 14:30:32 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'] 14:30:32 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 14:30:34 INFO - Return code: 0 14:30:34 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 14:30:34 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')]} 14:30:34 INFO - https://queue.taskcluster.net/v1/task/ZpuQaJRHT0StAa9eksnCSg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:30:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZpuQaJRHT0StAa9eksnCSg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:30:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZpuQaJRHT0StAa9eksnCSg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:30:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZpuQaJRHT0StAa9eksnCSg/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 14:30:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZpuQaJRHT0StAa9eksnCSg/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 14:30:35 INFO - Downloaded 22848271 bytes. 14:30:35 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'] 14:30:35 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 14:30:36 INFO - Return code: 0 14:30:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:30:36 INFO - https://queue.taskcluster.net/v1/task/ZpuQaJRHT0StAa9eksnCSg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:30:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZpuQaJRHT0StAa9eksnCSg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 14:30:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZpuQaJRHT0StAa9eksnCSg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 14:30:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZpuQaJRHT0StAa9eksnCSg/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 14:30:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZpuQaJRHT0StAa9eksnCSg/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 14:30:37 INFO - Downloaded 10834034 bytes. 14:30:37 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'] 14:30:37 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 14:30:38 INFO - Return code: 0 14:30: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')]} 14:30:38 INFO - https://queue.taskcluster.net/v1/task/ZpuQaJRHT0StAa9eksnCSg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:30:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZpuQaJRHT0StAa9eksnCSg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:30:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZpuQaJRHT0StAa9eksnCSg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:30:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZpuQaJRHT0StAa9eksnCSg/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 14:30:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZpuQaJRHT0StAa9eksnCSg/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 14:30:39 INFO - Downloaded 54828020 bytes. 14:30:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZpuQaJRHT0StAa9eksnCSg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:30:39 INFO - mkdir: /builds/slave/test/properties 14:30:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:30:39 INFO - Writing to file /builds/slave/test/properties/build_url 14:30:39 INFO - Contents: 14:30:39 INFO - build_url:https://queue.taskcluster.net/v1/task/ZpuQaJRHT0StAa9eksnCSg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:30:40 INFO - Running post-action listener: _resource_record_post_action 14:30:40 INFO - Running post-action listener: set_extra_try_arguments 14:30:40 INFO - ##### 14:30:40 INFO - ##### Finished download-and-extract step (success) 14:30:40 INFO - ##### 14:30:40 INFO - ##### 14:30:40 INFO - ##### Running populate-webroot step. 14:30:40 INFO - ##### 14:30:40 INFO - Running pre-action listener: _resource_record_pre_action 14:30:40 INFO - Running main action method: populate_webroot 14:30:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:30:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:30:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:30:40 INFO - '--tppagecycles', 14:30:40 INFO - '7'], 14:30:40 INFO - 'tests': ['tsvgm']}}, 14:30:40 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:30:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:30:40 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:30:40 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:30:40 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:30:40 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:30:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:30:40 INFO - 'talos_options': ['--disable-e10s'], 14:30:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:30:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:30:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:30:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:30:40 INFO - 'talos_options': ['--disable-e10s'], 14:30:40 INFO - 'tests': ['damp', 'tps']}, 14:30:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:30:40 INFO - 'tests': ['damp', 'tps']}, 14:30:40 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:30:40 INFO - 'tests': ['dromaeo_dom']}, 14:30:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:30:40 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:30:40 INFO - 'tests': ['a11yr', 14:30:40 INFO - 'ts_paint', 14:30:40 INFO - 'tpaint', 14:30:40 INFO - 'sessionrestore', 14:30:40 INFO - 'sessionrestore_no_auto_restore', 14:30:40 INFO - 'tabpaint']}, 14:30:40 INFO - 'other-e10s': {'tests': ['a11yr', 14:30:40 INFO - 'ts_paint', 14:30:40 INFO - 'tpaint', 14:30:40 INFO - 'sessionrestore', 14:30:40 INFO - 'sessionrestore_no_auto_restore', 14:30:40 INFO - 'tabpaint']}, 14:30:40 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:30:40 INFO - 'ts_paint', 14:30:40 INFO - 'tpaint', 14:30:40 INFO - 'sessionrestore', 14:30:40 INFO - 'sessionrestore_no_auto_restore', 14:30:40 INFO - 'tabpaint']}, 14:30:40 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:30:40 INFO - 'ts_paint', 14:30:40 INFO - 'tpaint', 14:30:40 INFO - 'sessionrestore', 14:30:40 INFO - 'sessionrestore_no_auto_restore', 14:30:40 INFO - 'tabpaint']}, 14:30:40 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:30:40 INFO - 'tests': ['a11yr', 14:30:40 INFO - 'ts_paint', 14:30:40 INFO - 'tpaint', 14:30:40 INFO - 'sessionrestore', 14:30:40 INFO - 'sessionrestore_no_auto_restore', 14:30:40 INFO - 'tabpaint']}, 14:30:40 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:30:40 INFO - 'tests': ['a11yr', 14:30:40 INFO - 'ts_paint', 14:30:40 INFO - 'tpaint', 14:30:40 INFO - 'sessionrestore', 14:30:40 INFO - 'sessionrestore_no_auto_restore', 14:30:40 INFO - 'tabpaint']}, 14:30:40 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:30:40 INFO - 'tests': ['tsvgx', 14:30:40 INFO - 'tsvgr_opacity', 14:30:40 INFO - 'tart', 14:30:40 INFO - 'tscrollx', 14:30:40 INFO - 'cart']}, 14:30:40 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:30:40 INFO - 'tsvgr_opacity', 14:30:40 INFO - 'tart', 14:30:40 INFO - 'tscrollx', 14:30:40 INFO - 'cart']}, 14:30:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:30:40 INFO - 'talos_options': ['--disable-e10s'], 14:30:40 INFO - 'tests': ['tp5o']}, 14:30:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:30:40 INFO - 'tests': ['tp5o']}, 14:30:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:30:40 INFO - 'talos_options': ['--disable-e10s', 14:30:40 INFO - '--xperf_path', 14:30:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:30:40 INFO - 'tests': ['tp5n']}, 14:30:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:30:40 INFO - 'talos_options': ['--xperf_path', 14:30:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:30:40 INFO - 'tests': ['tp5n']}}, 14:30:40 INFO - 'talos.zip': {'path': '', 14:30:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:30:40 INFO - Running post-action listener: _resource_record_post_action 14:30:40 INFO - ##### 14:30:40 INFO - ##### Finished populate-webroot step (success) 14:30:40 INFO - ##### 14:30:40 INFO - ##### 14:30:40 INFO - ##### Running create-virtualenv step. 14:30:40 INFO - ##### 14:30:40 INFO - Running pre-action listener: _resource_record_pre_action 14:30:40 INFO - Running main action method: create_virtualenv 14:30:40 INFO - Creating virtualenv /builds/slave/test/build/venv 14:30:40 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 14:30:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:30:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:30:40 INFO - Using real prefix '/usr' 14:30:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:30:41 INFO - Installing distribute.............................................................................................................................................................................................done. 14:30:42 INFO - Installing pip.................done. 14:30:42 INFO - Return code: 0 14:30:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:30:42 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')]} 14:30:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:30:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30:42 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')]} 14:30:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:30:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30:42 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 0x7f65a2666f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24309c0>, '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 0x24318c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2431d50>, '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': '82c74bd3bc9a11c5833d2010000001e6-1464211827.826212-1070013129', '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 14:30:42 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 14:30:43 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 14:30:43 INFO - Using env: {'DISPLAY': ':0', 14:30:43 INFO - 'HOME': '/home/cltbld', 14:30:43 INFO - 'LANG': 'en_US.UTF-8', 14:30:43 INFO - 'LANGUAGE': 'en_US:en', 14:30:43 INFO - 'LOGNAME': 'cltbld', 14:30:43 INFO - 'MAIL': '/var/mail/cltbld', 14:30:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:30:43 INFO - 'MOZ_NO_REMOTE': '1', 14:30:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:30:43 INFO - 'NO_EM_RESTART': '1', 14:30:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:30:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:30:43 INFO - 'PWD': '/builds/slave/test', 14:30:43 INFO - 'SHELL': '/bin/bash', 14:30:43 INFO - 'SHLVL': '1', 14:30:43 INFO - 'TERM': 'linux', 14:30:43 INFO - 'TMOUT': '86400', 14:30:43 INFO - 'USER': 'cltbld', 14:30:43 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1464211827.826212-1070013129', 14:30:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:30:43 INFO - '_': '/tools/buildbot/bin/python'} 14:30:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:30:43 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 14:30:43 INFO - Cleaning up... 14:30:43 INFO - Return code: 0 14:30:43 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:30:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:30:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:30:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:30:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:30:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30:43 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 0x7f65a2666f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24309c0>, '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 0x24318c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2431d50>, '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': '82c74bd3bc9a11c5833d2010000001e6-1464211827.826212-1070013129', '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 14:30:43 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 14:30:43 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 14:30:43 INFO - Using env: {'DISPLAY': ':0', 14:30:43 INFO - 'HOME': '/home/cltbld', 14:30:43 INFO - 'LANG': 'en_US.UTF-8', 14:30:43 INFO - 'LANGUAGE': 'en_US:en', 14:30:43 INFO - 'LOGNAME': 'cltbld', 14:30:43 INFO - 'MAIL': '/var/mail/cltbld', 14:30:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:30:43 INFO - 'MOZ_NO_REMOTE': '1', 14:30:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:30:43 INFO - 'NO_EM_RESTART': '1', 14:30:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:30:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:30:43 INFO - 'PWD': '/builds/slave/test', 14:30:43 INFO - 'SHELL': '/bin/bash', 14:30:43 INFO - 'SHLVL': '1', 14:30:43 INFO - 'TERM': 'linux', 14:30:43 INFO - 'TMOUT': '86400', 14:30:43 INFO - 'USER': 'cltbld', 14:30:43 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1464211827.826212-1070013129', 14:30:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:30:43 INFO - '_': '/tools/buildbot/bin/python'} 14:30:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:30:43 INFO - Downloading/unpacking psutil>=3.1.1 14:30: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 14:30: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 14:30: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 14:30: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 14:30: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 14:30: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 14:30:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:30:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:30:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:30:45 INFO - Installing collected packages: psutil 14:30:45 INFO - Running setup.py install for psutil 14:30:45 INFO - building 'psutil._psutil_linux' extension 14:30:45 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 14:30:45 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 14:30:45 INFO - building 'psutil._psutil_posix' extension 14:30:45 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 14:30:45 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 14:30:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:30:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:30:45 INFO - Successfully installed psutil 14:30:45 INFO - Cleaning up... 14:30:45 INFO - Return code: 0 14:30:45 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:30:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:30:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:30:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:30:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:30:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30:45 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 0x7f65a2666f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24309c0>, '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 0x24318c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2431d50>, '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': '82c74bd3bc9a11c5833d2010000001e6-1464211827.826212-1070013129', '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 14:30:45 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 14:30:45 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 14:30:45 INFO - Using env: {'DISPLAY': ':0', 14:30:45 INFO - 'HOME': '/home/cltbld', 14:30:45 INFO - 'LANG': 'en_US.UTF-8', 14:30:45 INFO - 'LANGUAGE': 'en_US:en', 14:30:45 INFO - 'LOGNAME': 'cltbld', 14:30:45 INFO - 'MAIL': '/var/mail/cltbld', 14:30:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:30:45 INFO - 'MOZ_NO_REMOTE': '1', 14:30:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:30:45 INFO - 'NO_EM_RESTART': '1', 14:30:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:30:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:30:45 INFO - 'PWD': '/builds/slave/test', 14:30:45 INFO - 'SHELL': '/bin/bash', 14:30:45 INFO - 'SHLVL': '1', 14:30:45 INFO - 'TERM': 'linux', 14:30:45 INFO - 'TMOUT': '86400', 14:30:45 INFO - 'USER': 'cltbld', 14:30:45 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1464211827.826212-1070013129', 14:30:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:30:45 INFO - '_': '/tools/buildbot/bin/python'} 14:30:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:30:46 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:30:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:30:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:30:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:30:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:30:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:30:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:30:48 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:30:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:30:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:30:48 INFO - Installing collected packages: mozsystemmonitor 14:30:48 INFO - Running setup.py install for mozsystemmonitor 14:30:48 INFO - Successfully installed mozsystemmonitor 14:30:48 INFO - Cleaning up... 14:30:48 INFO - Return code: 0 14:30:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:30:48 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')]} 14:30:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:30:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30:48 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')]} 14:30:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:30:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30:48 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 0x7f65a2666f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24309c0>, '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 0x24318c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2431d50>, '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': '82c74bd3bc9a11c5833d2010000001e6-1464211827.826212-1070013129', '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 14:30:48 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 14:30:48 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 14:30:48 INFO - Using env: {'DISPLAY': ':0', 14:30:48 INFO - 'HOME': '/home/cltbld', 14:30:48 INFO - 'LANG': 'en_US.UTF-8', 14:30:48 INFO - 'LANGUAGE': 'en_US:en', 14:30:48 INFO - 'LOGNAME': 'cltbld', 14:30:48 INFO - 'MAIL': '/var/mail/cltbld', 14:30:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:30:48 INFO - 'MOZ_NO_REMOTE': '1', 14:30:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:30:48 INFO - 'NO_EM_RESTART': '1', 14:30:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:30:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:30:48 INFO - 'PWD': '/builds/slave/test', 14:30:48 INFO - 'SHELL': '/bin/bash', 14:30:48 INFO - 'SHLVL': '1', 14:30:48 INFO - 'TERM': 'linux', 14:30:48 INFO - 'TMOUT': '86400', 14:30:48 INFO - 'USER': 'cltbld', 14:30:48 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1464211827.826212-1070013129', 14:30:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:30:48 INFO - '_': '/tools/buildbot/bin/python'} 14:30:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:30:48 INFO - Downloading/unpacking blobuploader==1.2.4 14:30:48 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 14:30:48 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 14:30:48 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 14:30:48 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 14:30:48 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 14:30:48 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 14:30:50 INFO - Downloading blobuploader-1.2.4.tar.gz 14:30:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:30:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:30:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:30:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:30:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:30:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:30:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:30:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:30:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:30:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:30:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:30:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:30:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:30:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:30:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:30:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:30:51 INFO - Downloading docopt-0.6.1.tar.gz 14:30:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:30:51 INFO - Installing collected packages: blobuploader, requests, docopt 14:30:51 INFO - Running setup.py install for blobuploader 14:30:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:30:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:30:51 INFO - Running setup.py install for requests 14:30:51 INFO - Running setup.py install for docopt 14:30:51 INFO - Successfully installed blobuploader requests docopt 14:30:51 INFO - Cleaning up... 14:30:51 INFO - Return code: 0 14:30:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:30: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')]} 14:30:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:30:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30: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')]} 14:30:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:30:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30:51 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 0x7f65a2666f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24309c0>, '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 0x24318c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2431d50>, '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': '82c74bd3bc9a11c5833d2010000001e6-1464211827.826212-1070013129', '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 14:30:51 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 14:30:51 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 14:30:51 INFO - Using env: {'DISPLAY': ':0', 14:30:51 INFO - 'HOME': '/home/cltbld', 14:30:51 INFO - 'LANG': 'en_US.UTF-8', 14:30:51 INFO - 'LANGUAGE': 'en_US:en', 14:30:51 INFO - 'LOGNAME': 'cltbld', 14:30:51 INFO - 'MAIL': '/var/mail/cltbld', 14:30:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:30:51 INFO - 'MOZ_NO_REMOTE': '1', 14:30:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:30:51 INFO - 'NO_EM_RESTART': '1', 14:30:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:30:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:30:51 INFO - 'PWD': '/builds/slave/test', 14:30:51 INFO - 'SHELL': '/bin/bash', 14:30:51 INFO - 'SHLVL': '1', 14:30:51 INFO - 'TERM': 'linux', 14:30:51 INFO - 'TMOUT': '86400', 14:30:51 INFO - 'USER': 'cltbld', 14:30:51 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1464211827.826212-1070013129', 14:30:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:30:51 INFO - '_': '/tools/buildbot/bin/python'} 14:30:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:30:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:30:52 INFO - Running setup.py (path:/tmp/pip-ZwZqq7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:30:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:30:52 INFO - Running setup.py (path:/tmp/pip-2c6ovb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:30:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:30:52 INFO - Running setup.py (path:/tmp/pip-tieSoL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:30:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:30:52 INFO - Running setup.py (path:/tmp/pip-x9T3Dd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:30:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:30:52 INFO - Running setup.py (path:/tmp/pip-dZAweM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:30:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:30:52 INFO - Running setup.py (path:/tmp/pip-2IpU3V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:30:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:30:52 INFO - Running setup.py (path:/tmp/pip-WZt8Mp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:30:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:30:52 INFO - Running setup.py (path:/tmp/pip-fjLKDb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:30:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:30:52 INFO - Running setup.py (path:/tmp/pip-C48oqI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:30:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:30:52 INFO - Running setup.py (path:/tmp/pip-CzRE1s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:30:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:30:52 INFO - Running setup.py (path:/tmp/pip-fHtaDZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:30:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:30:52 INFO - Running setup.py (path:/tmp/pip-oKGfA8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:30:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:30:52 INFO - Running setup.py (path:/tmp/pip-Gg2XED-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:30:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:30:52 INFO - Running setup.py (path:/tmp/pip-a18VC5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:30:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:30:53 INFO - Running setup.py (path:/tmp/pip-2NDfjL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:30:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:30:53 INFO - Running setup.py (path:/tmp/pip-1n6WaR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:30:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:30:53 INFO - Running setup.py (path:/tmp/pip-d7cVf4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:30:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:30:53 INFO - Running setup.py install for manifestparser 14:30:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:30:53 INFO - Running setup.py install for mozcrash 14:30:53 INFO - Running setup.py install for mozdebug 14:30:53 INFO - Running setup.py install for mozdevice 14:30:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:30:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:30:53 INFO - Running setup.py install for mozfile 14:30:53 INFO - Running setup.py install for mozhttpd 14:30:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:30:53 INFO - Running setup.py install for mozinfo 14:30:53 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:30:53 INFO - Running setup.py install for mozInstall 14:30:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:30:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:30:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:30:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:30:54 INFO - Running setup.py install for mozleak 14:30:54 INFO - Running setup.py install for mozlog 14:30:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:30:54 INFO - Running setup.py install for moznetwork 14:30:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:30:54 INFO - Running setup.py install for mozprocess 14:30:54 INFO - Running setup.py install for mozprofile 14:30:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:30:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:30:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:30:54 INFO - Running setup.py install for mozrunner 14:30:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:30:54 INFO - Running setup.py install for mozscreenshot 14:30:54 INFO - Running setup.py install for moztest 14:30:54 INFO - Running setup.py install for mozversion 14:30:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:30:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:30:55 INFO - Cleaning up... 14:30:55 INFO - Return code: 0 14:30:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:30:55 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')]} 14:30:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:30:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30:55 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')]} 14:30:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:30:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30:55 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 0x7f65a2666f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24309c0>, '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 0x24318c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2431d50>, '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': '82c74bd3bc9a11c5833d2010000001e6-1464211827.826212-1070013129', '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 14:30:55 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 14:30:55 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 14:30:55 INFO - Using env: {'DISPLAY': ':0', 14:30:55 INFO - 'HOME': '/home/cltbld', 14:30:55 INFO - 'LANG': 'en_US.UTF-8', 14:30:55 INFO - 'LANGUAGE': 'en_US:en', 14:30:55 INFO - 'LOGNAME': 'cltbld', 14:30:55 INFO - 'MAIL': '/var/mail/cltbld', 14:30:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:30:55 INFO - 'MOZ_NO_REMOTE': '1', 14:30:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:30:55 INFO - 'NO_EM_RESTART': '1', 14:30:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:30:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:30:55 INFO - 'PWD': '/builds/slave/test', 14:30:55 INFO - 'SHELL': '/bin/bash', 14:30:55 INFO - 'SHLVL': '1', 14:30:55 INFO - 'TERM': 'linux', 14:30:55 INFO - 'TMOUT': '86400', 14:30:55 INFO - 'USER': 'cltbld', 14:30:55 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1464211827.826212-1070013129', 14:30:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:30:55 INFO - '_': '/tools/buildbot/bin/python'} 14:30:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:30:55 INFO - Running setup.py (path:/tmp/pip-4Ul8D2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:30:55 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)) 14:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:30:55 INFO - Running setup.py (path:/tmp/pip-Ky7MEx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:30:55 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)) 14:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:30:55 INFO - Running setup.py (path:/tmp/pip-ne4u1c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:30:55 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)) 14:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:30:55 INFO - Running setup.py (path:/tmp/pip-XdIhBI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:30:55 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)) 14:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:30:55 INFO - Running setup.py (path:/tmp/pip-huavYP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:30:55 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)) 14:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:30:55 INFO - Running setup.py (path:/tmp/pip-_2Z5Ls-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:30:55 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)) 14:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:30:55 INFO - Running setup.py (path:/tmp/pip-Rzx7lR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:30:55 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)) 14:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:30:55 INFO - Running setup.py (path:/tmp/pip-F835Ts-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:30:55 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)) 14:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:30:55 INFO - Running setup.py (path:/tmp/pip-jdcHKp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:30:55 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)) 14:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:30:55 INFO - Running setup.py (path:/tmp/pip-tc5OQ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:30:55 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)) 14:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:30:55 INFO - Running setup.py (path:/tmp/pip-OUa64k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:30:56 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)) 14:30:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:30:56 INFO - Running setup.py (path:/tmp/pip-GVLH2V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:30:56 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)) 14:30:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:30:56 INFO - Running setup.py (path:/tmp/pip-MrJsP6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:30:56 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)) 14:30:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:30:56 INFO - Running setup.py (path:/tmp/pip-UkPq4T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:30:56 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)) 14:30:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:30:56 INFO - Running setup.py (path:/tmp/pip-uHaVui-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:30:56 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)) 14:30:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:30:56 INFO - Running setup.py (path:/tmp/pip-ovyONR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:30:56 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)) 14:30:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:30:56 INFO - Running setup.py (path:/tmp/pip-wPSgXS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:30:56 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)) 14:30:56 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)) 14:30:56 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)) 14:30:56 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)) 14:30:56 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)) 14:30:56 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)) 14:30:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:30: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 14:30: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 14:30: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 14:30: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 14:30: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 14:30: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 14:30:58 INFO - Downloading blessings-1.6.tar.gz 14:30:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:30:58 INFO - Installing collected packages: blessings 14:30:58 INFO - Running setup.py install for blessings 14:30:58 INFO - Successfully installed blessings 14:30:58 INFO - Cleaning up... 14:30:58 INFO - Return code: 0 14:30:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:30:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:30:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:30:58 INFO - Reading from file tmpfile_stdout 14:30:58 INFO - Current package versions: 14:30:58 INFO - argparse == 1.2.1 14:30:58 INFO - blessings == 1.6 14:30:58 INFO - blobuploader == 1.2.4 14:30:58 INFO - docopt == 0.6.1 14:30:58 INFO - manifestparser == 1.1 14:30:58 INFO - mozInstall == 1.12 14:30:58 INFO - mozcrash == 0.17 14:30:58 INFO - mozdebug == 0.1 14:30:58 INFO - mozdevice == 0.48 14:30:58 INFO - mozfile == 1.2 14:30:58 INFO - mozhttpd == 0.7 14:30:58 INFO - mozinfo == 0.9 14:30:58 INFO - mozleak == 0.1 14:30:58 INFO - mozlog == 3.2 14:30:58 INFO - moznetwork == 0.27 14:30:58 INFO - mozprocess == 0.22 14:30:58 INFO - mozprofile == 0.28 14:30:58 INFO - mozrunner == 6.11 14:30:58 INFO - mozscreenshot == 0.1 14:30:58 INFO - mozsystemmonitor == 0.3 14:30:58 INFO - moztest == 0.7 14:30:58 INFO - mozversion == 1.4 14:30:58 INFO - psutil == 3.1.1 14:30:58 INFO - requests == 1.2.3 14:30:58 INFO - wsgiref == 0.1.2 14:30:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:30:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:30:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:30:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:30:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:30:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30:58 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 0x7f65a2666f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24309c0>, '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 0x24318c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2431d50>, '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': '82c74bd3bc9a11c5833d2010000001e6-1464211827.826212-1070013129', '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 14:30:58 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 14:30:58 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 14:30:58 INFO - Using env: {'DISPLAY': ':0', 14:30:58 INFO - 'HOME': '/home/cltbld', 14:30:58 INFO - 'LANG': 'en_US.UTF-8', 14:30:58 INFO - 'LANGUAGE': 'en_US:en', 14:30:58 INFO - 'LOGNAME': 'cltbld', 14:30:58 INFO - 'MAIL': '/var/mail/cltbld', 14:30:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:30:58 INFO - 'MOZ_NO_REMOTE': '1', 14:30:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:30:58 INFO - 'NO_EM_RESTART': '1', 14:30:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:30:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:30:58 INFO - 'PWD': '/builds/slave/test', 14:30:58 INFO - 'SHELL': '/bin/bash', 14:30:58 INFO - 'SHLVL': '1', 14:30:58 INFO - 'TERM': 'linux', 14:30:58 INFO - 'TMOUT': '86400', 14:30:58 INFO - 'USER': 'cltbld', 14:30:58 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1464211827.826212-1070013129', 14:30:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:30:58 INFO - '_': '/tools/buildbot/bin/python'} 14:30:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:30:59 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)) 14:30:59 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)) 14:30:59 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)) 14:30:59 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)) 14:30:59 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)) 14:30:59 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)) 14:30:59 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)) 14:30:59 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)) 14:30:59 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)) 14:30:59 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)) 14:30:59 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)) 14:30:59 INFO - Cleaning up... 14:30:59 INFO - Return code: 0 14:30:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:30:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:30:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:30:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:30:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:30:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f65a2666f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24309c0>, '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 0x24318c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2431d50>, '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': '82c74bd3bc9a11c5833d2010000001e6-1464211827.826212-1070013129', '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 14:30:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:30:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:30:59 INFO - Using env: {'DISPLAY': ':0', 14:30:59 INFO - 'HOME': '/home/cltbld', 14:30:59 INFO - 'LANG': 'en_US.UTF-8', 14:30:59 INFO - 'LANGUAGE': 'en_US:en', 14:30:59 INFO - 'LOGNAME': 'cltbld', 14:30:59 INFO - 'MAIL': '/var/mail/cltbld', 14:30:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:30:59 INFO - 'MOZ_NO_REMOTE': '1', 14:30:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:30:59 INFO - 'NO_EM_RESTART': '1', 14:30:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:30:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:30:59 INFO - 'PWD': '/builds/slave/test', 14:30:59 INFO - 'SHELL': '/bin/bash', 14:30:59 INFO - 'SHLVL': '1', 14:30:59 INFO - 'TERM': 'linux', 14:30:59 INFO - 'TMOUT': '86400', 14:30:59 INFO - 'USER': 'cltbld', 14:30:59 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1464211827.826212-1070013129', 14:30:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:30:59 INFO - '_': '/tools/buildbot/bin/python'} 14:30:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:30:59 INFO - Downloading/unpacking jsonschema 14:30:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:30:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:30:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:30:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:30:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:30:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:31:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:31:01 INFO - Downloading/unpacking functools32 (from jsonschema) 14:31:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:31:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:31:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:31:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:31:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:31:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:31:01 INFO - Downloading functools32-3.2.3-2.tar.gz 14:31:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:31:01 INFO - warning: no files found matching '*.txt' 14:31:01 INFO - no previously-included directories found matching 'build' 14:31:01 INFO - no previously-included directories found matching 'dist' 14:31:01 INFO - no previously-included directories found matching '.git*' 14:31:01 INFO - Installing collected packages: jsonschema, functools32 14:31:01 INFO - Running setup.py install for functools32 14:31:01 INFO - warning: no files found matching '*.txt' 14:31:01 INFO - no previously-included directories found matching 'build' 14:31:01 INFO - no previously-included directories found matching 'dist' 14:31:01 INFO - no previously-included directories found matching '.git*' 14:31:01 INFO - Successfully installed jsonschema functools32 14:31:01 INFO - Cleaning up... 14:31:01 INFO - Return code: 0 14:31:01 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:31:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:31:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:31:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:31:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:31:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f65a2666f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24309c0>, '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 0x24318c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2431d50>, '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': '82c74bd3bc9a11c5833d2010000001e6-1464211827.826212-1070013129', '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 14:31:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 14:31:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 14:31:01 INFO - Using env: {'DISPLAY': ':0', 14:31:01 INFO - 'HOME': '/home/cltbld', 14:31:01 INFO - 'LANG': 'en_US.UTF-8', 14:31:01 INFO - 'LANGUAGE': 'en_US:en', 14:31:01 INFO - 'LOGNAME': 'cltbld', 14:31:01 INFO - 'MAIL': '/var/mail/cltbld', 14:31:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:31:01 INFO - 'MOZ_NO_REMOTE': '1', 14:31:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:31:01 INFO - 'NO_EM_RESTART': '1', 14:31:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:31:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:31:01 INFO - 'PWD': '/builds/slave/test', 14:31:01 INFO - 'SHELL': '/bin/bash', 14:31:01 INFO - 'SHLVL': '1', 14:31:01 INFO - 'TERM': 'linux', 14:31:01 INFO - 'TMOUT': '86400', 14:31:01 INFO - 'USER': 'cltbld', 14:31:01 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1464211827.826212-1070013129', 14:31:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:31:01 INFO - '_': '/tools/buildbot/bin/python'} 14:31:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:31:01 INFO - Downloading/unpacking flake8 14:31:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:31:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:31:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:31:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:31:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:31:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:31:03 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:31:03 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:31:03 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 14:31:03 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 14:31:03 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 14:31:03 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 14:31:03 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 14:31:03 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 14:31:03 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:31:03 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:31:03 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 14:31:03 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 14:31:03 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 14:31:03 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 14:31:03 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 14:31:03 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 14:31:04 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:31:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:31:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:31:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:31:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:31:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:31:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:31:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:31:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:31:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:31:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:31:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:31:04 INFO - no previously-included directories found matching 'docs/_build' 14:31:04 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:31:04 INFO - Running setup.py install for pep8 14:31:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:31:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:31:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:31:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:31:04 INFO - no previously-included directories found matching 'docs/_build' 14:31:04 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:31:04 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:31:04 INFO - Cleaning up... 14:31:04 INFO - Return code: 0 14:31:04 INFO - Running post-action listener: _resource_record_post_action 14:31:04 INFO - Running post-action listener: _start_resource_monitoring 14:31:04 INFO - Starting resource monitoring. 14:31:04 INFO - ##### 14:31:04 INFO - ##### Finished create-virtualenv step (success) 14:31:04 INFO - ##### 14:31:04 INFO - ##### 14:31:04 INFO - ##### Running install step. 14:31:04 INFO - ##### 14:31:04 INFO - Running pre-action listener: _resource_record_pre_action 14:31:04 INFO - Running main action method: install 14:31:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:31:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:31:04 INFO - Reading from file tmpfile_stdout 14:31:04 INFO - Detecting whether we're running mozinstall >=1.0... 14:31:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:31:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:31:05 INFO - Reading from file tmpfile_stdout 14:31:05 INFO - Output received: 14:31:05 INFO - Usage: mozinstall [options] installer 14:31:05 INFO - Options: 14:31:05 INFO - -h, --help show this help message and exit 14:31:05 INFO - -d DEST, --destination=DEST 14:31:05 INFO - Directory to install application into. [default: 14:31:05 INFO - "/builds/slave/test"] 14:31:05 INFO - --app=APP Application being installed. [default: firefox] 14:31:05 INFO - mkdir: /builds/slave/test/build/application 14:31:05 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'] 14:31:05 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 14:31:20 INFO - Reading from file tmpfile_stdout 14:31:20 INFO - Output received: 14:31:20 INFO - /builds/slave/test/build/application/firefox/firefox 14:31:20 INFO - Running post-action listener: _resource_record_post_action 14:31:20 INFO - ##### 14:31:20 INFO - ##### Finished install step (success) 14:31:20 INFO - ##### 14:31:20 INFO - ##### 14:31:20 INFO - ##### Running run-tests step. 14:31:20 INFO - ##### 14:31:20 INFO - Running pre-action listener: _resource_record_pre_action 14:31:20 INFO - Running main action method: run_tests 14:31:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:31:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:31:20 INFO - Python 2.7.3 14:31:20 INFO - Return code: 0 14:31:20 INFO - grabbing minidump binary from tooltool 14:31:20 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')]} 14:31:20 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 0x24309c0>, '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 0x24318c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2431d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:31:20 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 14:31:20 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 14:31:20 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 14:31:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:31:20 INFO - Return code: 0 14:31:20 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:31:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:31:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:31:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:31:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:31:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:31:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:31:21 INFO - Return code: 0 14:31:21 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZpuQaJRHT0StAa9eksnCSg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 14:31:21 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ZpuQaJRHT0StAa9eksnCSg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-066 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 14:31:21 INFO - Using env: {'DISPLAY': ':0', 14:31:21 INFO - 'HOME': '/home/cltbld', 14:31:21 INFO - 'LANG': 'en_US.UTF-8', 14:31:21 INFO - 'LANGUAGE': 'en_US:en', 14:31:21 INFO - 'LOGNAME': 'cltbld', 14:31:21 INFO - 'MAIL': '/var/mail/cltbld', 14:31:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:31:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:31:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:31:21 INFO - 'MOZ_NO_REMOTE': '1', 14:31:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:31:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:31:21 INFO - 'NO_EM_RESTART': '1', 14:31:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:31:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:31:21 INFO - 'PWD': '/builds/slave/test', 14:31:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:31:21 INFO - 'SHELL': '/bin/bash', 14:31:21 INFO - 'SHLVL': '1', 14:31:21 INFO - 'TERM': 'linux', 14:31:21 INFO - 'TMOUT': '86400', 14:31:21 INFO - 'USER': 'cltbld', 14:31:21 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1464211827.826212-1070013129', 14:31:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:31:21 INFO - '_': '/tools/buildbot/bin/python'} 14:31:21 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZpuQaJRHT0StAa9eksnCSg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 14:31:22 INFO - mozversion application_buildid: 20160525135343 14:31:22 INFO - mozversion application_changeset: 3531b8206f7051e2286f860e2c449bb5ff7f4a4c 14:31:22 INFO - mozversion application_display_name: Nightly 14:31:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:31:22 INFO - mozversion application_name: Firefox 14:31:22 INFO - mozversion application_remotingname: firefox 14:31:22 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:31:22 INFO - mozversion application_vendor: Mozilla 14:31:22 INFO - mozversion application_version: 49.0a1 14:31:22 INFO - mozversion platform_buildid: 20160525135343 14:31:22 INFO - mozversion platform_changeset: 3531b8206f7051e2286f860e2c449bb5ff7f4a4c 14:31:22 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:31:22 INFO - mozversion platform_version: 49.0a1 14:31:22 INFO - using testdate: 1464211882 14:31:22 INFO - actual date: 1464211882 14:31:22 INFO - starting webserver on 'localhost:44435' 14:31:22 INFO - SUITE-START | Running 2 tests 14:31:22 INFO - TEST-START | dromaeo_css 14:31:22 INFO - operating with platform_type : linux_ 14:31:22 INFO - Initialising browser for dromaeo_css test... 14:31:22 INFO - TEST-INFO | started process 23875 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiOSBET/profile http://localhost:44435/getInfo.html) 14:31:26 INFO - PROCESS | 23875 | 14:31:26 INFO - PROCESS | 23875 | (process:23941): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 14:31:27 INFO - PROCESS | 23875 | __metrics Screen width/height:1600/1200 14:31:27 INFO - PROCESS | 23875 | colorDepth:24 14:31:27 INFO - PROCESS | 23875 | Browser inner width/height: 1024/697 14:31:27 INFO - PROCESS | 23875 | __metrics 14:31:28 ERROR - PROCESS | 23875 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 14:31:28 INFO - TEST-INFO | 23875: exit 0 14:31:28 INFO - Browser initialized. 14:31:28 INFO - Running cycle 1/1 for dromaeo_css test... 14:31:28 INFO - TEST-INFO | started process 23992 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiOSBET/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:31:30 INFO - PROCESS | 23992 | 14:31:30 INFO - PROCESS | 23992 | (process:24051): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 14:31:40 INFO - PROCESS | 23992 | RSS: Main: 167469056 14:31:40 INFO - PROCESS | 23992 | 14:32:30 INFO - PROCESS | 23992 | 1464211950608 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] 14:34:42 INFO - PROCESS | 23992 | Cycle 1(1): loaded http://localhost:44435/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44435/tests/dromaeo/cssquery-ext.html) 14:34:43 INFO - PROCESS | 23992 | RSS: Main: 170172416 14:34:43 INFO - PROCESS | 23992 | 14:37:45 INFO - PROCESS | 23992 | Cycle 1(1): loaded http://localhost:44435/tests/dromaeo/cssquery-ext.html (next: http://localhost:44435/tests/dromaeo/cssquery-jquery.html) 14:37:45 INFO - PROCESS | 23992 | RSS: Main: 169377792 14:37:45 INFO - PROCESS | 23992 | 14:40:47 INFO - PROCESS | 23992 | Cycle 1(1): loaded http://localhost:44435/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44435/tests/dromaeo/cssquery-mootools.html) 14:40:48 INFO - PROCESS | 23992 | RSS: Main: 170254336 14:40:48 INFO - PROCESS | 23992 | 14:43:50 INFO - PROCESS | 23992 | Cycle 1(1): loaded http://localhost:44435/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44435/tests/dromaeo/cssquery-prototype.html) 14:43:50 INFO - PROCESS | 23992 | RSS: Main: 168529920 14:43:50 INFO - PROCESS | 23992 | 14:46:53 INFO - PROCESS | 23992 | Cycle 1(1): loaded http://localhost:44435/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44435/tests/dromaeo/cssquery-yui.html) 14:46:54 INFO - PROCESS | 23992 | RSS: Main: 169639936 14:46:54 INFO - PROCESS | 23992 | 14:49:56 INFO - PROCESS | 23992 | Cycle 1(1): loaded http://localhost:44435/tests/dromaeo/cssquery-yui.html (next: http://localhost:44435/tests/dromaeo/cssquery-dojo.html) 14:49:56 INFO - PROCESS | 23992 | RSS: Main: 171446272 14:49:56 INFO - PROCESS | 23992 | 14:49:56 INFO - PROCESS | 23992 | __start_tp_report 14:49:56 INFO - PROCESS | 23992 | _x_x_mozilla_page_load 14:49:56 INFO - PROCESS | 23992 | _x_x_mozilla_page_load_details 14:49:56 INFO - PROCESS | 23992 | |i|pagename|runs| 14:49:56 INFO - PROCESS | 23992 | |0;dojo.html;2656.62807206991;2694.6496955395796;2697.568389057751;2713.375923537585;2730.5221586222406;4672.275797251423;4683.672142949995;4712.5994290485305;4741.288806679;4774.997250577383;4611.446626404836;4715.3162791395225;4728.385309909716;4739.028499157673;4805.567498925096;4304.784760761957;4379.146066517031;4438.245498265303;4463.665225108113;4483.6861419700635;640.8059415077207;4307.353896915456;4400.955990440103;4405.339199120125;4431.601155895969;4336.783160841946;4339.414179085815;4349.347597860315;4359.04101097758;4380.518143004283;4247.171801498709;4346.326319420495;4349.369341445505;4388.078503514266;4425.513193548707;4287.2711639021445;4294.957050429487;4295.033617436052;4322.913541729179;4392.956070439319;4591.770411479446;4606.332081848113;4623.02916387559;4632.583067523905;4690.132325519789;5030.773615187325;5033.924491132636;5053.140966035746;5060.696358218482;5064.746762661852;5136.43499215086;5141.203113517411;5144.742762861842;5162.6128040397125;5170.017696637627;4779.808807647724;4780.187368147389;4800.73595952219;4819.662623616313;4851.830185943475;5082.923756143661;5235.4502777207845;5246.31797866275;5252.763625636855;5307.150855863043;5022.196448568212;5026.572741316956;5030;5041.924371134436;5095.286659867622;5111.463296353903;5114.846554603368;5125.56432703217;5133.486651334837;5139.203423469368;4919.950800491949;5006.599472042228;5083.034223497523;5084.720340381241;5098.770555325019;4801.087793319258;5038.143515602356;5041.495850414929;5077.26379674945;5102.974485127625;4281.336392859112;4298.075913678574;4299.290617048152;4332.1985432695055;4342.240107981153;3650.233450975272;3661.7436779425184;3666.211764470598;3689.760165589228;3703.870364537282;4521.909561808746;4522.86928267933;4535.024969631545;4559.52125026874;4575.3823233863;5149.871253218625;5156.793728250903;5169.4830516948;5177.974110129425;5233.738313084406;4384.364267181305;4459.576340247671;4482.910341793211;4493.1013797240685;4512.5261847505535;4557.840475583339;4560.794764235618;4579.290210017452;4579.564941330568;4646.465656449484;4749;4799.256115302133;4816.34979277807;4828.227483602747;4849;4909.214525675875;5064.139096353702;5114.795408183631;5126.051680439131;5149.948500514947;4818.494058123846;4825.420949486084;4833.419989601271;4852.466228714909;4873.049755297825;4963.982383611423;5083.974580127076;5087.465816089405;5096.0827051131155;5145.279660847409;5107.41264754558;5117.5905927526455;5154.175331947021;5157;5175.508326708957;5014.122528557561;5017.448080711192;5022.347094877642;5025.195968644999;5094.923576146287;4846.781894814671;4900.95099049005;5008.799648014038;5022.146235139962;5029.396472423333;4811.663183577116;4835.032993401404;4884.78018489176;4894.730789806595;4969.378827646544;5015.1223535880345;5016.824411145592;5020.899582008413;5027.245913112916;5055.140626093499;4870.537298956593;4916.9754151230445;4921.803127874845;4926.802927882844;4933.087378834927 14:49:56 INFO - PROCESS | 23992 | |1;ext.html;543.4161939929195;555.3446932619507;579.1631093070513;594.8839976204639;599.5263741644102;39954.800225998864;41253.79373103131;41325.79337103318;41340.37989430161;45467.31799023009;42226.36660450088;42766.78616606913;42906.14187716252;42914;42924;7796.41526885483;7902.367810575169;7944.404169687267;7963.283304502594;7976.6809327626825;7671.194524574923;7794.610269486531;7819.100803407596;7844.882326765103;7895.60521973899;7832.647530861125;7832.686692532292;7882;7886.526808391515;7899.644515996794;7797.181295963927;7804.960975195145;7857.960710196441;7878.72424465141;7878.921210787933;7675.424343174284;7790.610469476504;7791.0650721913735;7796.064472263308;7808.492447990862;39999.600003999876;40240.396394054114;40258.59741402607;40333.19333613341;40436;3006.8195908245575;3235.71819221401;3248.204189973472;3323.202431416467;3333.983330083334;29204.8539757302;30063.248418789706;30098;30182.396352073054;30974.22564435907;3232.2242661761243;3533.575970883485;3575.5173051637958;3612.6567976042497;3701.2967536168044;271927;274692;274861;275628;276225;57126.42873571294;57186.7140664294;57400.71299643475;57429.42570574324;57690.711546442835;33662.158446039044;34174;34342.14144646404;36360.818195908854;36594.8170259147;14633.707325853424;14837.851621483647;14895.329710163069;14926.850731492546;14954;11073.557057717762;11252.606158784403;11336.886631133582;11337.773244535063;11359.091272698164;18883;18961.620767584573;19029.048547572565;19029.238830446902;19041.238350465825;6950.8609827804175;6986.9650651746415;7255.8911616325795;7281.817954551073;7340.30267124633;835.778518692547;894.3650008493912;970.5438443931341;975.6536429567543;991.1872264742985;28061.43877122446;28835.56746648802;28866.567001494994;28954.565681514796;29371.55942660862;941.049539964627;974.4202199691173;992.7468495533593;1049.8504486540378;1050.0601961244643;14407.42370305176;14928.463012267168;14974.176420296988;15298.158601276815;15313.770293445607;389604;391321;392950;393595;393973.0602693994;50836.74581627068;51520.74239628778;51527.74236128795;51549.226761598606;51554.74222628938;1039.3815679670583;1041.047441590951;1068.6206396729206;1073.9892601074046;1153.763478486908;26510.204693859214;27548.862255688593;27628;27878.30304242329;28037.71962280351;42862.14275714406;42865.14269714526;42896.35655465233;43202;43353.783231083646;330640;331210;332212;332287;333585;25470.872645636653;25609.87195064013;26088.73911260863;26209.4758104833;26280.4743905117;39663.2067358657;42645.14709705851;43746.781266093465;43829.56170438255;44090.779546102065;36112.27775444529;37024.81487592545;37469.250614988094;37492.81253593715;37700.81149594344;36674.633253667125;36911.26177476489;36997.81501092585;37106.25787484289;37156.814215928745;32334.35331293314;35671.82164089163;36562.26875462422;39574.40638390369;40064;32456;34163.48754768631;34365.828170858986;34412;34432.48351274783;25663.230103096936;25804.35489112787;25949.481010380063;26028.34929126787;26291.73708262893 14:49:56 INFO - PROCESS | 23992 | |2;jquery.html;341.5474496292413;354.64712610952097;358.6252366277242;361.3351433362616;365.3241503219045;15578.766318505232;16036.43872464464;17264.309427622913;17309.307627694892;17349.39277125301;14675.89930755195;14805.185714785683;15195.088294702326;15289;15297.388104475807;4829.058333624945;4903.485134060926;5030.974845125769;5054.79780808769;5064.1390963536105;3615.132368231632;5000.824971126011;5553.305836770403;5821.0104282271905;5829.475347218749;5795.362510123883;5834.21238132853;5850.180974663551;5853.648781073128;5861.912071318934;5608.831735047955;5862.091375836731;5925.822225333204;5933.525317974551;5939.613925094876;4531.478879928784;5116.104681680728;5119.104156772587;5126.307948426952;5157.8452646420665;11279.097672186206;11605.245659032136;11741.530338786439;11773.234739741889;11776.05791536675;1793.973090403645;1845.575517630939;1918.2902326139279;1925.913333899978;2035.552178520738;8341.124181960868;8701.825963480758;8739.60671769772;8909.465432074096;8918.955405222998;1732.8180541043262;1742.651469706051;1785.8303461171167;1793.390247315919;1809.5023868436285;69055.30944690539;69459.65270173617;70355.64822175908;70854.64572677155;71277;8983.203359328161;9072.95463522678;9158.771030724285;9265.953670231605;9558.952205239068;11747.941260293645;11866.584669536525;11882.940585297018;11897.702557436134;11925.522979080914;6340.207474065742;6434.292227854932;6502.967485162544;6606.669666516655;6609.471242300604;6193.163922870445;6244.2819075805955;6304.432601065926;6401.07184458251;6424.582402143846;3708.2212735325884;3718.884334699579;3751.2685026419585;3768.1333293342686;3778.4521244419407;1521.3990473762801;1567.4827306988666;1665.3088968078355;1669.9415520456726;1689.518487231158;384.25646374265887;387.0980615166655;400.3574263307408;853.7268074216315;867.7093173786852;9903.306768526134;10010.349327293703;10057.547410366406;10085.949570252249;10305.742356440998;387.62981352808;390.8827351794507;393.78341911948314;399.67027202558006;406.778305823327;5455.699936503531;5504.724763761796;5508.283923089973;5564.944350556523;5565.081761509306;390185;390765;393475;413699;416629;79386;79439;80543.59728201438;81492;82221;397.06293148170295;403.8848928055549;404.5590306565857;406.35592585751914;407.81852075826566;8977.326700497359;9089.909100908906;9166.954165229132;9246.936602290823;9538.23694104484;33300.500492492145;34812.651873481955;35028;35840;36440;47802.760986194844;50803.74598126986;52793.472065280395;53408.73295633497;53668;7320.1215854097845;7496.7750967471065;7618.69525218985;7631.321109355933;7852.489588176751;8373.832523349378;10554;10957.123430125412;11570.826437603275;11720.413979301171;9874.901250987397;9936.701898943043;9961.203103751537;10062.144717699077;10170.08469237772;10349.430781307101;10435.739106522398;10505.054545090978;10528.473576321307;10672.733181670521;9777.608895644094;9890.159336456481;10170.644027459004;10256.07695307426;10375.273730839072;7305.452091093083;7341.889871652036;7369.336759691653;7392.741254056083;7415.2214017527385;8583.65665373378;9589;9687.564059617192;9849.162821160282;9880.604775809175 14:49:56 INFO - PROCESS | 23992 | |3;mootools.html;1416.8087308213392;1453.3387308774506;1565.2643257668892;1721.182438341787;1736.531136593119;6814.897776533344;7390.741324053659;7434.293742094499;7890.92109078909;7935.285824275821;7513.060867391576;7693.076830780315;7725.92274077259;7746.612669366537;7815.062192536903;2188.474766056147;2233.4528040630066;2239.9552008959813;2244.259394399844;2245.8427910046303;2174.836887233464;2202.48241663209;2217.2018073493527;2218.92233771818;2223.4663680716594;2182.5743979923923;2191.079746506471;2191.3535507025467;2197.8791166485835;2233.2853486884123;2096.2453516733963;2104.947376315589;2106.610277098742;2106.6629339305637;2110.915563377471;2108.599366120432;2152.2359562355296;2169.609470295346;2172.8261739060836;2173.4566358410398;7665.540067595962;7683.57740324282;7697.384209263301;7716.151223365426;7735.4585179037485;4151.6886233532305;4176.812043458051;4205.3271476563605;4298.118885628439;4310.4396428464415;2862.942741145186;2942.5439056945993;2993.625796775403;3022.9395412091635;3024.879004839826;866.9566521673954;891.5720454181965;917.9632814687404;959.8320293948601;972.4748635736764;10327.173826093895;10425.218108641806;10474.371537707762;10509.684709458728;10525.473726313654;4063.756174629532;4078.775667338325;4082.795860206978;4118.567550407164;4182.769947652909;8330.291925186306;8338.458000229966;8343.8331233375;8355.665773368997;8360.28937540316;4295;4296.0548679290505;4304.849330273488;4304.892377690583;4306.354046892991;3265.167382317494;3718.0890681783135;3810.7713537187856;3829.789361585084;3875.418687196943;3360.1599600099976;3399.473081672345;3441.5181874537584;3462.563036339891;3610.6389361063684;1016.2581315639625;1047.3820445936933;1050.5745173204864;1054.093479607537;1056.1920131099714;651.2250421997808;766.9808254793563;768.0974854545998;786.3276898252027;789.7551758954743;5025.271335656309;5048.646594738333;5084.56781173597;5139.023585518814;5171.896562068813;382.15543648537044;390.35786131813006;395.5787086752599;395.94456776051373;398.1698159337755;3356.429407000767;3375.8312084395684;3376.9493457598155;3459.8270086496077;3465.081753335368;8867.955660221787;9066.682666106655;9117.498537580364;9124.95437522808;9139.95430022859;8941.552922353856;8962.283017358595;9048.909510904938;9137.451752894847;9197.63209471627;6997.615131167835;7149.070620819364;7149.714011439588;7158.749443769443;7162.606056666829;5078.441371449211;5123.743812809419;5136.280920671034;5290;5314.946850531445;8431.747047588582;8470.152984701726;8483.787905302417;8502.362322825937;8600.22597966186;8428.620712067848;8500.107488713844;8799.20807127336;8856.955715221382;8880.86678699807;5483.424240454695;5872.412758724094;6034.939650603438;6073.726682299395;6131.202943617302;7314.561126332437;7337.669804858688;7349.118105827335;7351.595662238628;7372.778816635509;6352.618842869442;6480.70836812354;6513.576617519846;6518.804435866931;6591.8022459324375;6276.811695649138;6507.219133703986;6539.967300163468;6703.262641109376;6718.39534441883;5957.136215248678;6076.8784624308155;6100.8779824404155;6123.2652081750475;6169.660668663267;4297.54875738043;4370.0822827205375;4371.606555410029;4448.510663826912;4461.81761833108;4503.144402563503;4511.819527218874;4518.277075667877;4543.568361005699;4583.702059366131 14:49:56 INFO - PROCESS | 23992 | |4;prototype.html;288.6709151567213;290.79063074586304;291.04682165906655;299.63294963669495;300.16404313985555;4940.703557786535;4956.752162391875;4958.900821983558;4979.35268415106;4989.975050124749;4882.121218180726;4896.436909755379;4910.361652985107;4924.261360795874;4952;3632.5096112024935;3686.5576130864333;3804.9239015219678;3815.988762977813;3839.404892241707;3768.171002379472;3799.7530160539477;3803.201327721168;3806.7715937043868;3824.3498605237037;3774.301754175486;3782.3948168293077;3809.1048603578274;3816.637419445148;3822.636849499307;3538.3454060998797;3751.3247615429214;3834.7123965702544;3842.731008829383;3844.692424606025;3208.6951739584933;3219.7907136036083;3221.8240342275135;3228;3230.047136094834;4669.813207471697;4686.297055441677;4689.20283551797;4694.436667599875;4709.458412282563;4254.361845723135;4267.91464170718;4269.893252668677;4272.487301523837;4290.914181716348;5004.84985450437;5034.4713805050305;5064.088464076464;5070.084701296769;5080.542751152377;3494.493298471733;3499.2476617527354;3509.3332266869215;3532.894013179609;3534.964650353489;5416.593755468356;5416.945830541684;5430.212619170237;5432.6740395576;5438.891222175574;3382.712469440125;3617.692496137805;3624.873129440457;3625;3638.6725194732603;3661.761985470936;3693.4275187346007;3693.5041308270193;3697.371446854041;3699.038250055005;4278.379634952977;4299.634531064832;4306.547812479707;4327.545607711208;4331.805068771912;4987.501249875056;5160.845174644766;5239.266502689627;5241.659292145999;5247.9737601311745;1258.5091814192472;1264.7913094339515;1276.1131013945405;1279.7969908286182;1280.788669869461;776.1578687124534;782.8296696438861;786.8865555239272;798.6565776716068;822.3174764945081;4484.663650226246;4613.700109492872;4626.1904166771355;4633.930491042637;4648.372469716545;5313.210564453692;5360.410354860962;5370.650907690988;5387.488188622075;5388.817528900801;4525.058711837332;4623.16782979067;4641.814327426865;4650.790714417859;4651.232546629836;2802.8178168418985;2861.327588016856;2866.7276608722136;2867.856607169675;2877.5395936650034;5020.93722829074;5051.242313652908;5056.609432406118;5056.64603477753;5070.746462676925;5218.425973142951;5451.972740136353;5487.451254874481;5511.751971161308;5532.944670553324;5004.749762511859;5053.8736531587;5064.316317297192;5067.037262920034;5080.822171223989;5387.81142660005;5430.5384042356845;5436.8640783979135;5454.509094181542;5474.616776825584;5147.58819294448;5234.895302094013;5268.130758424817;5285.312909321764;5312.7343632818975;5060.139776237975;5064.8987020258655;5071.518205770446;5083.745812709423;5084.745762711924;3646.7994260315936;3661.7114303560274;3672.2556785526663;3683.705303575654;3691.966249450158;5116.820911268088;5362.222477740628;5420.7560659769615;5421.349438067457;5426.972865135649;5179.896402071862;5215.191645294985;5215.426303106731;5232.869178270422;5242.868928276824;5209.01028804526;5217.895642087213;5245.265662807134;5259.554307247148;5271.578273738169;4892.535209155125;5162.683515703471;5168.8449346519665;5168.896622067613;5172.456892026283;5030.346055012971;5124.769385377593;5258.106121959353;5269.28864603289;5272.813616936159;5172.439642377048;5176.741162941763;5181.637285389987;5212.478752124757;5212.765425555935 14:49:56 INFO - PROCESS | 23992 | |5;yui.html;675.5845155229532;688.4182865478671;737.4432303610773;747.0363231431458;755.6372940988329;12428.254304741711;12555.811662825054;13021.804672929902;13181.538646147386;13613.659658508543;13615.183089014667;13672.384742686578;13697.794533082011;13714.519991800289;13782.931085344559;623.3143542103672;788.8382881509277;792.3938187286716;798.5727635714894;799.940004499662;799.7880561651167;803.9839203215932;805.9435839491238;806.4717609965453;807.019471342319;843.9831203375929;846.2806614377791;846.9449485783435;848.3340577646549;848.3764433141636;839.2740279658052;841.3311417423103;844.7972486603232;844.9408541402073;845.4546817302836;613.6563524426335;613.7054213977272;617.5461036138435;617.8764247150588;618.2179542878263;12319;12320.938395307967;12326.137170398075;12348.38258087092;12350.876491235062;11787.823182652268;11940.582079627258;11960.880391196064;12142.757144857142;12374.62876113718;9529.952350238274;9933.552990115462;9980.550875210633;10083.294169408144;10147.188224941987;3244.7034841723;3340.7494437917253;3365.4951757236367;3370.4438767603315;3373.5614370131725;47271.29093063607;47486.762566187295;47583.28625070627;47877.04245915097;47953.76023119862;8885.111488851064;8904.243139333099;9091.636334546543;9242.260619150451;9256.629734810533;17104.40134595308;17299.221535030953;17302.480925572254;17331.393401230896;17360.305587776347;6479;6753.932460675429;6772.390484856386;6782.8304292392095;6950.20072691647;3623.6478186789386;3638.9272214555563;3683.4658974448553;3818.1218319786603;3863.8068096595057;2793.8184018038764;2911.4322707072342;2919.357741296911;2934.8679309431127;2935.163478408643;477.0649526927192;482.351237585447;488.68479830509835;497.219365596018;501.0305059709474;451.86895800218224;457.6024405463493;494.21913376864467;499.2311839766791;512.910240707882;7526.887096693554;7601.239876012465;7665.386769058462;7678.347340476123;7843.294103530709;416.895776055986;426.20725450661746;500.62703286051396;511.8490045436605;520.3859445853928;3627.147620309225;3650.653187947141;3699.352613292663;3705.370087085202;3749.0252534341266;60560;61198.38801612016;61492;62173.37826621676;62640;55566.44433555612;55700.72149639307;55911.44088559144;56486.717566411906;57344.71327643335;50840.237396438344;51375;51393.486065139616;51660.22509662358;53011.73494132505;7061.399781018671;7072;7253.347198751927;7262.709491620276;7334.156571994289;33107.50338744873;33531.66468335383;33979.4903076459;34200.65799341975;34599.481007785405;42322.57677423309;44153.33769993389;44432;44863.10273794571;45527.08945821131;9439;9439.858402124111;9497.47763872966;9499.192568631745;9527.333086683866;10128.189744820544;10538.894611054098;10770.192235582206;10807.35155890649;10913.672589822318;9570.665026724031;9585.281103917094;9622.566984485575;9738.415695058036;9996.07977411558;9460.432374057578;9461.574229159567;9524.142827145313;9616.471094089893;9752.024797520191;9329.440233586007;9566.808663826545;9629.422234665943;9675.564599593175;10277.177825773771;8311.750647480585;8511.574421279036;8516.403851730567;8664.220220179963;8812.383133180872;8676.089010654043;9158.542072896194;9215.170634642915;9258.53707314645;9462.763430914281 14:49:56 INFO - PROCESS | 23992 | __end_tp_report 14:49:56 INFO - PROCESS | 23992 | __start_cc_report 14:49:56 INFO - PROCESS | 23992 | _x_x_mozilla_cycle_collect,388 14:49:56 INFO - PROCESS | 23992 | __end_cc_report 14:49:56 INFO - PROCESS | 23992 | __startTimestamp1464212996936__endTimestamp 14:49:56 INFO - PROCESS | 23992 | 14:49:56 INFO - PROCESS | 23992 | ------- Summary: start ------- 14:49:56 INFO - PROCESS | 23992 | Number of tests: 6 14:49:56 INFO - PROCESS | 23992 | 14:49:56 INFO - PROCESS | 23992 | [#0] dojo.html Cycles:165 Average:4690.94 Median:4835.03 stddev:590.62 (12.2%) stddev-sans-first:570.47 14:49:56 INFO - PROCESS | 23992 | Values: 2656.6 2694.6 2697.6 2713.4 2730.5 4672.3 4683.7 4712.6 4741.3 4775.0 4611.4 4715.3 4728.4 4739.0 4805.6 4304.8 4379.1 4438.2 4463.7 4483.7 640.8 4307.4 4401.0 4405.3 4431.6 4336.8 4339.4 4349.3 4359.0 4380.5 4247.2 4346.3 4349.4 4388.1 4425.5 4287.3 4295.0 4295.0 4322.9 4393.0 4591.8 4606.3 4623.0 4632.6 4690.1 5030.8 5033.9 5053.1 5060.7 5064.7 5136.4 5141.2 5144.7 5162.6 5170.0 4779.8 4780.2 4800.7 4819.7 4851.8 5082.9 5235.5 5246.3 5252.8 5307.2 5022.2 5026.6 5030.0 5041.9 5095.3 5111.5 5114.8 5125.6 5133.5 5139.2 4920.0 5006.6 5083.0 5084.7 5098.8 4801.1 5038.1 5041.5 5077.3 5103.0 4281.3 4298.1 4299.3 4332.2 4342.2 3650.2 3661.7 3666.2 3689.8 3703.9 4521.9 4522.9 4535.0 4559.5 4575.4 5149.9 5156.8 5169.5 5178.0 5233.7 4384.4 4459.6 4482.9 4493.1 4512.5 4557.8 4560.8 4579.3 4579.6 4646.5 4749.0 4799.3 4816.3 4828.2 4849.0 4909.2 5064.1 5114.8 5126.1 5149.9 4818.5 4825.4 4833.4 4852.5 4873.0 4964.0 5084.0 5087.5 5096.1 5145.3 5107.4 5117.6 5154.2 5157.0 5175.5 5014.1 5017.4 5022.3 5025.2 5094.9 4846.8 4901.0 5008.8 5022.1 5029.4 4811.7 4835.0 4884.8 4894.7 4969.4 5015.1 5016.8 5020.9 5027.2 5055.1 4870.5 4917.0 4921.8 4926.8 4933.1 14:49:56 INFO - PROCESS | 23992 | 14:49:56 INFO - PROCESS | 23992 | [#1] ext.html Cycles:180 Average:48708.35 Median:37131.54 stddev:88535.70 (238.4%) stddev-sans-first:88710.21 14:49:56 INFO - PROCESS | 23992 | Values: 543.4 555.3 579.2 594.9 599.5 39954.8 41253.8 41325.8 41340.4 45467.3 42226.4 42766.8 42906.1 42914.0 42924.0 7796.4 7902.4 7944.4 7963.3 7976.7 7671.2 7794.6 7819.1 7844.9 7895.6 7832.6 7832.7 7882.0 7886.5 7899.6 7797.2 7805.0 7858.0 7878.7 7878.9 7675.4 7790.6 7791.1 7796.1 7808.5 39999.6 40240.4 40258.6 40333.2 40436.0 3006.8 3235.7 3248.2 3323.2 3334.0 29204.9 30063.2 30098.0 30182.4 30974.2 3232.2 3533.6 3575.5 3612.7 3701.3 271927.0 274692.0 274861.0 275628.0 276225.0 57126.4 57186.7 57400.7 57429.4 57690.7 33662.2 34174.0 34342.1 36360.8 36594.8 14633.7 14837.9 14895.3 14926.9 14954.0 11073.6 11252.6 11336.9 11337.8 11359.1 18883.0 18961.6 19029.0 19029.2 19041.2 6950.9 6987.0 7255.9 7281.8 7340.3 835.8 894.4 970.5 975.7 991.2 28061.4 28835.6 28866.6 28954.6 29371.6 941.0 974.4 992.7 1049.9 1050.1 14407.4 14928.5 14974.2 15298.2 15313.8 389604.0 391321.0 392950.0 393595.0 393973.1 50836.7 51520.7 51527.7 51549.2 51554.7 1039.4 1041.0 1068.6 1074.0 1153.8 26510.2 27548.9 27628.0 27878.3 28037.7 42862.1 42865.1 42896.4 43202.0 43353.8 330640.0 331210.0 332212.0 332287.0 333585.0 25470.9 25609.9 26088.7 26209.5 26280.5 39663.2 42645.1 43746.8 43829.6 44090.8 36112.3 37024.8 37469.3 37492.8 37700.8 36674.6 36911.3 36997.8 37106.3 37156.8 32334.4 35671.8 36562.3 39574.4 40064.0 32456.0 34163.5 34365.8 34412.0 34432.5 25663.2 25804.4 25949.5 26028.3 26291.7 14:49:56 INFO - PROCESS | 23992 | 14:49:56 INFO - PROCESS | 23992 | [#2] jquery.html Cycles:180 Average:23685.08 Median:4952.16 stddev:66450.85 (1341.9%) stddev-sans-first:66614.15 14:49:56 INFO - PROCESS | 23992 | Values: 341.5 354.6 358.6 361.3 365.3 15578.8 16036.4 17264.3 17309.3 17349.4 14675.9 14805.2 15195.1 15289.0 15297.4 4829.1 4903.5 5031.0 5054.8 5064.1 3615.1 5000.8 5553.3 5821.0 5829.5 5795.4 5834.2 5850.2 5853.6 5861.9 5608.8 5862.1 5925.8 5933.5 5939.6 4531.5 5116.1 5119.1 5126.3 5157.8 11279.1 11605.2 11741.5 11773.2 11776.1 1794.0 1845.6 1918.3 1925.9 2035.6 8341.1 8701.8 8739.6 8909.5 8919.0 1732.8 1742.7 1785.8 1793.4 1809.5 69055.3 69459.7 70355.6 70854.6 71277.0 8983.2 9073.0 9158.8 9266.0 9559.0 11747.9 11866.6 11882.9 11897.7 11925.5 6340.2 6434.3 6503.0 6606.7 6609.5 6193.2 6244.3 6304.4 6401.1 6424.6 3708.2 3718.9 3751.3 3768.1 3778.5 1521.4 1567.5 1665.3 1669.9 1689.5 384.3 387.1 400.4 853.7 867.7 9903.3 10010.3 10057.5 10085.9 10305.7 387.6 390.9 393.8 399.7 406.8 5455.7 5504.7 5508.3 5564.9 5565.1 390185.0 390765.0 393475.0 413699.0 416629.0 79386.0 79439.0 80543.6 81492.0 82221.0 397.1 403.9 404.6 406.4 407.8 8977.3 9089.9 9167.0 9246.9 9538.2 33300.5 34812.7 35028.0 35840.0 36440.0 47802.8 50803.7 52793.5 53408.7 53668.0 7320.1 7496.8 7618.7 7631.3 7852.5 8373.8 10554.0 10957.1 11570.8 11720.4 9874.9 9936.7 9961.2 10062.1 10170.1 10349.4 10435.7 10505.1 10528.5 10672.7 9777.6 9890.2 10170.6 10256.1 10375.3 7305.5 7341.9 7369.3 7392.7 7415.2 8583.7 9589.0 9687.6 9849.2 9880.6 14:49:56 INFO - PROCESS | 23992 | 14:49:56 INFO - PROCESS | 23992 | [#3] mootools.html Cycles:180 Average:4929.83 Median:5036.96 stddev:2765.41 (54.9%) stddev-sans-first:2760.57 14:49:56 INFO - PROCESS | 23992 | Values: 1416.8 1453.3 1565.3 1721.2 1736.5 6814.9 7390.7 7434.3 7890.9 7935.3 7513.1 7693.1 7725.9 7746.6 7815.1 2188.5 2233.5 2240.0 2244.3 2245.8 2174.8 2202.5 2217.2 2218.9 2223.5 2182.6 2191.1 2191.4 2197.9 2233.3 2096.2 2104.9 2106.6 2106.7 2110.9 2108.6 2152.2 2169.6 2172.8 2173.5 7665.5 7683.6 7697.4 7716.2 7735.5 4151.7 4176.8 4205.3 4298.1 4310.4 2862.9 2942.5 2993.6 3022.9 3024.9 867.0 891.6 918.0 959.8 972.5 10327.2 10425.2 10474.4 10509.7 10525.5 4063.8 4078.8 4082.8 4118.6 4182.8 8330.3 8338.5 8343.8 8355.7 8360.3 4295.0 4296.1 4304.8 4304.9 4306.4 3265.2 3718.1 3810.8 3829.8 3875.4 3360.2 3399.5 3441.5 3462.6 3610.6 1016.3 1047.4 1050.6 1054.1 1056.2 651.2 767.0 768.1 786.3 789.8 5025.3 5048.6 5084.6 5139.0 5171.9 382.2 390.4 395.6 395.9 398.2 3356.4 3375.8 3376.9 3459.8 3465.1 8868.0 9066.7 9117.5 9125.0 9140.0 8941.6 8962.3 9048.9 9137.5 9197.6 6997.6 7149.1 7149.7 7158.7 7162.6 5078.4 5123.7 5136.3 5290.0 5314.9 8431.7 8470.2 8483.8 8502.4 8600.2 8428.6 8500.1 8799.2 8857.0 8880.9 5483.4 5872.4 6034.9 6073.7 6131.2 7314.6 7337.7 7349.1 7351.6 7372.8 6352.6 6480.7 6513.6 6518.8 6591.8 6276.8 6507.2 6540.0 6703.3 6718.4 5957.1 6076.9 6100.9 6123.3 6169.7 4297.5 4370.1 4371.6 4448.5 4461.8 4503.1 4511.8 4518.3 4543.6 4583.7 14:49:56 INFO - PROCESS | 23992 | 14:49:56 INFO - PROCESS | 23992 | [#4] prototype.html Cycles:180 Average:4277.83 Median:4946.35 stddev:1284.22 (26.0%) stddev-sans-first:1252.43 14:49:56 INFO - PROCESS | 23992 | Values: 288.7 290.8 291.0 299.6 300.2 4940.7 4956.8 4958.9 4979.4 4990.0 4882.1 4896.4 4910.4 4924.3 4952.0 3632.5 3686.6 3804.9 3816.0 3839.4 3768.2 3799.8 3803.2 3806.8 3824.3 3774.3 3782.4 3809.1 3816.6 3822.6 3538.3 3751.3 3834.7 3842.7 3844.7 3208.7 3219.8 3221.8 3228.0 3230.0 4669.8 4686.3 4689.2 4694.4 4709.5 4254.4 4267.9 4269.9 4272.5 4290.9 5004.8 5034.5 5064.1 5070.1 5080.5 3494.5 3499.2 3509.3 3532.9 3535.0 5416.6 5416.9 5430.2 5432.7 5438.9 3382.7 3617.7 3624.9 3625.0 3638.7 3661.8 3693.4 3693.5 3697.4 3699.0 4278.4 4299.6 4306.5 4327.5 4331.8 4987.5 5160.8 5239.3 5241.7 5248.0 1258.5 1264.8 1276.1 1279.8 1280.8 776.2 782.8 786.9 798.7 822.3 4484.7 4613.7 4626.2 4633.9 4648.4 5313.2 5360.4 5370.7 5387.5 5388.8 4525.1 4623.2 4641.8 4650.8 4651.2 2802.8 2861.3 2866.7 2867.9 2877.5 5020.9 5051.2 5056.6 5056.6 5070.7 5218.4 5452.0 5487.5 5511.8 5532.9 5004.7 5053.9 5064.3 5067.0 5080.8 5387.8 5430.5 5436.9 5454.5 5474.6 5147.6 5234.9 5268.1 5285.3 5312.7 5060.1 5064.9 5071.5 5083.7 5084.7 3646.8 3661.7 3672.3 3683.7 3692.0 5116.8 5362.2 5420.8 5421.3 5427.0 5179.9 5215.2 5215.4 5232.9 5242.9 5209.0 5217.9 5245.3 5259.6 5271.6 4892.5 5162.7 5168.8 5168.9 5172.5 5030.3 5124.8 5258.1 5269.3 5272.8 5172.4 5176.7 5181.6 5212.5 5212.8 14:49:56 INFO - PROCESS | 23992 | 14:49:56 INFO - PROCESS | 23992 | [#5] yui.html Cycles:180 Average:13629.40 Median:56199.08 stddev:16957.70 (30.2%) stddev-sans-first:16977.38 14:49:56 INFO - PROCESS | 23992 | Values: 675.6 688.4 737.4 747.0 755.6 12428.3 12555.8 13021.8 13181.5 13613.7 13615.2 13672.4 13697.8 13714.5 13782.9 623.3 788.8 792.4 798.6 799.9 799.8 804.0 805.9 806.5 807.0 844.0 846.3 846.9 848.3 848.4 839.3 841.3 844.8 844.9 845.5 613.7 613.7 617.5 617.9 618.2 12319.0 12320.9 12326.1 12348.4 12350.9 11787.8 11940.6 11960.9 12142.8 12374.6 9530.0 9933.6 9980.6 10083.3 10147.2 3244.7 3340.7 3365.5 3370.4 3373.6 47271.3 47486.8 47583.3 47877.0 47953.8 8885.1 8904.2 9091.6 9242.3 9256.6 17104.4 17299.2 17302.5 17331.4 17360.3 6479.0 6753.9 6772.4 6782.8 6950.2 3623.6 3638.9 3683.5 3818.1 3863.8 2793.8 2911.4 2919.4 2934.9 2935.2 477.1 482.4 488.7 497.2 501.0 451.9 457.6 494.2 499.2 512.9 7526.9 7601.2 7665.4 7678.3 7843.3 416.9 426.2 500.6 511.8 520.4 3627.1 3650.7 3699.4 3705.4 3749.0 60560.0 61198.4 61492.0 62173.4 62640.0 55566.4 55700.7 55911.4 56486.7 57344.7 50840.2 51375.0 51393.5 51660.2 53011.7 7061.4 7072.0 7253.3 7262.7 7334.2 33107.5 33531.7 33979.5 34200.7 34599.5 42322.6 44153.3 44432.0 44863.1 45527.1 9439.0 9439.9 9497.5 9499.2 9527.3 10128.2 10538.9 10770.2 10807.4 10913.7 9570.7 9585.3 9622.6 9738.4 9996.1 9460.4 9461.6 9524.1 9616.5 9752.0 9329.4 9566.8 9629.4 9675.6 10277.2 8311.8 8511.6 8516.4 8664.2 8812.4 8676.1 9158.5 9215.2 9258.5 9462.8 14:49:56 INFO - PROCESS | 23992 | -------- Summary: end -------- 14:49:56 INFO - PROCESS | 23992 | 14:49:57 INFO - TEST-INFO | 23992: exit 0 14:49:57 INFO - TEST-OK | dromaeo_css | took 1115679ms 14:49:57 INFO - TEST-START | kraken 14:49:57 INFO - operating with platform_type : linux_ 14:49:57 INFO - Initialising browser for kraken test... 14:49:57 INFO - TEST-INFO | started process 24226 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcxjchx/profile http://localhost:44435/getInfo.html) 14:50:01 INFO - PROCESS | 24226 | 14:50:01 INFO - PROCESS | 24226 | (process:24293): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 14:50:02 INFO - PROCESS | 24226 | __metrics Screen width/height:1600/1200 14:50:02 INFO - PROCESS | 24226 | colorDepth:24 14:50:02 INFO - PROCESS | 24226 | Browser inner width/height: 1024/697 14:50:02 INFO - PROCESS | 24226 | __metrics 14:50:03 ERROR - PROCESS | 24226 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 14:50:04 INFO - TEST-INFO | 24226: exit 0 14:50:04 INFO - Browser initialized. 14:50:04 INFO - Running cycle 1/1 for kraken test... 14:50:04 INFO - TEST-INFO | started process 24344 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcxjchx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:50:06 INFO - PROCESS | 24344 | 14:50:06 INFO - PROCESS | 24344 | (process:24404): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 14:50:16 INFO - PROCESS | 24344 | RSS: Main: 167317504 14:50:16 INFO - PROCESS | 24344 | 14:50:18 INFO - PROCESS | 24344 | Cycle 1(1): loaded http://localhost:44435/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44435/tests/kraken/driver.html?testName=audio-beat-detection) 14:50:19 INFO - PROCESS | 24344 | RSS: Main: 171446272 14:50:19 INFO - PROCESS | 24344 | 14:50:22 INFO - PROCESS | 24344 | Cycle 1(1): loaded http://localhost:44435/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44435/tests/kraken/driver.html?testName=audio-dft) 14:50:23 INFO - PROCESS | 24344 | RSS: Main: 171462656 14:50:23 INFO - PROCESS | 24344 | 14:50:26 INFO - PROCESS | 24344 | Cycle 1(1): loaded http://localhost:44435/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44435/tests/kraken/driver.html?testName=audio-fft) 14:50:27 INFO - PROCESS | 24344 | RSS: Main: 166739968 14:50:27 INFO - PROCESS | 24344 | 14:50:29 INFO - PROCESS | 24344 | Cycle 1(1): loaded http://localhost:44435/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44435/tests/kraken/driver.html?testName=audio-oscillator) 14:50:29 INFO - PROCESS | 24344 | RSS: Main: 166817792 14:50:29 INFO - PROCESS | 24344 | 14:50:31 INFO - PROCESS | 24344 | Cycle 1(1): loaded http://localhost:44435/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44435/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:50:32 INFO - PROCESS | 24344 | RSS: Main: 166780928 14:50:32 INFO - PROCESS | 24344 | 14:50:35 INFO - PROCESS | 24344 | Cycle 1(1): loaded http://localhost:44435/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44435/tests/kraken/driver.html?testName=imaging-darkroom) 14:50:36 INFO - PROCESS | 24344 | RSS: Main: 166817792 14:50:36 INFO - PROCESS | 24344 | 14:50:39 INFO - PROCESS | 24344 | Cycle 1(1): loaded http://localhost:44435/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44435/tests/kraken/driver.html?testName=imaging-desaturate) 14:50:40 INFO - PROCESS | 24344 | RSS: Main: 165847040 14:50:40 INFO - PROCESS | 24344 | 14:50:43 INFO - PROCESS | 24344 | Cycle 1(1): loaded http://localhost:44435/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44435/tests/kraken/driver.html?testName=json-parse-financial) 14:50:44 INFO - PROCESS | 24344 | RSS: Main: 165892096 14:50:44 INFO - PROCESS | 24344 | 14:50:45 INFO - PROCESS | 24344 | Cycle 1(1): loaded http://localhost:44435/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44435/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:50:46 INFO - PROCESS | 24344 | RSS: Main: 166547456 14:50:46 INFO - PROCESS | 24344 | 14:50:48 INFO - PROCESS | 24344 | Cycle 1(1): loaded http://localhost:44435/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44435/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:50:48 INFO - PROCESS | 24344 | RSS: Main: 167559168 14:50:48 INFO - PROCESS | 24344 | 14:50:51 INFO - PROCESS | 24344 | Cycle 1(1): loaded http://localhost:44435/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44435/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:50:51 INFO - PROCESS | 24344 | RSS: Main: 167133184 14:50:51 INFO - PROCESS | 24344 | 14:50:54 INFO - PROCESS | 24344 | Cycle 1(1): loaded http://localhost:44435/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44435/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:50:55 INFO - PROCESS | 24344 | RSS: Main: 167186432 14:50:55 INFO - PROCESS | 24344 | 14:50:58 INFO - PROCESS | 24344 | Cycle 1(1): loaded http://localhost:44435/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44435/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:50:58 INFO - PROCESS | 24344 | RSS: Main: 167178240 14:50:58 INFO - PROCESS | 24344 | 14:51:00 INFO - PROCESS | 24344 | Cycle 1(1): loaded http://localhost:44435/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44435/tests/kraken/driver.html?testName=ai-astar) 14:51:00 INFO - PROCESS | 24344 | RSS: Main: 168542208 14:51:00 INFO - PROCESS | 24344 | 14:51:00 INFO - PROCESS | 24344 | __start_tp_report 14:51:00 INFO - PROCESS | 24344 | _x_x_mozilla_page_load 14:51:00 INFO - PROCESS | 24344 | _x_x_mozilla_page_load_details 14:51:00 INFO - PROCESS | 24344 | |i|pagename|runs| 14:51:00 INFO - PROCESS | 24344 | |0;ai-astar;114;110;114;114;115;117;113;113;113;113 14:51:00 INFO - PROCESS | 24344 | |1;audio-beat-detection;154;136;157;180;140;156;163;132;204;136 14:51:00 INFO - PROCESS | 24344 | |2;audio-dft;163;163;165;178;162;162;162;170;164;162 14:51:00 INFO - PROCESS | 24344 | |3;audio-fft;74;76;77;153;76;77;76;76;169;77 14:51:00 INFO - PROCESS | 24344 | |4;audio-oscillator;85;85;134;86;84;86;143;85;85;140 14:51:00 INFO - PROCESS | 24344 | |5;imaging-gaussian-blur;118;117;117;119;118;118;118;119;118;119 14:51:00 INFO - PROCESS | 24344 | |6;imaging-darkroom;148;147;148;147;147;148;148;146;147;148 14:51:00 INFO - PROCESS | 24344 | |7;imaging-desaturate;95;96;95;95;95;95;96;96;96;95 14:51:00 INFO - PROCESS | 24344 | |8;json-parse-financial;66;66;64;71;64;64;65;77;64;62 14:51:00 INFO - PROCESS | 24344 | |9;json-stringify-tinderbox;66;65;65;64;66;65;65;65;65;66 14:51:00 INFO - PROCESS | 24344 | |10;stanford-crypto-aes;86;83;83;84;83;84;85;85;85;86 14:51:00 INFO - PROCESS | 24344 | |11;stanford-crypto-ccm;135;140;139;147;135;132;137;131;171;144 14:51:00 INFO - PROCESS | 24344 | |12;stanford-crypto-pbkdf2;168;169;168;171;168;177;168;170;166;168 14:51:00 INFO - PROCESS | 24344 | |13;stanford-crypto-sha256-iterative;67;70;67;68;70;66;69;65;67;67 14:51:00 INFO - PROCESS | 24344 | __end_tp_report 14:51:00 INFO - PROCESS | 24344 | __start_cc_report 14:51:00 INFO - PROCESS | 24344 | _x_x_mozilla_cycle_collect,929 14:51:00 INFO - PROCESS | 24344 | __end_cc_report 14:51:00 INFO - PROCESS | 24344 | __startTimestamp1464213060745__endTimestamp 14:51:00 INFO - PROCESS | 24344 | 14:51:00 INFO - PROCESS | 24344 | ------- Summary: start ------- 14:51:00 INFO - PROCESS | 24344 | Number of tests: 14 14:51:00 INFO - PROCESS | 24344 | 14:51:00 INFO - PROCESS | 24344 | [#0] ai-astar Cycles:10 Average:113.60 Median:114.00 stddev:1.78 (1.6%) stddev-sans-first:1.88 14:51:00 INFO - PROCESS | 24344 | Values: 114.0 110.0 114.0 114.0 115.0 117.0 113.0 113.0 113.0 113.0 14:51:00 INFO - PROCESS | 24344 | 14:51:00 INFO - PROCESS | 24344 | [#1] audio-beat-detection Cycles:10 Average:155.80 Median:156.50 stddev:22.52 (14.4%) stddev-sans-first:23.88 14:51:00 INFO - PROCESS | 24344 | Values: 154.0 136.0 157.0 180.0 140.0 156.0 163.0 132.0 204.0 136.0 14:51:00 INFO - PROCESS | 24344 | 14:51:00 INFO - PROCESS | 24344 | [#2] audio-dft Cycles:10 Average:165.10 Median:163.50 stddev:5.15 (3.2%) stddev-sans-first:5.41 14:51:00 INFO - PROCESS | 24344 | Values: 163.0 163.0 165.0 178.0 162.0 162.0 162.0 170.0 164.0 162.0 14:51:00 INFO - PROCESS | 24344 | 14:51:00 INFO - PROCESS | 24344 | [#3] audio-fft Cycles:10 Average:93.10 Median:76.00 stddev:36.00 (47.4%) stddev-sans-first:37.51 14:51:00 INFO - PROCESS | 24344 | Values: 74.0 76.0 77.0 153.0 76.0 77.0 76.0 76.0 169.0 77.0 14:51:00 INFO - PROCESS | 24344 | 14:51:00 INFO - PROCESS | 24344 | [#4] audio-oscillator Cycles:10 Average:101.30 Median:85.00 stddev:26.11 (30.7%) stddev-sans-first:27.02 14:51:00 INFO - PROCESS | 24344 | Values: 85.0 85.0 134.0 86.0 84.0 86.0 143.0 85.0 85.0 140.0 14:51:00 INFO - PROCESS | 24344 | 14:51:00 INFO - PROCESS | 24344 | [#5] imaging-gaussian-blur Cycles:10 Average:118.10 Median:118.00 stddev:0.74 (0.6%) stddev-sans-first:0.78 14:51:00 INFO - PROCESS | 24344 | Values: 118.0 117.0 117.0 119.0 118.0 118.0 118.0 119.0 118.0 119.0 14:51:00 INFO - PROCESS | 24344 | 14:51:00 INFO - PROCESS | 24344 | [#6] imaging-darkroom Cycles:10 Average:147.40 Median:148.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 14:51:00 INFO - PROCESS | 24344 | Values: 148.0 147.0 148.0 147.0 147.0 148.0 148.0 146.0 147.0 148.0 14:51:00 INFO - PROCESS | 24344 | 14:51:00 INFO - PROCESS | 24344 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 14:51:00 INFO - PROCESS | 24344 | Values: 95.0 96.0 95.0 95.0 95.0 95.0 96.0 96.0 96.0 95.0 14:51:00 INFO - PROCESS | 24344 | 14:51:00 INFO - PROCESS | 24344 | [#8] json-parse-financial Cycles:10 Average:66.30 Median:65.50 stddev:4.45 (6.8%) stddev-sans-first:4.72 14:51:00 INFO - PROCESS | 24344 | Values: 66.0 66.0 64.0 71.0 64.0 64.0 65.0 77.0 64.0 62.0 14:51:00 INFO - PROCESS | 24344 | 14:51:00 INFO - PROCESS | 24344 | [#9] json-stringify-tinderbox Cycles:10 Average:65.20 Median:65.00 stddev:0.63 (1.0%) stddev-sans-first:0.60 14:51:00 INFO - PROCESS | 24344 | Values: 66.0 65.0 65.0 64.0 66.0 65.0 65.0 65.0 65.0 66.0 14:51:00 INFO - PROCESS | 24344 | 14:51:00 INFO - PROCESS | 24344 | [#10] stanford-crypto-aes Cycles:10 Average:84.40 Median:85.00 stddev:1.17 (1.4%) stddev-sans-first:1.09 14:51:00 INFO - PROCESS | 24344 | Values: 86.0 83.0 83.0 84.0 83.0 84.0 85.0 85.0 85.0 86.0 14:51:00 INFO - PROCESS | 24344 | 14:51:00 INFO - PROCESS | 24344 | [#11] stanford-crypto-ccm Cycles:10 Average:141.10 Median:139.50 stddev:11.64 (8.3%) stddev-sans-first:12.13 14:51:00 INFO - PROCESS | 24344 | Values: 135.0 140.0 139.0 147.0 135.0 132.0 137.0 131.0 171.0 144.0 14:51:00 INFO - PROCESS | 24344 | 14:51:00 INFO - PROCESS | 24344 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.30 Median:168.50 stddev:3.02 (1.8%) stddev-sans-first:3.17 14:51:00 INFO - PROCESS | 24344 | Values: 168.0 169.0 168.0 171.0 168.0 177.0 168.0 170.0 166.0 168.0 14:51:00 INFO - PROCESS | 24344 | 14:51:00 INFO - PROCESS | 24344 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.60 Median:67.50 stddev:1.65 (2.4%) stddev-sans-first:1.73 14:51:00 INFO - PROCESS | 24344 | Values: 67.0 70.0 67.0 68.0 70.0 66.0 69.0 65.0 67.0 67.0 14:51:00 INFO - PROCESS | 24344 | -------- Summary: end -------- 14:51:00 INFO - PROCESS | 24344 | 14:51:01 INFO - TEST-INFO | 24344: exit 0 14:51:01 INFO - TEST-OK | kraken | took 64118ms 14:51:01 INFO - SUITE-END | took 1179s 14:51:01 INFO - Completed test suite (00:19:39) 14:51:01 INFO - javascript benchmark 14:51:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6104.202141816162, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2656.62807206991, 2694.6496955395796, 2697.568389057751, 2713.375923537585, 2730.5221586222406, 4672.275797251423, 4683.672142949995, 4712.5994290485305, 4741.288806679, 4774.997250577383, 4611.446626404836, 4715.3162791395225, 4728.385309909716, 4739.028499157673, 4805.567498925096, 4304.784760761957, 4379.146066517031, 4438.245498265303, 4463.665225108113, 4483.6861419700635, 640.8059415077207, 4307.353896915456, 4400.955990440103, 4405.339199120125, 4431.601155895969, 4336.783160841946, 4339.414179085815, 4349.347597860315, 4359.04101097758, 4380.518143004283, 4247.171801498709, 4346.326319420495, 4349.369341445505, 4388.078503514266, 4425.513193548707, 4287.2711639021445, 4294.957050429487, 4295.033617436052, 4322.913541729179, 4392.956070439319, 4591.770411479446, 4606.332081848113, 4623.02916387559, 4632.583067523905, 4690.132325519789, 5030.773615187325, 5033.924491132636, 5053.140966035746, 5060.696358218482, 5064.746762661852, 5136.43499215086, 5141.203113517411, 5144.742762861842, 5162.6128040397125, 5170.017696637627, 4779.808807647724, 4780.187368147389, 4800.73595952219, 4819.662623616313, 4851.830185943475, 5082.923756143661, 5235.4502777207845, 5246.31797866275, 5252.763625636855, 5307.150855863043, 5022.196448568212, 5026.572741316956, 5030.0, 5041.924371134436, 5095.286659867622, 5111.463296353903, 5114.846554603368, 5125.56432703217, 5133.486651334837, 5139.203423469368, 4919.950800491949, 5006.599472042228, 5083.034223497523, 5084.720340381241, 5098.770555325019, 4801.087793319258, 5038.143515602356, 5041.495850414929, 5077.26379674945, 5102.974485127625, 4281.336392859112, 4298.075913678574, 4299.290617048152, 4332.1985432695055, 4342.240107981153, 3650.233450975272, 3661.7436779425184, 3666.211764470598, 3689.760165589228, 3703.870364537282, 4521.909561808746, 4522.86928267933, 4535.024969631545, 4559.52125026874, 4575.3823233863, 5149.871253218625, 5156.793728250903, 5169.4830516948, 5177.974110129425, 5233.738313084406, 4384.364267181305, 4459.576340247671, 4482.910341793211, 4493.1013797240685, 4512.5261847505535, 4557.840475583339, 4560.794764235618, 4579.290210017452, 4579.564941330568, 4646.465656449484, 4749.0, 4799.256115302133, 4816.34979277807, 4828.227483602747, 4849.0, 4909.214525675875, 5064.139096353702, 5114.795408183631, 5126.051680439131, 5149.948500514947, 4818.494058123846, 4825.420949486084, 4833.419989601271, 4852.466228714909, 4873.049755297825, 4963.982383611423, 5083.974580127076, 5087.465816089405, 5096.0827051131155, 5145.279660847409, 5107.41264754558, 5117.5905927526455, 5154.175331947021, 5157.0, 5175.508326708957, 5014.122528557561, 5017.448080711192, 5022.347094877642, 5025.195968644999, 5094.923576146287, 4846.781894814671, 4900.95099049005, 5008.799648014038, 5022.146235139962, 5029.396472423333, 4811.663183577116, 4835.032993401404, 4884.78018489176, 4894.730789806595, 4969.378827646544, 5015.1223535880345, 5016.824411145592, 5020.899582008413, 5027.245913112916, 5055.140626093499, 4870.537298956593, 4916.9754151230445, 4921.803127874845, 4926.802927882844, 4933.087378834927], "value": 4655.275979757192, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [543.4161939929195, 555.3446932619507, 579.1631093070513, 594.8839976204639, 599.5263741644102, 39954.800225998864, 41253.79373103131, 41325.79337103318, 41340.37989430161, 45467.31799023009, 42226.36660450088, 42766.78616606913, 42906.14187716252, 42914.0, 42924.0, 7796.41526885483, 7902.367810575169, 7944.404169687267, 7963.283304502594, 7976.6809327626825, 7671.194524574923, 7794.610269486531, 7819.100803407596, 7844.882326765103, 7895.60521973899, 7832.647530861125, 7832.686692532292, 7882.0, 7886.526808391515, 7899.644515996794, 7797.181295963927, 7804.960975195145, 7857.960710196441, 7878.72424465141, 7878.921210787933, 7675.424343174284, 7790.610469476504, 7791.0650721913735, 7796.064472263308, 7808.492447990862, 39999.600003999876, 40240.396394054114, 40258.59741402607, 40333.19333613341, 40436.0, 3006.8195908245575, 3235.71819221401, 3248.204189973472, 3323.202431416467, 3333.983330083334, 29204.8539757302, 30063.248418789706, 30098.0, 30182.396352073054, 30974.22564435907, 3232.2242661761243, 3533.575970883485, 3575.5173051637958, 3612.6567976042497, 3701.2967536168044, 271927.0, 274692.0, 274861.0, 275628.0, 276225.0, 57126.42873571294, 57186.7140664294, 57400.71299643475, 57429.42570574324, 57690.711546442835, 33662.158446039044, 34174.0, 34342.14144646404, 36360.818195908854, 36594.8170259147, 14633.707325853424, 14837.851621483647, 14895.329710163069, 14926.850731492546, 14954.0, 11073.557057717762, 11252.606158784403, 11336.886631133582, 11337.773244535063, 11359.091272698164, 18883.0, 18961.620767584573, 19029.048547572565, 19029.238830446902, 19041.238350465825, 6950.8609827804175, 6986.9650651746415, 7255.8911616325795, 7281.817954551073, 7340.30267124633, 835.778518692547, 894.3650008493912, 970.5438443931341, 975.6536429567543, 991.1872264742985, 28061.43877122446, 28835.56746648802, 28866.567001494994, 28954.565681514796, 29371.55942660862, 941.049539964627, 974.4202199691173, 992.7468495533593, 1049.8504486540378, 1050.0601961244643, 14407.42370305176, 14928.463012267168, 14974.176420296988, 15298.158601276815, 15313.770293445607, 389604.0, 391321.0, 392950.0, 393595.0, 393973.0602693994, 50836.74581627068, 51520.74239628778, 51527.74236128795, 51549.226761598606, 51554.74222628938, 1039.3815679670583, 1041.047441590951, 1068.6206396729206, 1073.9892601074046, 1153.763478486908, 26510.204693859214, 27548.862255688593, 27628.0, 27878.30304242329, 28037.71962280351, 42862.14275714406, 42865.14269714526, 42896.35655465233, 43202.0, 43353.783231083646, 330640.0, 331210.0, 332212.0, 332287.0, 333585.0, 25470.872645636653, 25609.87195064013, 26088.73911260863, 26209.4758104833, 26280.4743905117, 39663.2067358657, 42645.14709705851, 43746.781266093465, 43829.56170438255, 44090.779546102065, 36112.27775444529, 37024.81487592545, 37469.250614988094, 37492.81253593715, 37700.81149594344, 36674.633253667125, 36911.26177476489, 36997.81501092585, 37106.25787484289, 37156.814215928745, 32334.35331293314, 35671.82164089163, 36562.26875462422, 39574.40638390369, 40064.0, 32456.0, 34163.48754768631, 34365.828170858986, 34412.0, 34432.48351274783, 25663.230103096936, 25804.35489112787, 25949.481010380063, 26028.34929126787, 26291.73708262893], "value": 17734.02901165465, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [341.5474496292413, 354.64712610952097, 358.6252366277242, 361.3351433362616, 365.3241503219045, 15578.766318505232, 16036.43872464464, 17264.309427622913, 17309.307627694892, 17349.39277125301, 14675.89930755195, 14805.185714785683, 15195.088294702326, 15289.0, 15297.388104475807, 4829.058333624945, 4903.485134060926, 5030.974845125769, 5054.79780808769, 5064.1390963536105, 3615.132368231632, 5000.824971126011, 5553.305836770403, 5821.0104282271905, 5829.475347218749, 5795.362510123883, 5834.21238132853, 5850.180974663551, 5853.648781073128, 5861.912071318934, 5608.831735047955, 5862.091375836731, 5925.822225333204, 5933.525317974551, 5939.613925094876, 4531.478879928784, 5116.104681680728, 5119.104156772587, 5126.307948426952, 5157.8452646420665, 11279.097672186206, 11605.245659032136, 11741.530338786439, 11773.234739741889, 11776.05791536675, 1793.973090403645, 1845.575517630939, 1918.2902326139279, 1925.913333899978, 2035.552178520738, 8341.124181960868, 8701.825963480758, 8739.60671769772, 8909.465432074096, 8918.955405222998, 1732.8180541043262, 1742.651469706051, 1785.8303461171167, 1793.390247315919, 1809.5023868436285, 69055.30944690539, 69459.65270173617, 70355.64822175908, 70854.64572677155, 71277.0, 8983.203359328161, 9072.95463522678, 9158.771030724285, 9265.953670231605, 9558.952205239068, 11747.941260293645, 11866.584669536525, 11882.940585297018, 11897.702557436134, 11925.522979080914, 6340.207474065742, 6434.292227854932, 6502.967485162544, 6606.669666516655, 6609.471242300604, 6193.163922870445, 6244.2819075805955, 6304.432601065926, 6401.07184458251, 6424.582402143846, 3708.2212735325884, 3718.884334699579, 3751.2685026419585, 3768.1333293342686, 3778.4521244419407, 1521.3990473762801, 1567.4827306988666, 1665.3088968078355, 1669.9415520456726, 1689.518487231158, 384.25646374265887, 387.0980615166655, 400.3574263307408, 853.7268074216315, 867.7093173786852, 9903.306768526134, 10010.349327293703, 10057.547410366406, 10085.949570252249, 10305.742356440998, 387.62981352808, 390.8827351794507, 393.78341911948314, 399.67027202558006, 406.778305823327, 5455.699936503531, 5504.724763761796, 5508.283923089973, 5564.944350556523, 5565.081761509306, 390185.0, 390765.0, 393475.0, 413699.0, 416629.0, 79386.0, 79439.0, 80543.59728201438, 81492.0, 82221.0, 397.06293148170295, 403.8848928055549, 404.5590306565857, 406.35592585751914, 407.81852075826566, 8977.326700497359, 9089.909100908906, 9166.954165229132, 9246.936602290823, 9538.23694104484, 33300.500492492145, 34812.651873481955, 35028.0, 35840.0, 36440.0, 47802.760986194844, 50803.74598126986, 52793.472065280395, 53408.73295633497, 53668.0, 7320.1215854097845, 7496.7750967471065, 7618.69525218985, 7631.321109355933, 7852.489588176751, 8373.832523349378, 10554.0, 10957.123430125412, 11570.826437603275, 11720.413979301171, 9874.901250987397, 9936.701898943043, 9961.203103751537, 10062.144717699077, 10170.08469237772, 10349.430781307101, 10435.739106522398, 10505.054545090978, 10528.473576321307, 10672.733181670521, 9777.608895644094, 9890.159336456481, 10170.644027459004, 10256.07695307426, 10375.273730839072, 7305.452091093083, 7341.889871652036, 7369.336759691653, 7392.741254056083, 7415.2214017527385, 8583.65665373378, 9589.0, 9687.564059617192, 9849.162821160282, 9880.604775809175], "value": 7096.244439583706, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1416.8087308213392, 1453.3387308774506, 1565.2643257668892, 1721.182438341787, 1736.531136593119, 6814.897776533344, 7390.741324053659, 7434.293742094499, 7890.92109078909, 7935.285824275821, 7513.060867391576, 7693.076830780315, 7725.92274077259, 7746.612669366537, 7815.062192536903, 2188.474766056147, 2233.4528040630066, 2239.9552008959813, 2244.259394399844, 2245.8427910046303, 2174.836887233464, 2202.48241663209, 2217.2018073493527, 2218.92233771818, 2223.4663680716594, 2182.5743979923923, 2191.079746506471, 2191.3535507025467, 2197.8791166485835, 2233.2853486884123, 2096.2453516733963, 2104.947376315589, 2106.610277098742, 2106.6629339305637, 2110.915563377471, 2108.599366120432, 2152.2359562355296, 2169.609470295346, 2172.8261739060836, 2173.4566358410398, 7665.540067595962, 7683.57740324282, 7697.384209263301, 7716.151223365426, 7735.4585179037485, 4151.6886233532305, 4176.812043458051, 4205.3271476563605, 4298.118885628439, 4310.4396428464415, 2862.942741145186, 2942.5439056945993, 2993.625796775403, 3022.9395412091635, 3024.879004839826, 866.9566521673954, 891.5720454181965, 917.9632814687404, 959.8320293948601, 972.4748635736764, 10327.173826093895, 10425.218108641806, 10474.371537707762, 10509.684709458728, 10525.473726313654, 4063.756174629532, 4078.775667338325, 4082.795860206978, 4118.567550407164, 4182.769947652909, 8330.291925186306, 8338.458000229966, 8343.8331233375, 8355.665773368997, 8360.28937540316, 4295.0, 4296.0548679290505, 4304.849330273488, 4304.892377690583, 4306.354046892991, 3265.167382317494, 3718.0890681783135, 3810.7713537187856, 3829.789361585084, 3875.418687196943, 3360.1599600099976, 3399.473081672345, 3441.5181874537584, 3462.563036339891, 3610.6389361063684, 1016.2581315639625, 1047.3820445936933, 1050.5745173204864, 1054.093479607537, 1056.1920131099714, 651.2250421997808, 766.9808254793563, 768.0974854545998, 786.3276898252027, 789.7551758954743, 5025.271335656309, 5048.646594738333, 5084.56781173597, 5139.023585518814, 5171.896562068813, 382.15543648537044, 390.35786131813006, 395.5787086752599, 395.94456776051373, 398.1698159337755, 3356.429407000767, 3375.8312084395684, 3376.9493457598155, 3459.8270086496077, 3465.081753335368, 8867.955660221787, 9066.682666106655, 9117.498537580364, 9124.95437522808, 9139.95430022859, 8941.552922353856, 8962.283017358595, 9048.909510904938, 9137.451752894847, 9197.63209471627, 6997.615131167835, 7149.070620819364, 7149.714011439588, 7158.749443769443, 7162.606056666829, 5078.441371449211, 5123.743812809419, 5136.280920671034, 5290.0, 5314.946850531445, 8431.747047588582, 8470.152984701726, 8483.787905302417, 8502.362322825937, 8600.22597966186, 8428.620712067848, 8500.107488713844, 8799.20807127336, 8856.955715221382, 8880.86678699807, 5483.424240454695, 5872.412758724094, 6034.939650603438, 6073.726682299395, 6131.202943617302, 7314.561126332437, 7337.669804858688, 7349.118105827335, 7351.595662238628, 7372.778816635509, 6352.618842869442, 6480.70836812354, 6513.576617519846, 6518.804435866931, 6591.8022459324375, 6276.811695649138, 6507.219133703986, 6539.967300163468, 6703.262641109376, 6718.39534441883, 5957.136215248678, 6076.8784624308155, 6100.8779824404155, 6123.2652081750475, 6169.660668663267, 4297.54875738043, 4370.0822827205375, 4371.606555410029, 4448.510663826912, 4461.81761833108, 4503.144402563503, 4511.819527218874, 4518.277075667877, 4543.568361005699, 4583.702059366131], "value": 3911.8824751353222, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [288.6709151567213, 290.79063074586304, 291.04682165906655, 299.63294963669495, 300.16404313985555, 4940.703557786535, 4956.752162391875, 4958.900821983558, 4979.35268415106, 4989.975050124749, 4882.121218180726, 4896.436909755379, 4910.361652985107, 4924.261360795874, 4952.0, 3632.5096112024935, 3686.5576130864333, 3804.9239015219678, 3815.988762977813, 3839.404892241707, 3768.171002379472, 3799.7530160539477, 3803.201327721168, 3806.7715937043868, 3824.3498605237037, 3774.301754175486, 3782.3948168293077, 3809.1048603578274, 3816.637419445148, 3822.636849499307, 3538.3454060998797, 3751.3247615429214, 3834.7123965702544, 3842.731008829383, 3844.692424606025, 3208.6951739584933, 3219.7907136036083, 3221.8240342275135, 3228.0, 3230.047136094834, 4669.813207471697, 4686.297055441677, 4689.20283551797, 4694.436667599875, 4709.458412282563, 4254.361845723135, 4267.91464170718, 4269.893252668677, 4272.487301523837, 4290.914181716348, 5004.84985450437, 5034.4713805050305, 5064.088464076464, 5070.084701296769, 5080.542751152377, 3494.493298471733, 3499.2476617527354, 3509.3332266869215, 3532.894013179609, 3534.964650353489, 5416.593755468356, 5416.945830541684, 5430.212619170237, 5432.6740395576, 5438.891222175574, 3382.712469440125, 3617.692496137805, 3624.873129440457, 3625.0, 3638.6725194732603, 3661.761985470936, 3693.4275187346007, 3693.5041308270193, 3697.371446854041, 3699.038250055005, 4278.379634952977, 4299.634531064832, 4306.547812479707, 4327.545607711208, 4331.805068771912, 4987.501249875056, 5160.845174644766, 5239.266502689627, 5241.659292145999, 5247.9737601311745, 1258.5091814192472, 1264.7913094339515, 1276.1131013945405, 1279.7969908286182, 1280.788669869461, 776.1578687124534, 782.8296696438861, 786.8865555239272, 798.6565776716068, 822.3174764945081, 4484.663650226246, 4613.700109492872, 4626.1904166771355, 4633.930491042637, 4648.372469716545, 5313.210564453692, 5360.410354860962, 5370.650907690988, 5387.488188622075, 5388.817528900801, 4525.058711837332, 4623.16782979067, 4641.814327426865, 4650.790714417859, 4651.232546629836, 2802.8178168418985, 2861.327588016856, 2866.7276608722136, 2867.856607169675, 2877.5395936650034, 5020.93722829074, 5051.242313652908, 5056.609432406118, 5056.64603477753, 5070.746462676925, 5218.425973142951, 5451.972740136353, 5487.451254874481, 5511.751971161308, 5532.944670553324, 5004.749762511859, 5053.8736531587, 5064.316317297192, 5067.037262920034, 5080.822171223989, 5387.81142660005, 5430.5384042356845, 5436.8640783979135, 5454.509094181542, 5474.616776825584, 5147.58819294448, 5234.895302094013, 5268.130758424817, 5285.312909321764, 5312.7343632818975, 5060.139776237975, 5064.8987020258655, 5071.518205770446, 5083.745812709423, 5084.745762711924, 3646.7994260315936, 3661.7114303560274, 3672.2556785526663, 3683.705303575654, 3691.966249450158, 5116.820911268088, 5362.222477740628, 5420.7560659769615, 5421.349438067457, 5426.972865135649, 5179.896402071862, 5215.191645294985, 5215.426303106731, 5232.869178270422, 5242.868928276824, 5209.01028804526, 5217.895642087213, 5245.265662807134, 5259.554307247148, 5271.578273738169, 4892.535209155125, 5162.683515703471, 5168.8449346519665, 5168.896622067613, 5172.456892026283, 5030.346055012971, 5124.769385377593, 5258.106121959353, 5269.28864603289, 5272.813616936159, 5172.439642377048, 5176.741162941763, 5181.637285389987, 5212.478752124757, 5212.765425555935], "value": 3860.363657059795, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [675.5845155229532, 688.4182865478671, 737.4432303610773, 747.0363231431458, 755.6372940988329, 12428.254304741711, 12555.811662825054, 13021.804672929902, 13181.538646147386, 13613.659658508543, 13615.183089014667, 13672.384742686578, 13697.794533082011, 13714.519991800289, 13782.931085344559, 623.3143542103672, 788.8382881509277, 792.3938187286716, 798.5727635714894, 799.940004499662, 799.7880561651167, 803.9839203215932, 805.9435839491238, 806.4717609965453, 807.019471342319, 843.9831203375929, 846.2806614377791, 846.9449485783435, 848.3340577646549, 848.3764433141636, 839.2740279658052, 841.3311417423103, 844.7972486603232, 844.9408541402073, 845.4546817302836, 613.6563524426335, 613.7054213977272, 617.5461036138435, 617.8764247150588, 618.2179542878263, 12319.0, 12320.938395307967, 12326.137170398075, 12348.38258087092, 12350.876491235062, 11787.823182652268, 11940.582079627258, 11960.880391196064, 12142.757144857142, 12374.62876113718, 9529.952350238274, 9933.552990115462, 9980.550875210633, 10083.294169408144, 10147.188224941987, 3244.7034841723, 3340.7494437917253, 3365.4951757236367, 3370.4438767603315, 3373.5614370131725, 47271.29093063607, 47486.762566187295, 47583.28625070627, 47877.04245915097, 47953.76023119862, 8885.111488851064, 8904.243139333099, 9091.636334546543, 9242.260619150451, 9256.629734810533, 17104.40134595308, 17299.221535030953, 17302.480925572254, 17331.393401230896, 17360.305587776347, 6479.0, 6753.932460675429, 6772.390484856386, 6782.8304292392095, 6950.20072691647, 3623.6478186789386, 3638.9272214555563, 3683.4658974448553, 3818.1218319786603, 3863.8068096595057, 2793.8184018038764, 2911.4322707072342, 2919.357741296911, 2934.8679309431127, 2935.163478408643, 477.0649526927192, 482.351237585447, 488.68479830509835, 497.219365596018, 501.0305059709474, 451.86895800218224, 457.6024405463493, 494.21913376864467, 499.2311839766791, 512.910240707882, 7526.887096693554, 7601.239876012465, 7665.386769058462, 7678.347340476123, 7843.294103530709, 416.895776055986, 426.20725450661746, 500.62703286051396, 511.8490045436605, 520.3859445853928, 3627.147620309225, 3650.653187947141, 3699.352613292663, 3705.370087085202, 3749.0252534341266, 60560.0, 61198.38801612016, 61492.0, 62173.37826621676, 62640.0, 55566.44433555612, 55700.72149639307, 55911.44088559144, 56486.717566411906, 57344.71327643335, 50840.237396438344, 51375.0, 51393.486065139616, 51660.22509662358, 53011.73494132505, 7061.399781018671, 7072.0, 7253.347198751927, 7262.709491620276, 7334.156571994289, 33107.50338744873, 33531.66468335383, 33979.4903076459, 34200.65799341975, 34599.481007785405, 42322.57677423309, 44153.33769993389, 44432.0, 44863.10273794571, 45527.08945821131, 9439.0, 9439.858402124111, 9497.47763872966, 9499.192568631745, 9527.333086683866, 10128.189744820544, 10538.894611054098, 10770.192235582206, 10807.35155890649, 10913.672589822318, 9570.665026724031, 9585.281103917094, 9622.566984485575, 9738.415695058036, 9996.07977411558, 9460.432374057578, 9461.574229159567, 9524.142827145313, 9616.471094089893, 9752.024797520191, 9329.440233586007, 9566.808663826545, 9629.422234665943, 9675.564599593175, 10277.177825773771, 8311.750647480585, 8511.574421279036, 8516.403851730567, 8664.220220179963, 8812.383133180872, 8676.089010654043, 9158.542072896194, 9215.170634642915, 9258.53707314645, 9462.763430914281], "value": 5846.933146219326, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1583.6999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 110.0, 114.0, 114.0, 115.0, 117.0, 113.0, 113.0, 113.0, 113.0], "value": 113.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 136.0, 157.0, 180.0, 140.0, 156.0, 163.0, 132.0, 204.0, 136.0], "value": 155.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 165.0, 178.0, 162.0, 162.0, 162.0, 170.0, 164.0, 162.0], "value": 165.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 77.0, 153.0, 76.0, 77.0, 76.0, 76.0, 169.0, 77.0], "value": 93.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 134.0, 86.0, 84.0, 86.0, 143.0, 85.0, 85.0, 140.0], "value": 101.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 119.0, 118.0, 118.0, 118.0, 119.0, 118.0, 119.0], "value": 118.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 148.0, 147.0, 147.0, 148.0, 148.0, 146.0, 147.0, 148.0], "value": 147.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 96.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 64.0, 71.0, 64.0, 64.0, 65.0, 77.0, 64.0, 62.0], "value": 66.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 65.0, 64.0, 66.0, 65.0, 65.0, 65.0, 65.0, 66.0], "value": 65.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 83.0, 83.0, 84.0, 83.0, 84.0, 85.0, 85.0, 85.0, 86.0], "value": 84.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 140.0, 139.0, 147.0, 135.0, 132.0, 137.0, 131.0, 171.0, 144.0], "value": 141.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 169.0, 168.0, 171.0, 168.0, 177.0, 168.0, 170.0, 166.0, 168.0], "value": 169.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 70.0, 67.0, 68.0, 70.0, 66.0, 69.0, 65.0, 67.0, 67.0], "value": 67.6, "unit": "score"}]}]} 14:51:01 INFO - Return code: 0 14:51:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 14:51:02 ERROR - # TBPL SUCCESS # 14:51:02 INFO - Running post-action listener: _resource_record_post_action 14:51:02 INFO - ##### 14:51:02 INFO - ##### Finished run-tests step (success) 14:51:02 INFO - ##### 14:51:02 INFO - Running post-run listener: _resource_record_post_run 14:51:02 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 4096; Write bytes: 532107264; Read time: 12; Write time: 489568 14:51:02 INFO - TinderboxPrint: CPU usage
13.4% 14:51:02 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 14:51:02 INFO - TinderboxPrint: I/O write bytes / time
532,107,264 / 489,568 14:51:02 INFO - TinderboxPrint: CPU idle
8,270.6 (86.6%) 14:51:02 INFO - TinderboxPrint: CPU user
1,225.8 (12.8%) 14:51:02 INFO - TinderboxPrint: Swap in / out
0 / 0 14:51:02 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 237109248; Read time: 0; Write time: 292660 14:51:02 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 4096; Write bytes: 294998016; Read time: 12; Write time: 196908 14:51:02 INFO - Running post-run listener: _upload_blobber_files 14:51:02 INFO - Blob upload gear active. 14:51:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:51:02 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 14:51:02 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'] 14:51:02 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 14:51:03 INFO - (blobuploader) - INFO - Open directory for files ... 14:51:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:51:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:51:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:51:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:51:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:51:04 INFO - (blobuploader) - INFO - Done attempting. 14:51:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:51:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:51:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:51:09 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:51:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:51:09 INFO - (blobuploader) - INFO - Done attempting. 14:51:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:51:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:51:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:51:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:51:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:51:10 INFO - (blobuploader) - INFO - Done attempting. 14:51:10 INFO - (blobuploader) - INFO - Iteration through files over. 14:51:10 INFO - Return code: 0 14:51:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:51:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:51:10 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d40f994d6f21f73ff97973cbc576ee1defd5ee566891916ed769e81bab33c6d6411b4b9ba9690e3186e1b3758f29f9e99eb9ab05cedcd5d1fc21905fe1701833", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/06efc3e54b0cad76a3f8b955a67e8765421bbd184521c69ba028556f8660124d7320032bb87ee6ba395740231ab3b181b6ad42e271338f3523075b1823ec879f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bc3f1ee03e9576b2d94dba8687863c7bacc6f214856335481a0e4d637f0622b597028f0321f918f961d45cc93921610d79db1266630b11f843f71cfb2c3b797a"} 14:51:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:51:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:51:10 INFO - Contents: 14:51:10 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d40f994d6f21f73ff97973cbc576ee1defd5ee566891916ed769e81bab33c6d6411b4b9ba9690e3186e1b3758f29f9e99eb9ab05cedcd5d1fc21905fe1701833", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/06efc3e54b0cad76a3f8b955a67e8765421bbd184521c69ba028556f8660124d7320032bb87ee6ba395740231ab3b181b6ad42e271338f3523075b1823ec879f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bc3f1ee03e9576b2d94dba8687863c7bacc6f214856335481a0e4d637f0622b597028f0321f918f961d45cc93921610d79db1266630b11f843f71cfb2c3b797a"} 14:51:10 INFO - Running post-run listener: copy_logs_to_upload_dir 14:51:10 INFO - Copying logs to upload dir... 14:51:10 INFO - mkdir: /builds/slave/test/build/upload/logs 14:51:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.652597 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-05-25 14:51:09.669051) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-25 14:51:09.672886) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1464211827.826212-1070013129 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d40f994d6f21f73ff97973cbc576ee1defd5ee566891916ed769e81bab33c6d6411b4b9ba9690e3186e1b3758f29f9e99eb9ab05cedcd5d1fc21905fe1701833", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/06efc3e54b0cad76a3f8b955a67e8765421bbd184521c69ba028556f8660124d7320032bb87ee6ba395740231ab3b181b6ad42e271338f3523075b1823ec879f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bc3f1ee03e9576b2d94dba8687863c7bacc6f214856335481a0e4d637f0622b597028f0321f918f961d45cc93921610d79db1266630b11f843f71cfb2c3b797a"} build_url:https://queue.taskcluster.net/v1/task/ZpuQaJRHT0StAa9eksnCSg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011302 build_url: 'https://queue.taskcluster.net/v1/task/ZpuQaJRHT0StAa9eksnCSg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d40f994d6f21f73ff97973cbc576ee1defd5ee566891916ed769e81bab33c6d6411b4b9ba9690e3186e1b3758f29f9e99eb9ab05cedcd5d1fc21905fe1701833", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/06efc3e54b0cad76a3f8b955a67e8765421bbd184521c69ba028556f8660124d7320032bb87ee6ba395740231ab3b181b6ad42e271338f3523075b1823ec879f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bc3f1ee03e9576b2d94dba8687863c7bacc6f214856335481a0e4d637f0622b597028f0321f918f961d45cc93921610d79db1266630b11f843f71cfb2c3b797a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-25 14:51:09.698211) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 14:51:09.698553) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1464211827.826212-1070013129 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004744 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 14:51:09.750334) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-25 14:51:09.750688) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-25 14:51:09.751001) ========= ========= Total master_lag: 0.12 =========