builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-041 starttime: 1463051492.77 results: success (0) buildid: 20160512013006 builduid: 5e8d256c49614c3881adb15569e555df revision: 5190ada5abfef2d6308277f2948bc1286409d659 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-12 04:11:32.773881) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-12 04:11:32.774415) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-12 04:11:32.774741) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-12 04:11:32.805055) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 04:11:32.805320) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1463051464.510196-153851708 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-12 04:11:32-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 50.7M=0s 2016-05-12 04:11:33 (50.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.090703 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 04:11:32.910377) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 04:11:32.910714) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1463051464.510196-153851708 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019855 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 04:11:32.960685) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-12 04:11:32.961026) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 5190ada5abfef2d6308277f2948bc1286409d659 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 5190ada5abfef2d6308277f2948bc1286409d659 --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=8c6b6742ce8f6f39ef4ce27d000001f1-1463051464.510196-153851708 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-12 04:11:33,121 truncating revision to first 12 chars 2016-05-12 04:11:33,121 Setting DEBUG logging. 2016-05-12 04:11:33,121 attempt 1/10 2016-05-12 04:11:33,121 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/5190ada5abfe?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-12 04:11:34,015 unpacking tar archive at: mozilla-inbound-5190ada5abfe/testing/mozharness/ program finished with exit code 0 elapsedTime=1.208096 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-12 04:11:34.182112) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-12 04:11:34.182432) ========= script_repo_revision: 5190ada5abfef2d6308277f2948bc1286409d659 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-12 04:11:34.182854) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-12 04:11:34.183116) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-12 04:11:34.190707) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-05-12 04:11:34.190993) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=8c6b6742ce8f6f39ef4ce27d000001f1-1463051464.510196-153851708 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:11:34 INFO - MultiFileLogger online at 20160512 04:11:34 in /builds/slave/test 04:11:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 04:11:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:11:34 INFO - {'append_to_log': False, 04:11:34 INFO - 'base_work_dir': '/builds/slave/test', 04:11:34 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 04:11:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:11:34 INFO - 'branch': 'Mozilla-Inbound', 04:11:34 INFO - 'buildbot_json_path': 'buildprops.json', 04:11:34 INFO - 'config_files': ('talos/linux_config.py',), 04:11:34 INFO - 'default_actions': ('clobber', 04:11:34 INFO - 'read-buildbot-config', 04:11:34 INFO - 'download-and-extract', 04:11:34 INFO - 'populate-webroot', 04:11:34 INFO - 'create-virtualenv', 04:11:34 INFO - 'install', 04:11:34 INFO - 'run-tests'), 04:11:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:11:34 INFO - 'download_minidump_stackwalk': True, 04:11:34 INFO - 'download_symbols': 'ondemand', 04:11:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:11:34 INFO - 'tooltool.py': '/tools/tooltool.py', 04:11:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:11:34 INFO - '/tools/misc-python/virtualenv.py')}, 04:11:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:11:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:11:34 INFO - 'installer_path': 'installer.exe', 04:11:34 INFO - 'log_level': 'info', 04:11:34 INFO - 'log_name': 'talos', 04:11:34 INFO - 'log_to_console': True, 04:11:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:11:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:11:34 INFO - 'opt_config_files': (), 04:11:34 INFO - 'pip_index': False, 04:11:34 INFO - 'sps_profile': False, 04:11:34 INFO - 'sps_profile_interval': 0, 04:11:34 INFO - 'suite': 'dromaeojs', 04:11:34 INFO - 'system_bits': '32', 04:11:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:11:34 INFO - 'title': 'talos-linux64-ix-041', 04:11:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:11:34 INFO - 'use_talos_json': True, 04:11:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:11:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:11:34 INFO - 'work_dir': 'build'} 04:11:34 INFO - ##### 04:11:34 INFO - ##### Running clobber step. 04:11:34 INFO - ##### 04:11:34 INFO - Running pre-action listener: _resource_record_pre_action 04:11:34 INFO - Running main action method: clobber 04:11:34 INFO - rmtree: /builds/slave/test/build 04:11:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:11:35 INFO - Running post-action listener: _resource_record_post_action 04:11:35 INFO - ##### 04:11:35 INFO - ##### Finished clobber step (success) 04:11:35 INFO - ##### 04:11:35 INFO - ##### 04:11:35 INFO - ##### Running read-buildbot-config step. 04:11:35 INFO - ##### 04:11:35 INFO - Running pre-action listener: _resource_record_pre_action 04:11:35 INFO - Running main action method: read_buildbot_config 04:11:35 INFO - Using buildbot properties: 04:11:35 INFO - { 04:11:35 INFO - "project": "", 04:11:35 INFO - "product": "firefox", 04:11:35 INFO - "script_repo_revision": "production", 04:11:35 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 04:11:35 INFO - "repository": "", 04:11:35 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 04:11:35 INFO - "buildid": "20160512013006", 04:11:35 INFO - "pgo_build": "True", 04:11:35 INFO - "basedir": "/builds/slave/test", 04:11:35 INFO - "buildnumber": 983, 04:11:35 INFO - "slavename": "talos-linux64-ix-041", 04:11:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:11:35 INFO - "platform": "ubuntu64_hw", 04:11:35 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 04:11:35 INFO - "branch": "mozilla-inbound", 04:11:35 INFO - "repo_path": "integration/mozilla-inbound", 04:11:35 INFO - "revision": "5190ada5abfef2d6308277f2948bc1286409d659", 04:11:35 INFO - "stage_platform": "linux64-pgo", 04:11:35 INFO - "builduid": "5e8d256c49614c3881adb15569e555df", 04:11:35 INFO - "slavebuilddir": "test" 04:11:35 INFO - } 04:11:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/XRYBGfG2Q3aB06rFyVAMPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 04:11:35 INFO - Running post-action listener: _resource_record_post_action 04:11:35 INFO - ##### 04:11:35 INFO - ##### Finished read-buildbot-config step (success) 04:11:35 INFO - ##### 04:11:35 INFO - ##### 04:11:35 INFO - ##### Running download-and-extract step. 04:11:35 INFO - ##### 04:11:35 INFO - Running pre-action listener: _resource_record_pre_action 04:11:35 INFO - Running main action method: download_and_extract 04:11:35 INFO - mkdir: /builds/slave/test/build/tests 04:11:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:11:35 INFO - https://queue.taskcluster.net/v1/task/XRYBGfG2Q3aB06rFyVAMPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:11:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XRYBGfG2Q3aB06rFyVAMPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:11:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XRYBGfG2Q3aB06rFyVAMPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:11:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XRYBGfG2Q3aB06rFyVAMPw/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 04:11:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XRYBGfG2Q3aB06rFyVAMPw/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 04:11:36 INFO - Downloaded 1361 bytes. 04:11:36 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:11:36 INFO - Using the following test package requirements: 04:11:36 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 04:11:36 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:11:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:11:36 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:11:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:11:36 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:11:36 INFO - u'jsshell-linux-x86_64.zip'], 04:11:36 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:11:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:11:36 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 04:11:36 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:11:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:11:36 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:11:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:11:36 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:11:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:11:36 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:11:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:11:36 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:11: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')]} 04:11:36 INFO - https://queue.taskcluster.net/v1/task/XRYBGfG2Q3aB06rFyVAMPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:11:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XRYBGfG2Q3aB06rFyVAMPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:11:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XRYBGfG2Q3aB06rFyVAMPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:11:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XRYBGfG2Q3aB06rFyVAMPw/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 04:11:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XRYBGfG2Q3aB06rFyVAMPw/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 04:11:39 INFO - Downloaded 23903718 bytes. 04:11:39 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'] 04:11:39 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 04:11:40 INFO - Return code: 0 04:11:40 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 04:11:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:11:40 INFO - https://queue.taskcluster.net/v1/task/XRYBGfG2Q3aB06rFyVAMPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:11:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XRYBGfG2Q3aB06rFyVAMPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:11:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XRYBGfG2Q3aB06rFyVAMPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:11:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XRYBGfG2Q3aB06rFyVAMPw/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 04:11:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XRYBGfG2Q3aB06rFyVAMPw/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 04:11:43 INFO - Downloaded 23903718 bytes. 04:11:43 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'] 04:11:43 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 04:11:44 INFO - Return code: 0 04:11:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:11:44 INFO - https://queue.taskcluster.net/v1/task/XRYBGfG2Q3aB06rFyVAMPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:11:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XRYBGfG2Q3aB06rFyVAMPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 04:11:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XRYBGfG2Q3aB06rFyVAMPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 04:11:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XRYBGfG2Q3aB06rFyVAMPw/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 04:11:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XRYBGfG2Q3aB06rFyVAMPw/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 04:11:45 INFO - Downloaded 10840239 bytes. 04:11:45 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'] 04:11:45 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 04:11:45 INFO - Return code: 0 04:11: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')]} 04:11:45 INFO - https://queue.taskcluster.net/v1/task/XRYBGfG2Q3aB06rFyVAMPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:11:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XRYBGfG2Q3aB06rFyVAMPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:11:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XRYBGfG2Q3aB06rFyVAMPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:11:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XRYBGfG2Q3aB06rFyVAMPw/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 04:11:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XRYBGfG2Q3aB06rFyVAMPw/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 04:11:50 INFO - Downloaded 58324169 bytes. 04:11:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XRYBGfG2Q3aB06rFyVAMPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:11:50 INFO - mkdir: /builds/slave/test/properties 04:11:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:11:50 INFO - Writing to file /builds/slave/test/properties/build_url 04:11:50 INFO - Contents: 04:11:50 INFO - build_url:https://queue.taskcluster.net/v1/task/XRYBGfG2Q3aB06rFyVAMPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:11:51 INFO - Running post-action listener: _resource_record_post_action 04:11:51 INFO - Running post-action listener: set_extra_try_arguments 04:11:51 INFO - ##### 04:11:51 INFO - ##### Finished download-and-extract step (success) 04:11:51 INFO - ##### 04:11:51 INFO - ##### 04:11:51 INFO - ##### Running populate-webroot step. 04:11:51 INFO - ##### 04:11:51 INFO - Running pre-action listener: _resource_record_pre_action 04:11:51 INFO - Running main action method: populate_webroot 04:11:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:11:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:11:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:11:51 INFO - '--tppagecycles', 04:11:51 INFO - '7'], 04:11:51 INFO - 'tests': ['tsvgm']}}, 04:11:51 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:11:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:11:51 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:11:51 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:11:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:11:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:11:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:11:51 INFO - 'talos_options': ['--disable-e10s'], 04:11:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:11:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:11:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:11:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:11:51 INFO - 'talos_options': ['--disable-e10s'], 04:11:51 INFO - 'tests': ['damp', 'tps']}, 04:11:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:11:51 INFO - 'tests': ['damp', 'tps']}, 04:11:51 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:11:51 INFO - 'tests': ['dromaeo_dom']}, 04:11:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:11:51 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:11:51 INFO - 'tests': ['a11yr', 04:11:51 INFO - 'ts_paint', 04:11:51 INFO - 'tpaint', 04:11:51 INFO - 'sessionrestore', 04:11:51 INFO - 'sessionrestore_no_auto_restore', 04:11:51 INFO - 'tabpaint']}, 04:11:51 INFO - 'other-e10s': {'tests': ['a11yr', 04:11:51 INFO - 'ts_paint', 04:11:51 INFO - 'tpaint', 04:11:51 INFO - 'sessionrestore', 04:11:51 INFO - 'sessionrestore_no_auto_restore', 04:11:51 INFO - 'tabpaint']}, 04:11:51 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:11:51 INFO - 'ts_paint', 04:11:51 INFO - 'tpaint', 04:11:51 INFO - 'sessionrestore', 04:11:51 INFO - 'sessionrestore_no_auto_restore', 04:11:51 INFO - 'tabpaint']}, 04:11:51 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:11:51 INFO - 'ts_paint', 04:11:51 INFO - 'tpaint', 04:11:51 INFO - 'sessionrestore', 04:11:51 INFO - 'sessionrestore_no_auto_restore', 04:11:51 INFO - 'tabpaint']}, 04:11:51 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:11:51 INFO - 'tests': ['a11yr', 04:11:51 INFO - 'ts_paint', 04:11:51 INFO - 'tpaint', 04:11:51 INFO - 'sessionrestore', 04:11:51 INFO - 'sessionrestore_no_auto_restore', 04:11:51 INFO - 'tabpaint']}, 04:11:51 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:11:51 INFO - 'tests': ['a11yr', 04:11:51 INFO - 'ts_paint', 04:11:51 INFO - 'tpaint', 04:11:51 INFO - 'sessionrestore', 04:11:51 INFO - 'sessionrestore_no_auto_restore', 04:11:51 INFO - 'tabpaint']}, 04:11:51 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:11:51 INFO - 'tests': ['tsvgx', 04:11:51 INFO - 'tsvgr_opacity', 04:11:51 INFO - 'tart', 04:11:51 INFO - 'tscrollx', 04:11:51 INFO - 'cart']}, 04:11:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:11:51 INFO - 'tsvgr_opacity', 04:11:51 INFO - 'tart', 04:11:51 INFO - 'tscrollx', 04:11:51 INFO - 'cart']}, 04:11:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:11:51 INFO - 'talos_options': ['--disable-e10s'], 04:11:51 INFO - 'tests': ['tp5o']}, 04:11:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:11:51 INFO - 'tests': ['tp5o']}, 04:11:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:11:51 INFO - 'talos_options': ['--disable-e10s', 04:11:51 INFO - '--xperf_path', 04:11:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:11:51 INFO - 'tests': ['tp5n']}, 04:11:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:11:51 INFO - 'talos_options': ['--xperf_path', 04:11:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:11:51 INFO - 'tests': ['tp5n']}}, 04:11:51 INFO - 'talos.zip': {'path': '', 04:11:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:11:51 INFO - Running post-action listener: _resource_record_post_action 04:11:51 INFO - ##### 04:11:51 INFO - ##### Finished populate-webroot step (success) 04:11:51 INFO - ##### 04:11:51 INFO - ##### 04:11:51 INFO - ##### Running create-virtualenv step. 04:11:51 INFO - ##### 04:11:51 INFO - Running pre-action listener: _resource_record_pre_action 04:11:51 INFO - Running main action method: create_virtualenv 04:11:51 INFO - Creating virtualenv /builds/slave/test/build/venv 04:11:51 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 04:11:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:11:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:11:51 INFO - Using real prefix '/usr' 04:11:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:11:51 INFO - Installing distribute.............................................................................................................................................................................................done. 04:11:53 INFO - Installing pip.................done. 04:11:53 INFO - Return code: 0 04:11:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:11:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:11:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:11:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:11:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:11:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:53 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 0x7f537a96cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd1e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdad9c0>, '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 0xdae8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdaed50>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1463051464.510196-153851708', '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 04:11:53 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 04:11:53 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 04:11:53 INFO - Using env: {'DISPLAY': ':0', 04:11:53 INFO - 'HOME': '/home/cltbld', 04:11:53 INFO - 'LANG': 'en_US.UTF-8', 04:11:53 INFO - 'LANGUAGE': 'en_US:en', 04:11:53 INFO - 'LOGNAME': 'cltbld', 04:11:53 INFO - 'MAIL': '/var/mail/cltbld', 04:11:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:11:53 INFO - 'MOZ_NO_REMOTE': '1', 04:11:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:11:53 INFO - 'NO_EM_RESTART': '1', 04:11:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:11:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:11:53 INFO - 'PWD': '/builds/slave/test', 04:11:53 INFO - 'SHELL': '/bin/bash', 04:11:53 INFO - 'SHLVL': '1', 04:11:53 INFO - 'TERM': 'linux', 04:11:53 INFO - 'TMOUT': '86400', 04:11:53 INFO - 'USER': 'cltbld', 04:11:53 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1463051464.510196-153851708', 04:11:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:11:53 INFO - '_': '/tools/buildbot/bin/python'} 04:11:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:11:54 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 04:11:54 INFO - Cleaning up... 04:11:54 INFO - Return code: 0 04:11:54 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:11:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:11:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:11:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:11:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:11:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f537a96cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd1e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdad9c0>, '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 0xdae8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdaed50>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1463051464.510196-153851708', '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 04:11:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 04:11:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 04:11:54 INFO - Using env: {'DISPLAY': ':0', 04:11:54 INFO - 'HOME': '/home/cltbld', 04:11:54 INFO - 'LANG': 'en_US.UTF-8', 04:11:54 INFO - 'LANGUAGE': 'en_US:en', 04:11:54 INFO - 'LOGNAME': 'cltbld', 04:11:54 INFO - 'MAIL': '/var/mail/cltbld', 04:11:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:11:54 INFO - 'MOZ_NO_REMOTE': '1', 04:11:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:11:54 INFO - 'NO_EM_RESTART': '1', 04:11:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:11:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:11:54 INFO - 'PWD': '/builds/slave/test', 04:11:54 INFO - 'SHELL': '/bin/bash', 04:11:54 INFO - 'SHLVL': '1', 04:11:54 INFO - 'TERM': 'linux', 04:11:54 INFO - 'TMOUT': '86400', 04:11:54 INFO - 'USER': 'cltbld', 04:11:54 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1463051464.510196-153851708', 04:11:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:11:54 INFO - '_': '/tools/buildbot/bin/python'} 04:11:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:11:54 INFO - Downloading/unpacking psutil>=0.7.1 04:11:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:11:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:11:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:11:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:11:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:11:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:11:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:11:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:11:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:11:56 INFO - Installing collected packages: psutil 04:11:56 INFO - Running setup.py install for psutil 04:11:56 INFO - building 'psutil._psutil_linux' extension 04:11:56 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 04:11:56 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 04:11:56 INFO - building 'psutil._psutil_posix' extension 04:11:56 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 04:11:56 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 04:11:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:11:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:11:56 INFO - Successfully installed psutil 04:11:56 INFO - Cleaning up... 04:11:56 INFO - Return code: 0 04:11:56 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:11:56 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')]} 04:11:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:11:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:56 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')]} 04:11:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:11:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f537a96cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd1e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdad9c0>, '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 0xdae8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdaed50>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1463051464.510196-153851708', '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 04:11:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 04:11:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 04:11:56 INFO - Using env: {'DISPLAY': ':0', 04:11:56 INFO - 'HOME': '/home/cltbld', 04:11:56 INFO - 'LANG': 'en_US.UTF-8', 04:11:56 INFO - 'LANGUAGE': 'en_US:en', 04:11:56 INFO - 'LOGNAME': 'cltbld', 04:11:56 INFO - 'MAIL': '/var/mail/cltbld', 04:11:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:11:56 INFO - 'MOZ_NO_REMOTE': '1', 04:11:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:11:56 INFO - 'NO_EM_RESTART': '1', 04:11:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:11:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:11:56 INFO - 'PWD': '/builds/slave/test', 04:11:56 INFO - 'SHELL': '/bin/bash', 04:11:56 INFO - 'SHLVL': '1', 04:11:56 INFO - 'TERM': 'linux', 04:11:56 INFO - 'TMOUT': '86400', 04:11:56 INFO - 'USER': 'cltbld', 04:11:56 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1463051464.510196-153851708', 04:11:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:11:56 INFO - '_': '/tools/buildbot/bin/python'} 04:11:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:11:56 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:11: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 04:11: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 04:11: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 04:11: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 04:11: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 04:11: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 04:11:58 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:11:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:11:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:11:59 INFO - Installing collected packages: mozsystemmonitor 04:11:59 INFO - Running setup.py install for mozsystemmonitor 04:11:59 INFO - Successfully installed mozsystemmonitor 04:11:59 INFO - Cleaning up... 04:11:59 INFO - Return code: 0 04:11:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:11: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')]} 04:11:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:11:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11: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')]} 04:11:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:11:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11: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', '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 0x7f537a96cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd1e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdad9c0>, '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 0xdae8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdaed50>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1463051464.510196-153851708', '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 04:11: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:11: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 blobuploader==1.2.4 04:11:59 INFO - Using env: {'DISPLAY': ':0', 04:11:59 INFO - 'HOME': '/home/cltbld', 04:11:59 INFO - 'LANG': 'en_US.UTF-8', 04:11:59 INFO - 'LANGUAGE': 'en_US:en', 04:11:59 INFO - 'LOGNAME': 'cltbld', 04:11:59 INFO - 'MAIL': '/var/mail/cltbld', 04:11:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:11:59 INFO - 'MOZ_NO_REMOTE': '1', 04:11:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:11:59 INFO - 'NO_EM_RESTART': '1', 04:11:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:11:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:11:59 INFO - 'PWD': '/builds/slave/test', 04:11:59 INFO - 'SHELL': '/bin/bash', 04:11:59 INFO - 'SHLVL': '1', 04:11:59 INFO - 'TERM': 'linux', 04:11:59 INFO - 'TMOUT': '86400', 04:11:59 INFO - 'USER': 'cltbld', 04:11:59 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1463051464.510196-153851708', 04:11:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:11:59 INFO - '_': '/tools/buildbot/bin/python'} 04:11:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:11:59 INFO - Downloading/unpacking blobuploader==1.2.4 04:11: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 04:11: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 04:11: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 04:11: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 04:11: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 04:11: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 04:12:01 INFO - Downloading blobuploader-1.2.4.tar.gz 04:12:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:12:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:12: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 04:12: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 04:12: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 04:12: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 04:12: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 04:12: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 04:12:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:12:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:12: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 04:12: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 04:12: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 04:12: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 04:12: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 04:12: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 04:12:01 INFO - Downloading docopt-0.6.1.tar.gz 04:12:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:12:02 INFO - Installing collected packages: blobuploader, requests, docopt 04:12:02 INFO - Running setup.py install for blobuploader 04:12:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:12:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:12:02 INFO - Running setup.py install for requests 04:12:02 INFO - Running setup.py install for docopt 04:12:02 INFO - Successfully installed blobuploader requests docopt 04:12:02 INFO - Cleaning up... 04:12:02 INFO - Return code: 0 04:12:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:12:02 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')]} 04:12:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:12:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:02 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')]} 04:12:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:12:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:02 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 0x7f537a96cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd1e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdad9c0>, '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 0xdae8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdaed50>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1463051464.510196-153851708', '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 04:12:02 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 04:12:02 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 04:12:02 INFO - Using env: {'DISPLAY': ':0', 04:12:02 INFO - 'HOME': '/home/cltbld', 04:12:02 INFO - 'LANG': 'en_US.UTF-8', 04:12:02 INFO - 'LANGUAGE': 'en_US:en', 04:12:02 INFO - 'LOGNAME': 'cltbld', 04:12:02 INFO - 'MAIL': '/var/mail/cltbld', 04:12:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:12:02 INFO - 'MOZ_NO_REMOTE': '1', 04:12:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:12:02 INFO - 'NO_EM_RESTART': '1', 04:12:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:12:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:12:02 INFO - 'PWD': '/builds/slave/test', 04:12:02 INFO - 'SHELL': '/bin/bash', 04:12:02 INFO - 'SHLVL': '1', 04:12:02 INFO - 'TERM': 'linux', 04:12:02 INFO - 'TMOUT': '86400', 04:12:02 INFO - 'USER': 'cltbld', 04:12:02 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1463051464.510196-153851708', 04:12:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:12:02 INFO - '_': '/tools/buildbot/bin/python'} 04:12:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:12:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:12:02 INFO - Running setup.py (path:/tmp/pip-TdHSPs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:12:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:12:02 INFO - Running setup.py (path:/tmp/pip-cbCajJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:12:03 INFO - Running setup.py (path:/tmp/pip-lh5jPi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:12:03 INFO - Running setup.py (path:/tmp/pip-SS8n1o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:12:03 INFO - Running setup.py (path:/tmp/pip-hU564O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:12:03 INFO - Running setup.py (path:/tmp/pip-CE_eer-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:12:03 INFO - Running setup.py (path:/tmp/pip-K4Feca-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:12:03 INFO - Running setup.py (path:/tmp/pip-raTPCN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:12:03 INFO - Running setup.py (path:/tmp/pip-Mt3Ouy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:12:03 INFO - Running setup.py (path:/tmp/pip-3StE2s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:12:03 INFO - Running setup.py (path:/tmp/pip-tTx1JV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:12:03 INFO - Running setup.py (path:/tmp/pip-KwbJIi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:12:03 INFO - Running setup.py (path:/tmp/pip-Z1XUR5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:12:03 INFO - Running setup.py (path:/tmp/pip-itv056-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:12:03 INFO - Running setup.py (path:/tmp/pip-0rMAKb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:12:03 INFO - Running setup.py (path:/tmp/pip-a1wjhl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:12:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:12:04 INFO - Running setup.py (path:/tmp/pip-XmWIVw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:12:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:12:04 INFO - Running setup.py install for manifestparser 04:12:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:12:04 INFO - Running setup.py install for mozcrash 04:12:04 INFO - Running setup.py install for mozdebug 04:12:04 INFO - Running setup.py install for mozdevice 04:12:04 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:12:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:12:04 INFO - Running setup.py install for mozfile 04:12:04 INFO - Running setup.py install for mozhttpd 04:12:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:12:04 INFO - Running setup.py install for mozinfo 04:12:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:12:04 INFO - Running setup.py install for mozInstall 04:12:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:12:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:12:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:12:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:12:04 INFO - Running setup.py install for mozleak 04:12:04 INFO - Running setup.py install for mozlog 04:12:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:12:05 INFO - Running setup.py install for moznetwork 04:12:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:12:05 INFO - Running setup.py install for mozprocess 04:12:05 INFO - Running setup.py install for mozprofile 04:12:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:12:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:12:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:12:05 INFO - Running setup.py install for mozrunner 04:12:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:12:05 INFO - Running setup.py install for mozscreenshot 04:12:05 INFO - Running setup.py install for moztest 04:12:05 INFO - Running setup.py install for mozversion 04:12:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:12:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:12:05 INFO - Cleaning up... 04:12:05 INFO - Return code: 0 04:12:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:12:05 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')]} 04:12:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:12:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:05 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')]} 04:12:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:12:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:05 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 0x7f537a96cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd1e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdad9c0>, '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 0xdae8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdaed50>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1463051464.510196-153851708', '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 04:12:05 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 04:12:05 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 04:12:05 INFO - Using env: {'DISPLAY': ':0', 04:12:05 INFO - 'HOME': '/home/cltbld', 04:12:05 INFO - 'LANG': 'en_US.UTF-8', 04:12:05 INFO - 'LANGUAGE': 'en_US:en', 04:12:05 INFO - 'LOGNAME': 'cltbld', 04:12:05 INFO - 'MAIL': '/var/mail/cltbld', 04:12:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:12:05 INFO - 'MOZ_NO_REMOTE': '1', 04:12:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:12:05 INFO - 'NO_EM_RESTART': '1', 04:12:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:12:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:12:05 INFO - 'PWD': '/builds/slave/test', 04:12:05 INFO - 'SHELL': '/bin/bash', 04:12:05 INFO - 'SHLVL': '1', 04:12:05 INFO - 'TERM': 'linux', 04:12:05 INFO - 'TMOUT': '86400', 04:12:05 INFO - 'USER': 'cltbld', 04:12:05 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1463051464.510196-153851708', 04:12:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:12:05 INFO - '_': '/tools/buildbot/bin/python'} 04:12:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:12:06 INFO - Running setup.py (path:/tmp/pip-xALBDf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:12:06 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)) 04:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:12:06 INFO - Running setup.py (path:/tmp/pip-v01puG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:12:06 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)) 04:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:12:06 INFO - Running setup.py (path:/tmp/pip-jcAfqC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:12:06 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)) 04:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:12:06 INFO - Running setup.py (path:/tmp/pip-XkE8UR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:12:06 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)) 04:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:12:06 INFO - Running setup.py (path:/tmp/pip-gK13ju-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:12:06 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)) 04:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:12:06 INFO - Running setup.py (path:/tmp/pip-xniTro-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:12:06 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)) 04:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:12:06 INFO - Running setup.py (path:/tmp/pip-ANvVe6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:12:06 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)) 04:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:12:06 INFO - Running setup.py (path:/tmp/pip-Mp_E3Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:12:06 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)) 04:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:12:06 INFO - Running setup.py (path:/tmp/pip-BABMZw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:12:06 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)) 04:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:12:06 INFO - Running setup.py (path:/tmp/pip-9VhcKT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:12:06 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)) 04:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:12:06 INFO - Running setup.py (path:/tmp/pip-a7hSTo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:12:06 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)) 04:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:12:06 INFO - Running setup.py (path:/tmp/pip-c5DEHj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:12:06 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)) 04:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:12:06 INFO - Running setup.py (path:/tmp/pip-yUPuoQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:12:07 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)) 04:12:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:12:07 INFO - Running setup.py (path:/tmp/pip-GJKlmA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:12:07 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)) 04:12:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:12:07 INFO - Running setup.py (path:/tmp/pip-_pxiw2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:12:07 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)) 04:12:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:12:07 INFO - Running setup.py (path:/tmp/pip-Edt5Pg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:12:07 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)) 04:12:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:12:07 INFO - Running setup.py (path:/tmp/pip-yxnIqs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:12:07 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)) 04:12:07 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)) 04:12:07 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)) 04:12:07 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)) 04:12:07 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)) 04:12:07 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)) 04:12:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:12:07 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 04:12:07 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 04:12:07 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 04:12:07 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 04:12:07 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 04:12:07 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 04:12:09 INFO - Downloading blessings-1.6.tar.gz 04:12:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:12:09 INFO - Installing collected packages: blessings 04:12:09 INFO - Running setup.py install for blessings 04:12:09 INFO - Successfully installed blessings 04:12:09 INFO - Cleaning up... 04:12:09 INFO - Return code: 0 04:12:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:12:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:12:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:12:09 INFO - Reading from file tmpfile_stdout 04:12:09 INFO - Current package versions: 04:12:09 INFO - argparse == 1.2.1 04:12:09 INFO - blessings == 1.6 04:12:09 INFO - blobuploader == 1.2.4 04:12:09 INFO - docopt == 0.6.1 04:12:09 INFO - manifestparser == 1.1 04:12:09 INFO - mozInstall == 1.12 04:12:09 INFO - mozcrash == 0.17 04:12:09 INFO - mozdebug == 0.1 04:12:09 INFO - mozdevice == 0.48 04:12:09 INFO - mozfile == 1.2 04:12:09 INFO - mozhttpd == 0.7 04:12:09 INFO - mozinfo == 0.9 04:12:09 INFO - mozleak == 0.1 04:12:09 INFO - mozlog == 3.2 04:12:09 INFO - moznetwork == 0.27 04:12:09 INFO - mozprocess == 0.22 04:12:09 INFO - mozprofile == 0.28 04:12:09 INFO - mozrunner == 6.11 04:12:09 INFO - mozscreenshot == 0.1 04:12:09 INFO - mozsystemmonitor == 0.0 04:12:09 INFO - moztest == 0.7 04:12:09 INFO - mozversion == 1.4 04:12:09 INFO - psutil == 3.1.1 04:12:09 INFO - requests == 1.2.3 04:12:09 INFO - wsgiref == 0.1.2 04:12:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:12:09 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')]} 04:12:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:12:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:09 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')]} 04:12:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:12:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:09 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 0x7f537a96cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd1e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdad9c0>, '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 0xdae8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdaed50>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1463051464.510196-153851708', '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 04:12:09 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 04:12:09 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 04:12:09 INFO - Using env: {'DISPLAY': ':0', 04:12:09 INFO - 'HOME': '/home/cltbld', 04:12:09 INFO - 'LANG': 'en_US.UTF-8', 04:12:09 INFO - 'LANGUAGE': 'en_US:en', 04:12:09 INFO - 'LOGNAME': 'cltbld', 04:12:09 INFO - 'MAIL': '/var/mail/cltbld', 04:12:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:12:09 INFO - 'MOZ_NO_REMOTE': '1', 04:12:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:12:09 INFO - 'NO_EM_RESTART': '1', 04:12:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:12:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:12:09 INFO - 'PWD': '/builds/slave/test', 04:12:09 INFO - 'SHELL': '/bin/bash', 04:12:09 INFO - 'SHLVL': '1', 04:12:09 INFO - 'TERM': 'linux', 04:12:09 INFO - 'TMOUT': '86400', 04:12:09 INFO - 'USER': 'cltbld', 04:12:09 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1463051464.510196-153851708', 04:12:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:12:09 INFO - '_': '/tools/buildbot/bin/python'} 04:12:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:12:09 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)) 04:12:09 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)) 04:12:09 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)) 04:12:09 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)) 04:12:09 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)) 04:12:09 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)) 04:12:09 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)) 04:12:09 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)) 04:12:09 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)) 04:12:09 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)) 04:12:09 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)) 04:12:09 INFO - Cleaning up... 04:12:09 INFO - Return code: 0 04:12:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:12:09 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')]} 04:12:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:12:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:09 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')]} 04:12:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:12:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:09 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 0x7f537a96cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd1e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdad9c0>, '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 0xdae8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdaed50>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1463051464.510196-153851708', '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 04:12:09 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 04:12:09 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 04:12:09 INFO - Using env: {'DISPLAY': ':0', 04:12:09 INFO - 'HOME': '/home/cltbld', 04:12:09 INFO - 'LANG': 'en_US.UTF-8', 04:12:09 INFO - 'LANGUAGE': 'en_US:en', 04:12:09 INFO - 'LOGNAME': 'cltbld', 04:12:09 INFO - 'MAIL': '/var/mail/cltbld', 04:12:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:12:09 INFO - 'MOZ_NO_REMOTE': '1', 04:12:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:12:09 INFO - 'NO_EM_RESTART': '1', 04:12:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:12:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:12:09 INFO - 'PWD': '/builds/slave/test', 04:12:09 INFO - 'SHELL': '/bin/bash', 04:12:09 INFO - 'SHLVL': '1', 04:12:09 INFO - 'TERM': 'linux', 04:12:09 INFO - 'TMOUT': '86400', 04:12:09 INFO - 'USER': 'cltbld', 04:12:09 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1463051464.510196-153851708', 04:12:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:12:09 INFO - '_': '/tools/buildbot/bin/python'} 04:12:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:12:10 INFO - Downloading/unpacking jsonschema 04:12:10 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 04:12:10 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 04:12:10 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 04:12:10 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 04:12:10 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 04:12:10 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 04:12:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:12:11 INFO - Downloading/unpacking functools32 (from jsonschema) 04:12:11 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 04:12:11 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 04:12:11 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 04:12:11 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 04:12:11 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 04:12:11 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 04:12:12 INFO - Downloading functools32-3.2.3-2.tar.gz 04:12:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:12:12 INFO - warning: no files found matching '*.txt' 04:12:12 INFO - no previously-included directories found matching 'build' 04:12:12 INFO - no previously-included directories found matching 'dist' 04:12:12 INFO - no previously-included directories found matching '.git*' 04:12:12 INFO - Installing collected packages: jsonschema, functools32 04:12:12 INFO - Running setup.py install for functools32 04:12:12 INFO - warning: no files found matching '*.txt' 04:12:12 INFO - no previously-included directories found matching 'build' 04:12:12 INFO - no previously-included directories found matching 'dist' 04:12:12 INFO - no previously-included directories found matching '.git*' 04:12:12 INFO - Successfully installed jsonschema functools32 04:12:12 INFO - Cleaning up... 04:12:12 INFO - Return code: 0 04:12:12 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:12:12 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')]} 04:12:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:12:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:12 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')]} 04:12:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:12:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:12 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 0x7f537a96cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd1e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdad9c0>, '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 0xdae8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdaed50>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1463051464.510196-153851708', '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 04:12:12 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 04:12:12 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 04:12:12 INFO - Using env: {'DISPLAY': ':0', 04:12:12 INFO - 'HOME': '/home/cltbld', 04:12:12 INFO - 'LANG': 'en_US.UTF-8', 04:12:12 INFO - 'LANGUAGE': 'en_US:en', 04:12:12 INFO - 'LOGNAME': 'cltbld', 04:12:12 INFO - 'MAIL': '/var/mail/cltbld', 04:12:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:12:12 INFO - 'MOZ_NO_REMOTE': '1', 04:12:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:12:12 INFO - 'NO_EM_RESTART': '1', 04:12:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:12:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:12:12 INFO - 'PWD': '/builds/slave/test', 04:12:12 INFO - 'SHELL': '/bin/bash', 04:12:12 INFO - 'SHLVL': '1', 04:12:12 INFO - 'TERM': 'linux', 04:12:12 INFO - 'TMOUT': '86400', 04:12:12 INFO - 'USER': 'cltbld', 04:12:12 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1463051464.510196-153851708', 04:12:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:12:12 INFO - '_': '/tools/buildbot/bin/python'} 04:12:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:12:12 INFO - Downloading/unpacking flake8 04:12:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:12:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:12:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:12:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:12:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:12:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:12:14 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:12:14 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:12:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:12:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:12:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:12:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:12:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:12:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:12:14 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:12:14 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:12:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:12:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:12:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:12:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:12:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:12:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:12:14 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:12:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:12:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:12:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:12:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:12:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:12:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:12:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:12:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:12:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:12:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:12:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:12:15 INFO - no previously-included directories found matching 'docs/_build' 04:12:15 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:12:15 INFO - Running setup.py install for pep8 04:12:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:12:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:12:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:12:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:12:15 INFO - no previously-included directories found matching 'docs/_build' 04:12:15 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:12:15 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:12:15 INFO - Cleaning up... 04:12:15 INFO - Return code: 0 04:12:15 INFO - Running post-action listener: _resource_record_post_action 04:12:15 INFO - Running post-action listener: _start_resource_monitoring 04:12:15 INFO - Starting resource monitoring. 04:12:15 INFO - ##### 04:12:15 INFO - ##### Finished create-virtualenv step (success) 04:12:15 INFO - ##### 04:12:15 INFO - ##### 04:12:15 INFO - ##### Running install step. 04:12:15 INFO - ##### 04:12:15 INFO - Running pre-action listener: _resource_record_pre_action 04:12:15 INFO - Running main action method: install 04:12:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:12:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:12:15 INFO - Reading from file tmpfile_stdout 04:12:15 INFO - Detecting whether we're running mozinstall >=1.0... 04:12:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:12:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:12:15 INFO - Reading from file tmpfile_stdout 04:12:15 INFO - Output received: 04:12:15 INFO - Usage: mozinstall [options] installer 04:12:15 INFO - Options: 04:12:15 INFO - -h, --help show this help message and exit 04:12:15 INFO - -d DEST, --destination=DEST 04:12:15 INFO - Directory to install application into. [default: 04:12:15 INFO - "/builds/slave/test"] 04:12:15 INFO - --app=APP Application being installed. [default: firefox] 04:12:15 INFO - mkdir: /builds/slave/test/build/application 04:12:15 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'] 04:12:15 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 04:12:32 INFO - Reading from file tmpfile_stdout 04:12:32 INFO - Output received: 04:12:32 INFO - /builds/slave/test/build/application/firefox/firefox 04:12:32 INFO - Running post-action listener: _resource_record_post_action 04:12:32 INFO - ##### 04:12:32 INFO - ##### Finished install step (success) 04:12:32 INFO - ##### 04:12:32 INFO - ##### 04:12:32 INFO - ##### Running run-tests step. 04:12:32 INFO - ##### 04:12:32 INFO - Running pre-action listener: _resource_record_pre_action 04:12:32 INFO - Running main action method: run_tests 04:12:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:12:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:12:32 INFO - Python 2.7.3 04:12:32 INFO - Return code: 0 04:12:32 INFO - grabbing minidump binary from tooltool 04:12:32 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')]} 04:12:32 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 0xdad9c0>, '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 0xdae8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdaed50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:12:32 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 04:12:32 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 04:12:32 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 04:12:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:12:32 INFO - Return code: 0 04:12:32 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:12:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:12:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:12:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:12:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:12:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:12:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:12:33 INFO - Return code: 0 04:12:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XRYBGfG2Q3aB06rFyVAMPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 04:12:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/XRYBGfG2Q3aB06rFyVAMPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-041 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 04:12:33 INFO - Using env: {'DISPLAY': ':0', 04:12:33 INFO - 'HOME': '/home/cltbld', 04:12:33 INFO - 'LANG': 'en_US.UTF-8', 04:12:33 INFO - 'LANGUAGE': 'en_US:en', 04:12:33 INFO - 'LOGNAME': 'cltbld', 04:12:33 INFO - 'MAIL': '/var/mail/cltbld', 04:12:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:12:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:12:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:12:33 INFO - 'MOZ_NO_REMOTE': '1', 04:12:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:12:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:12:33 INFO - 'NO_EM_RESTART': '1', 04:12:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:12:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:12:33 INFO - 'PWD': '/builds/slave/test', 04:12:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:12:33 INFO - 'SHELL': '/bin/bash', 04:12:33 INFO - 'SHLVL': '1', 04:12:33 INFO - 'TERM': 'linux', 04:12:33 INFO - 'TMOUT': '86400', 04:12:33 INFO - 'USER': 'cltbld', 04:12:33 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1463051464.510196-153851708', 04:12:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:12:33 INFO - '_': '/tools/buildbot/bin/python'} 04:12:33 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XRYBGfG2Q3aB06rFyVAMPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 04:12:33 INFO - mozversion application_buildid: 20160512013006 04:12:33 INFO - mozversion application_changeset: 5190ada5abfef2d6308277f2948bc1286409d659 04:12:33 INFO - mozversion application_display_name: Nightly 04:12:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:12:33 INFO - mozversion application_name: Firefox 04:12:33 INFO - mozversion application_remotingname: firefox 04:12:33 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 04:12:33 INFO - mozversion application_vendor: Mozilla 04:12:33 INFO - mozversion application_version: 49.0a1 04:12:33 INFO - mozversion platform_buildid: 20160512013006 04:12:33 INFO - mozversion platform_changeset: 5190ada5abfef2d6308277f2948bc1286409d659 04:12:33 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 04:12:33 INFO - mozversion platform_version: 49.0a1 04:12:33 INFO - using testdate: 1463051553 04:12:33 INFO - actual date: 1463051553 04:12:33 INFO - starting webserver on 'localhost:38110' 04:12:33 INFO - SUITE-START | Running 2 tests 04:12:33 INFO - TEST-START | dromaeo_css 04:12:33 INFO - operating with platform_type : linux_ 04:12:33 INFO - Initialising browser for dromaeo_css test... 04:12:33 INFO - TEST-INFO | started process 16661 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvlfVZ3/profile http://localhost:38110/getInfo.html) 04:12:37 INFO - PROCESS | 16661 | __metrics Screen width/height:1600/1200 04:12:37 INFO - PROCESS | 16661 | colorDepth:24 04:12:37 INFO - PROCESS | 16661 | Browser inner width/height: 1024/697 04:12:37 INFO - PROCESS | 16661 | __metrics 04:12:38 ERROR - PROCESS | 16661 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:12:39 INFO - TEST-INFO | 16661: exit 0 04:12:39 INFO - Browser initialized. 04:12:39 INFO - Running cycle 1/1 for dromaeo_css test... 04:12:39 INFO - TEST-INFO | started process 16744 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvlfVZ3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:12:51 INFO - PROCESS | 16744 | RSS: Main: 152268800 04:12:51 INFO - PROCESS | 16744 | 04:13:42 INFO - PROCESS | 16744 | 1463051622700 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] 04:15:50 INFO - PROCESS | 16744 | Cycle 1(1): loaded http://localhost:38110/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38110/tests/dromaeo/cssquery-ext.html) 04:15:51 INFO - PROCESS | 16744 | RSS: Main: 241356800 04:15:51 INFO - PROCESS | 16744 | 04:18:53 INFO - PROCESS | 16744 | Cycle 1(1): loaded http://localhost:38110/tests/dromaeo/cssquery-ext.html (next: http://localhost:38110/tests/dromaeo/cssquery-jquery.html) 04:18:54 INFO - PROCESS | 16744 | RSS: Main: 244961280 04:18:54 INFO - PROCESS | 16744 | 04:21:56 INFO - PROCESS | 16744 | Cycle 1(1): loaded http://localhost:38110/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38110/tests/dromaeo/cssquery-mootools.html) 04:21:57 INFO - PROCESS | 16744 | RSS: Main: 241217536 04:21:57 INFO - PROCESS | 16744 | 04:24:59 INFO - PROCESS | 16744 | Cycle 1(1): loaded http://localhost:38110/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38110/tests/dromaeo/cssquery-prototype.html) 04:24:59 INFO - PROCESS | 16744 | RSS: Main: 241721344 04:24:59 INFO - PROCESS | 16744 | 04:28:02 INFO - PROCESS | 16744 | Cycle 1(1): loaded http://localhost:38110/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38110/tests/dromaeo/cssquery-yui.html) 04:28:02 INFO - PROCESS | 16744 | RSS: Main: 204500992 04:28:02 INFO - PROCESS | 16744 | 04:31:05 INFO - PROCESS | 16744 | Cycle 1(1): loaded http://localhost:38110/tests/dromaeo/cssquery-yui.html (next: http://localhost:38110/tests/dromaeo/cssquery-dojo.html) 04:31:05 INFO - PROCESS | 16744 | RSS: Main: 325668864 04:31:05 INFO - PROCESS | 16744 | 04:31:05 INFO - PROCESS | 16744 | __start_tp_report 04:31:05 INFO - PROCESS | 16744 | _x_x_mozilla_page_load 04:31:05 INFO - PROCESS | 16744 | _x_x_mozilla_page_load_details 04:31:05 INFO - PROCESS | 16744 | |i|pagename|runs| 04:31:05 INFO - PROCESS | 16744 | |0;dojo.html;3078.645955715093;3132;3145.308032232909;3164.651888292286;3195.3769015042076;5170.172772356424;5246.160614301703;5259.000789849926;5275.28783614212;5284.57723382129;5292;5294.205869119624;5299.258103865462;5440.755166017529;5455.918161227575;4822;4846.321514987904;4849.490803465638;4854.296127061574;5001.949980500185;4877.34155888954;4916.041371932474;4941.3329200558;4969.751512424383;4973.162449337266;4709.411323584552;4777.761111944406;4786.186348320759;4789.30555069513;4821.951780482185;4778.307145463888;4794.35276237707;4863.440704319013;4868.294097355899;4908.43552991407;4702.247640377524;4818.397700287464;4845.442774080955;4847.224444088929;4874.049560335736;5254.684718916839;5297.311349524537;5306.071437498423;5406.405295417501;5413.810516631938;5794.652320860761;5856.267966504187;5878.735456904449;5886.205362276123;5887.116932460122;5562.666240025571;5630.690312032836;5914.645121292736;5919.644821310735;5921.703914804242;5329.813456529003;5403.918941215885;5425.728713564306;5430.619856609999;5433.26650902131;5907.822765317047;5909.468147866713;5910.911336329958;5915;5915.526757859361;5476.2333273341765;5542.168674698747;5546.112621980464;5685.147227915763;5703.344115426696;5694.202811606378;5695.088785794253;5705.885882282331;5708.20085188074;5734.340550836707;5661.3206415229615;5668.489835914787;5669.914951275734;5671.744771485293;5672.858178545569;5533.142362933751;5553.111502159716;5563.13771365439;5570.275864137636;5681.829545113653;4259.063006138645;4281.721688090264;4286;4287.164003019444;4316.6546676265825;3849.364854798983;3861.942070868939;3871.070942973666;3897.045223920101;3903.785291808978;5236.711980841014;5262.7631756571045;5429.8099566515775;5454.7272636368025;5477.424870388551;5764.452377024176;5779.682117483579;5780.826575202751;5783.392743761844;5828.213191219216;5489.478499542537;5500.147477141049;5502.119660854244;5506.559475241971;5512.972435137799;4604.148232576917;4625.676202665781;4669.463011753692;4712.151812673752;4842.055799119138;5801.390853960358;5817.970910145506;5831.825045248649;5833.095870140135;5837.474627283565;5631.774729010794;5635.746391412315;5636.267285252891;5638.88722225545;5643.435656434323;5666.320041595035;5705.486506214461;5856.677882716492;5869.148973398748;5873.618214816023;5531.751071201725;5560.666360018412;5568.415316391721;5571.7492712828835;5572.91640625399;5646.943530564806;5647.943520564741;5652.547796176378;5652.717364131695;5653.067243904709;5307.389650190277;5490.615656903979;5512;5547.084731019337;5581.302337207849;5536.861578460571;5545.889082218414;5555;5557.083081291703;5559.360673522597;5264.131418315935;5451;5465.92979895033;5472.370677372153;5519.337679478328;5560.388357280777;5596.048671725735;5635.380108188178;5715.028445164249;5736.541076713769;5527.309086364205;5564.137558678412;5566.053770858883;5568;5607.467290607386 04:31:05 INFO - PROCESS | 16744 | |1;ext.html;629.1537881549316;634.7587916591694;639.7632875835941;643.5141468191515;653.5915053091816;42054.7897260514;43644.345334820006;43694.907627309294;47627.285590716165;47737.522624773745;43993;44776.77611611946;44924.77537612307;44933.32600011003;44992.550074499246;8765.254953328975;8855.15875991783;8956.955215223914;8967.95516022419;8970.327225458084;8769.342299327544;8863.689770858022;8867.866981995276;8876.334274929373;8919.063498332678;8962.641494340218;8999.775005624879;9011.95494022529;9016.639334426614;9020.278377729766;8905.910940890573;8942.418742781698;8948;8949.821003579957;8951.462912225223;8791.78020549485;8874.911250887473;8880.955595222047;8890.511021893793;8892.911070889273;40791.18417631631;41037.384439233436;41134.79432602848;41203;41222.38166427506;3407.2504049109157;3456.2569047654624;3530.223350862832;3854.1713531590563;4154.709170358076;31441.528377074363;31960.20099497508;32018.839905800556;32065.679343206502;33453;4371.366151907955;4408.955910440919;4425.589547482489;4482.753448560328;4562.019165879318;322420;322666.9999999977;322730;323050;323589;51970.22044669333;57146.42853571494;57844.71077644585;58508.41491585115;58511;56761;62476.68761656163;62500.81247156419;62759.37240627626;62794.37205627977;15853.762193567105;16059;16078.839211607969;16083.919580402024;16100.838991609933;12416;13123.475060997644;13336.799948000787;13439.395227214798;13463;17875.642487150184;17908.552286192687;17917;17942;17985.910070449827;6350.396712312323;6404.295527491972;6418.229812422539;6527.445167160749;6591;1000.174855744014;1078.805814953316;1105.4196546812987;1128.8193888977723;1146.2434793036723;31985.52021719676;32441.848856943292;32589.348213035606;33080.17299567482;33464.33071338559;1108.6396921000708;1117.1063149480383;1164.057113737875;1174.1604752601932;1189.4528516882158;17106;17179.82820171807;17452.389166379115;17478.751703107744;17578.91210543939;437657;444976;446157;447207;447836;55563.72218138964;56726.43273567211;56726.43273567294;56745.43254567484;56793.71603141958;1399.7620404531253;1407.352617795805;1410.4076287959083;1411.3719394869186;1443.2855736410545;30169.69830301669;31763.68236317607;31972;32143.51784723278;32397.838010809795;50204.49795501998;50333.49666503435;50574.747126264134;50645.746771265905;50660.493395065576;386260;386602;386901;388984;435349;41069.38395924123;41970.58029419667;42341.36487952745;45761.542384575725;45997.310040350094;47392.28911566398;48446.27330589973;50987;51147.48852511427;52455.21317180169;41530.58469415267;42002.57997419986;43110.56889431066;43190;43503;41022.58977410188;42326;42326;42332;42972.78513607412;43021.784891075346;44206;44761.55238447704;44937.32594011158;47200.62671056274;36331.818340908125;38566.69449040077;38841.417378739905;38936.610633893295;39086;29545.26136846596;29641.407171856874;30104.69895301019;30660.846695766377;31191.376172475968 04:31:05 INFO - PROCESS | 16744 | |2;jquery.html;393.4845352588108;396.1048031448926;400.7675548182055;410.4889412681212;410.8603074954515;13906.235157066358;16992.830071699278;17680.73478897816;19196.71204931927;19298.131584078714;14367.209803460806;18049.4585162445;18642.813571864277;18719.3448229312;19414;5659.236003139575;5769.740361683714;5799.101139323411;5821.476067153955;5827.358990511061;4174.227767862955;4369.890752731176;5702.971485142569;6073.331933487313;6386.808395748135;6424.614523128604;6474.449671777905;6493.935060649404;6494.31809659986;6495.805125846232;6250.843593935137;6288.654124023177;6351.269603995554;6357.65032923189;6409.9679501602195;5039.84880453587;5387;5623.606347555673;5637.013522633522;5647.29408823897;12624.873751262554;12806.87193128066;12815.807762883564;12907.161034532724;17602.559936001573;2192.848754403935;2235.653473711561;2436.3665446983737;2512.660790793238;2644.167087367473;9433.811323773487;10426.530806113667;10458.68623941283;12828.294443805587;13291;1798.2986635212278;1848.4269876338244;1862.748528948588;1909.847212223019;1982.6530357187578;78783;81480.59259703664;83977.16022839755;84041.57979210126;84585.57707211425;10991.725206869893;11244.325340479434;11273.94363028196;11327.433628318551;11425.143114266462;15572.454964076203;15628.609284767972;15693.293801778947;15726.05643661384;15758.133302668233;8237.711680091168;8400.495970241805;8418.957905210435;8590.613422396007;8610.526421046903;8172.918270817335;8235.1353107924;8289.4197406181;8356.540390278593;8425.241728244366;4273.252180868336;4436.64506839452;4636.235021221461;4732.881677958009;4795.904081918412;1785.5625371783997;1803.5761596024925;1815.9273629054953;1904.5429097016893;1917.4151883675613;994.4977786218059;1001.4592120254981;1010.8786945566579;1053.9894601054045;1085.918556108295;18794.064092323122;18840.340588079627;19435.51411214731;19497.610047799248;19527;1011.2718842433436;1012.9949350253349;1019.8368261078192;1022.601185537641;1098.2751384086464;10634.468276586294;10914.504044062824;10927.125829933586;10938.453077346101;11001.834972475419;166534.1673291626;337232;474269;484671;485913;54264.728676357154;79919.60040199762;88437.55781221182;89155.55422222847;89574;999.7900440907491;1016.187050359724;1026.7946410717886;1030.1912998296452;1034.5913364221242;16835.074070926217;16927.15364231759;17080.145992700564;17256.396026139024;17568.912155439142;36561.634383656885;37009.629903701694;37979.62020379761;38313.4252986211;39042.609573903894;51996.74001629968;53179;53490.73254633858;53855.73072134614;54055.459445405046;8664.523451210243;8833.64665413402;8964.417312874642;9012.774680633036;9143.177114059767;12617.43221555014;13122.60632181036;13167.407466663832;13437.731245375233;13486;11660.825087623523;11743.41282935867;11824.349660768741;11843.881561184278;12206.694832629255;11586;11596.884031159918;11609.941950290195;11722.70693232676;11783.175177737476;11605.883941160819;11647.475863585989;11734.70663233426;11767.705807354885;12007.159498834997;8263.338932885235;8351.081381047958;8710.520921349133;8958.193762561401;8975.730728078168;10982.341059536133;11893.345865977108;12065.336406497727;12434.191777534432;12435 04:31:05 INFO - PROCESS | 16744 | |3;mootools.html;1199.3163896578953;1530.341952960227;1537.3927298717008;1726.197318247015;1876.362036907452;8083.272505474506;8417.579121043946;8466;8674.522901240429;8687.305015598753;8598.91401085989;8720.215180633742;8781.604827782749;8781.868271975909;8799.252063574604;1992.2529051605648;2268.410213344526;2326.3718795925092;2351.1535847095033;2351.529694061186;2337.8129749620075;2349.659299401586;2358.8820558971984;2360.280114565057;2360.5042940982416;2320.6983092197993;2373.1100837186054;2374.715034195899;2376.9049238030457;2376.964345534818;1989.5225145964937;2231.319447568491;2296.919607813735;2303.585354636165;2319.5592837360846;2271.6251818449937;2276.2602154299752;2284.017872314904;2285.634298512247;2307.7576854430213;8797.956010219972;8850.911490885073;8857.335699822539;8859.424137431046;8867.113288671146;5291.576673866081;5396.163594642837;5425.321834770653;5425.864353391197;5446.101393270145;3265.379577880195;3429.0741499794917;3429.5198672185916;3438.9656103438897;3479.6172421033666;1125.2798209146154;1135.7671677306214;1140.925839820409;1142.23470274916;1152.4698638626242;11926.403679815974;11994.760104797855;12023.51905923762;12042.337671428068;12048.457819398149;4369.6722745794195;4376.6498680105515;4497.415336006298;4524.117797029613;4552.339910712994;9355.391899526508;9363.438193708263;9401.811963760687;9404.24766018717;9411.20004799586;4529.637628989739;5153.5361817436615;5167.68993860362;5203.2195170723935;5242.842714718565;4791.161546729309;4913.287573301851;4924.113659541317;4932.580730637936;4940.580050695731;3794.734368594227;3841.5774264830848;3882.8446862125766;3920.666743326792;3920.8039598019986;1152.2107356460851;1153.2388623508612;1160.6227975907864;1161.8199179127248;1175.7589694112687;834.7662654456761;913.1370854542394;943.8489841625444;946.7396465971775;975.3124047546463;5718.628289161275;5800.622959507618;5891.587588868738;5907.593059026146;6169.56813023093;955.6177528988321;972.2902281334665;997.8353571660595;1011.9392836429838;1028.6399760083912;3985.0834308109297;4003.6797056236014;4022.0950286185957;4068.7355321903983;4069;10461.790764184825;10770.461476926122;10773.51519181623;10912.181586381053;11067.446627668583;10759.731006724738;10822.729431764268;10839.458027098613;10857.185711071701;10950.123990080774;7902.802429939297;8058.798530036679;8119.147489513516;8143.389245806469;8169.2647661710735;5639.661620302795;5688.345840228427;5711.657300561979;5737.770489180386;5813.534917206529;9857.901420985698;9905.207583393456;9913.355631883904;10025.649102281384;10036.447995360326;9797.314188007056;9864.85202721974;9878.308518403643;9899.851502227328;10156.898431015596;6615.569987950767;6742.561733487308;6898.931010690029;7332.706691732485;7473.6263186841525;7986.8003299915645;8024.478408903403;8080.393970452122;8087.676492940216;8098.028236611644;7170.820729481805;7234.674439650334;7274.672639731119;7410.444216683878;7419.8145046374275;7109.395701365442;7136.357727804522;7217.989481472493;7341.59621220838;7552.773416797285;7003.929960700328;7112;7117.8576428470105;7117.857642847218;7122.5726456412785;4798.064377446364;4905.803767849389;4952.727599982036;5078.796848126033;5134.666246693953;4969.503049695001;5069.214271787879;5091.87270318245;5119.206522988943;5180.533751962342 04:31:05 INFO - PROCESS | 16744 | |4;prototype.html;329.1218296001466;341.41617833504705;349.70275266023884;351.1186920828719;351.9331327047862;5346.866328341794;5361.222622719703;5392;5392.4877136672;5432.945670543293;5055.898882022367;5089;5205.219217117435;5269.41917424773;5298.390685071218;4082.142750022499;4110.753354798707;4140.606642368985;4158.708890377675;4181.581841815824;4127.257093723144;4141.62725354718;4146.108586653869;4158.688098392618;4170;3816.6755825754703;3926.646601805837;4037.636612704856;4090.7954602269915;4125.195586860564;4084.6732261419015;4096.795160241976;4105.220008198433;4128.731632443882;4150.273702102135;3665.4318580620047;3670.687991520724;3674.6141655126094;3679.7185744838102;3700.6484383983748;4990.500949905017;5072.391313042422;5079.949200508022;5084.516970887797;5106.846794596168;4717;4724.551167639103;4751.572358487752;4757.3815403997605;4761.880952976168;5455.390659755381;5483.424240454735;5496.972515137439;5504.7522861470925;5521.282233309644;3930.5849894038124;4023.597640235953;4053.391991201314;4068.3490641497515;4073.9388909166387;5715.5427565794635;5725.227094342294;5750.396208398141;5755.251817263771;5760.654360738369;4176.517336345553;4176.624103830609;4179.958200418017;4197.223513649985;4217.240896638573;4062.268791617478;4229.894252643709;4235.4917409911;4242.44848169736;4255.063885945087;4696.671233013724;4745.098431298043;4770.403699537558;4777.378940737752;4784.4497882743235;5573.972130139324;5603.6077474577205;5637.154426835926;5682.289713785777;5697.572682048863;1336.4186578838237;1400.6008287638178;1412.3150272118014;1444.169602478579;1473.5505670770303;898.5398727068514;905.4160066756905;915.3089417489753;918.779492921694;919.8620206969008;4657.138429390574;4705.811767529261;4738.028704115648;4754.833580824655;4831.903361932742;4982.377202849644;4984.5513903748115;5033.345665063592;5058.241263810384;5072;4584.100615131458;4773.902002539436;4783.808647654055;4801.615870730333;4826.8069277228515;2752.7109653486496;2760.061579063128;2762.709915458888;2763.585462180689;2774.4728501584636;5128.666636668605;5198.558122559625;5214.7914083436235;5222.660527065728;5257.421683614799;4633.814647414066;5059.873503162376;5086.415062267886;5118.436971933084;5173.40505841833;5199.324087868628;5231.738413079407;5248.422673505911;5265.368155821326;5283.603729720209;5046.697198168122;5068.859506610983;5077.441481437113;5110.948890511196;5154.819581314636;4819.903601928012;4992.72540010303;4993.875153121201;5075;5076.0863044652315;5070.262058488375;5131.897362052663;5140.3831540215415;5192.948070519246;5207.947920520746;3713.6657700805977;3717.2937141942944;3777.112378591084;3804.2771873343977;3891.377379619247;5681.346645135863;5692.800751973661;5701.828945131652;5713.314402271754;5771.7114144293455;5478.45215478449;5492.1212605982855;5509.889802204014;5516.172574113915;5563.1655251710945;5299.761510731949;5539;5539.504333829763;5547.778088876561;5560.694161821139;5446.918296225481;5456.781728730806;5457.9727101365825;5493.7802487900035;5499.4225606310765;5393.352797664305;5556.277683901067;5583.664980101207;5585.190147428519;5599.468050535193;5459.645123067146;5465.590080744039;5488.615796894179;5491.643043202179;5497.725113744376 04:31:05 INFO - PROCESS | 16744 | |5;yui.html;674.6828990374523;726;740.574169852335;745.8508298340333;776.4215659333797;12675.366231688413;13479.258640774753;13483.393247303871;13506;13519.12125711828;12569.057320700938;12577.11960162789;12612.81080783789;12636.241825490477;12943.546975855847;687.7799104286605;806.770070529899;830.3689196210893;831.7754206364308;844.8859403980476;825.8802473641318;833.2584000239762;833.3957880536593;833.9374546909006;833.9916600834005;878.2578720980761;881.5724373678793;881.6209030117047;881.894172699277;882.4484697064335;713.3116542536451;846.7205822078761;874.558348034245;874.8425283448977;877.1228771228771;641.6054126712086;642.00809748938;642.2549842183092;642.2678146912524;642.3063091860826;12940.935295323558;12955.417006234742;12990;13004.869951300461;13024;12950.287734174617;12963.28701921394;13190.60428187156;13405.262710550916;13439;11570.710732231677;11577.421128943519;11605.187636865423;11648.184627076109;11756.941215293955;4251.744895306291;4267.509236437819;4271.765052922088;4305.935410968838;4419.18245124653;52764.47235527634;54797.72601137008;55766;55794.44205557933;55958;9831.852522212173;9913.107820296207;10024.448655323882;10032.69901902944;10209.642662506925;18700.438986830417;18713.157907894176;18752.156152973148;18782;18999.145038473303;7782.182870798485;7791.454598178187;7807.375409967189;7814.10137834145;8027.2775450209765;4346.304591265382;4373.365861950063;4393.692441529126;4487.618552423015;4540.636749060133;3382.729381649462;3475.4091804393315;3478.3043391321835;3481.1819222482695;3483.2162763378037;692.6709812838861;721.7149226055678;722.3679280629449;724.7209824217714;725.2022774947516;636.6848410037061;654.9443297319781;656.5633853487473;691.8305015271291;714.7569826259097;8454.49273043607;8763.605637746317;8807.471551706918;8960.1935825776;9154.86267705985;620.5376994139395;693.4106009891552;738.7635956493871;746.805830484078;757.1784613694203;3828.2152158807376;4131.9173616527505;4219.135077309205;4237.957620423756;4333.285007973649;66005.66997164984;68842.65578672074;69164.3083569168;69292.30707692858;69306.65346673335;59594.404055959756;60425.69787151124;60809;61253.38746612566;61928.071078933855;54207.728961354944;54456.45543544514;54636.453635463135;54646;54699.45300547023;7813.609319533887;7851.5289082652935;7985.441019128605;7998.680052798056;8052.154523775153;35962.82018589995;36093.27813443769;36246.63753362433;36580.817095915416;36731.26537469182;45239.09521809611;47292;47818.760906195246;47937;48985.265221022426;12387.814182787086;12409.93795031019;12522.812157817458;12716.682082948;13062.020348473712;13405.66485837862;13500.594982150551;13995.230262335263;14096.718065638835;14234.572962811133;9451.716448506555;11683.824742629038;11711.238769479956;12032.819507707567;12130.575429859913;11295.322280663186;11443.084553235887;11974.58088966882;11986.580469683518;12003.1597788154;12289.692757680772;12737.490500379881;13033.543825966046;13066.085374024107;13097.934510327768;9845.556949937414;9849.359791613522;9957.153641940517;10056.798864022532;10175.949120254352;9508.619655213713;10129.290949633749;10301.896981030393;10359.741006474898;10405.115565177044 04:31:05 INFO - PROCESS | 16744 | __end_tp_report 04:31:05 INFO - PROCESS | 16744 | __start_cc_report 04:31:05 INFO - PROCESS | 16744 | _x_x_mozilla_cycle_collect,894 04:31:05 INFO - PROCESS | 16744 | __end_cc_report 04:31:05 INFO - PROCESS | 16744 | __startTimestamp1463052665806__endTimestamp 04:31:05 INFO - PROCESS | 16744 | 04:31:05 INFO - PROCESS | 16744 | ------- Summary: start ------- 04:31:05 INFO - PROCESS | 16744 | Number of tests: 6 04:31:05 INFO - PROCESS | 16744 | 04:31:05 INFO - PROCESS | 16744 | [#0] dojo.html Cycles:165 Average:5288.33 Median:5512.97 stddev:605.97 (11.0%) stddev-sans-first:582.50 04:31:05 INFO - PROCESS | 16744 | Values: 3078.6 3132.0 3145.3 3164.7 3195.4 5170.2 5246.2 5259.0 5275.3 5284.6 5292.0 5294.2 5299.3 5440.8 5455.9 4822.0 4846.3 4849.5 4854.3 5001.9 4877.3 4916.0 4941.3 4969.8 4973.2 4709.4 4777.8 4786.2 4789.3 4822.0 4778.3 4794.4 4863.4 4868.3 4908.4 4702.2 4818.4 4845.4 4847.2 4874.0 5254.7 5297.3 5306.1 5406.4 5413.8 5794.7 5856.3 5878.7 5886.2 5887.1 5562.7 5630.7 5914.6 5919.6 5921.7 5329.8 5403.9 5425.7 5430.6 5433.3 5907.8 5909.5 5910.9 5915.0 5915.5 5476.2 5542.2 5546.1 5685.1 5703.3 5694.2 5695.1 5705.9 5708.2 5734.3 5661.3 5668.5 5669.9 5671.7 5672.9 5533.1 5553.1 5563.1 5570.3 5681.8 4259.1 4281.7 4286.0 4287.2 4316.7 3849.4 3861.9 3871.1 3897.0 3903.8 5236.7 5262.8 5429.8 5454.7 5477.4 5764.5 5779.7 5780.8 5783.4 5828.2 5489.5 5500.1 5502.1 5506.6 5513.0 4604.1 4625.7 4669.5 4712.2 4842.1 5801.4 5818.0 5831.8 5833.1 5837.5 5631.8 5635.7 5636.3 5638.9 5643.4 5666.3 5705.5 5856.7 5869.1 5873.6 5531.8 5560.7 5568.4 5571.7 5572.9 5646.9 5647.9 5652.5 5652.7 5653.1 5307.4 5490.6 5512.0 5547.1 5581.3 5536.9 5545.9 5555.0 5557.1 5559.4 5264.1 5451.0 5465.9 5472.4 5519.3 5560.4 5596.0 5635.4 5715.0 5736.5 5527.3 5564.1 5566.1 5568.0 5607.5 04:31:05 INFO - PROCESS | 16744 | 04:31:05 INFO - PROCESS | 16744 | [#1] ext.html Cycles:180 Average:56577.38 Median:43066.18 stddev:103054.71 (239.3%) stddev-sans-first:103258.19 04:31:05 INFO - PROCESS | 16744 | Values: 629.2 634.8 639.8 643.5 653.6 42054.8 43644.3 43694.9 47627.3 47737.5 43993.0 44776.8 44924.8 44933.3 44992.6 8765.3 8855.2 8957.0 8968.0 8970.3 8769.3 8863.7 8867.9 8876.3 8919.1 8962.6 8999.8 9012.0 9016.6 9020.3 8905.9 8942.4 8948.0 8949.8 8951.5 8791.8 8874.9 8881.0 8890.5 8892.9 40791.2 41037.4 41134.8 41203.0 41222.4 3407.3 3456.3 3530.2 3854.2 4154.7 31441.5 31960.2 32018.8 32065.7 33453.0 4371.4 4409.0 4425.6 4482.8 4562.0 322420.0 322667.0 322730.0 323050.0 323589.0 51970.2 57146.4 57844.7 58508.4 58511.0 56761.0 62476.7 62500.8 62759.4 62794.4 15853.8 16059.0 16078.8 16083.9 16100.8 12416.0 13123.5 13336.8 13439.4 13463.0 17875.6 17908.6 17917.0 17942.0 17985.9 6350.4 6404.3 6418.2 6527.4 6591.0 1000.2 1078.8 1105.4 1128.8 1146.2 31985.5 32441.8 32589.3 33080.2 33464.3 1108.6 1117.1 1164.1 1174.2 1189.5 17106.0 17179.8 17452.4 17478.8 17578.9 437657.0 444976.0 446157.0 447207.0 447836.0 55563.7 56726.4 56726.4 56745.4 56793.7 1399.8 1407.4 1410.4 1411.4 1443.3 30169.7 31763.7 31972.0 32143.5 32397.8 50204.5 50333.5 50574.7 50645.7 50660.5 386260.0 386602.0 386901.0 388984.0 435349.0 41069.4 41970.6 42341.4 45761.5 45997.3 47392.3 48446.3 50987.0 51147.5 52455.2 41530.6 42002.6 43110.6 43190.0 43503.0 41022.6 42326.0 42326.0 42332.0 42972.8 43021.8 44206.0 44761.6 44937.3 47200.6 36331.8 38566.7 38841.4 38936.6 39086.0 29545.3 29641.4 30104.7 30660.8 31191.4 04:31:05 INFO - PROCESS | 16744 | 04:31:05 INFO - PROCESS | 16744 | [#2] jquery.html Cycles:180 Average:25456.22 Median:19512.31 stddev:67933.47 (348.2%) stddev-sans-first:68097.97 04:31:05 INFO - PROCESS | 16744 | Values: 393.5 396.1 400.8 410.5 410.9 13906.2 16992.8 17680.7 19196.7 19298.1 14367.2 18049.5 18642.8 18719.3 19414.0 5659.2 5769.7 5799.1 5821.5 5827.4 4174.2 4369.9 5703.0 6073.3 6386.8 6424.6 6474.4 6493.9 6494.3 6495.8 6250.8 6288.7 6351.3 6357.7 6410.0 5039.8 5387.0 5623.6 5637.0 5647.3 12624.9 12806.9 12815.8 12907.2 17602.6 2192.8 2235.7 2436.4 2512.7 2644.2 9433.8 10426.5 10458.7 12828.3 13291.0 1798.3 1848.4 1862.7 1909.8 1982.7 78783.0 81480.6 83977.2 84041.6 84585.6 10991.7 11244.3 11273.9 11327.4 11425.1 15572.5 15628.6 15693.3 15726.1 15758.1 8237.7 8400.5 8419.0 8590.6 8610.5 8172.9 8235.1 8289.4 8356.5 8425.2 4273.3 4436.6 4636.2 4732.9 4795.9 1785.6 1803.6 1815.9 1904.5 1917.4 994.5 1001.5 1010.9 1054.0 1085.9 18794.1 18840.3 19435.5 19497.6 19527.0 1011.3 1013.0 1019.8 1022.6 1098.3 10634.5 10914.5 10927.1 10938.5 11001.8 166534.2 337232.0 474269.0 484671.0 485913.0 54264.7 79919.6 88437.6 89155.6 89574.0 999.8 1016.2 1026.8 1030.2 1034.6 16835.1 16927.2 17080.1 17256.4 17568.9 36561.6 37009.6 37979.6 38313.4 39042.6 51996.7 53179.0 53490.7 53855.7 54055.5 8664.5 8833.6 8964.4 9012.8 9143.2 12617.4 13122.6 13167.4 13437.7 13486.0 11660.8 11743.4 11824.3 11843.9 12206.7 11586.0 11596.9 11609.9 11722.7 11783.2 11605.9 11647.5 11734.7 11767.7 12007.2 8263.3 8351.1 8710.5 8958.2 8975.7 10982.3 11893.3 12065.3 12434.2 12435.0 04:31:05 INFO - PROCESS | 16744 | 04:31:05 INFO - PROCESS | 16744 | [#3] mootools.html Cycles:180 Average:5662.63 Median:5074.01 stddev:3193.52 (62.9%) stddev-sans-first:3184.86 04:31:05 INFO - PROCESS | 16744 | Values: 1199.3 1530.3 1537.4 1726.2 1876.4 8083.3 8417.6 8466.0 8674.5 8687.3 8598.9 8720.2 8781.6 8781.9 8799.3 1992.3 2268.4 2326.4 2351.2 2351.5 2337.8 2349.7 2358.9 2360.3 2360.5 2320.7 2373.1 2374.7 2376.9 2377.0 1989.5 2231.3 2296.9 2303.6 2319.6 2271.6 2276.3 2284.0 2285.6 2307.8 8798.0 8850.9 8857.3 8859.4 8867.1 5291.6 5396.2 5425.3 5425.9 5446.1 3265.4 3429.1 3429.5 3439.0 3479.6 1125.3 1135.8 1140.9 1142.2 1152.5 11926.4 11994.8 12023.5 12042.3 12048.5 4369.7 4376.6 4497.4 4524.1 4552.3 9355.4 9363.4 9401.8 9404.2 9411.2 4529.6 5153.5 5167.7 5203.2 5242.8 4791.2 4913.3 4924.1 4932.6 4940.6 3794.7 3841.6 3882.8 3920.7 3920.8 1152.2 1153.2 1160.6 1161.8 1175.8 834.8 913.1 943.8 946.7 975.3 5718.6 5800.6 5891.6 5907.6 6169.6 955.6 972.3 997.8 1011.9 1028.6 3985.1 4003.7 4022.1 4068.7 4069.0 10461.8 10770.5 10773.5 10912.2 11067.4 10759.7 10822.7 10839.5 10857.2 10950.1 7902.8 8058.8 8119.1 8143.4 8169.3 5639.7 5688.3 5711.7 5737.8 5813.5 9857.9 9905.2 9913.4 10025.6 10036.4 9797.3 9864.9 9878.3 9899.9 10156.9 6615.6 6742.6 6898.9 7332.7 7473.6 7986.8 8024.5 8080.4 8087.7 8098.0 7170.8 7234.7 7274.7 7410.4 7419.8 7109.4 7136.4 7218.0 7341.6 7552.8 7003.9 7112.0 7117.9 7117.9 7122.6 4798.1 4905.8 4952.7 5078.8 5134.7 4969.5 5069.2 5091.9 5119.2 5180.5 04:31:05 INFO - PROCESS | 16744 | 04:31:05 INFO - PROCESS | 16744 | [#4] prototype.html Cycles:180 Average:4504.12 Median:5059.06 stddev:1292.43 (25.5%) stddev-sans-first:1257.49 04:31:05 INFO - PROCESS | 16744 | Values: 329.1 341.4 349.7 351.1 351.9 5346.9 5361.2 5392.0 5392.5 5432.9 5055.9 5089.0 5205.2 5269.4 5298.4 4082.1 4110.8 4140.6 4158.7 4181.6 4127.3 4141.6 4146.1 4158.7 4170.0 3816.7 3926.6 4037.6 4090.8 4125.2 4084.7 4096.8 4105.2 4128.7 4150.3 3665.4 3670.7 3674.6 3679.7 3700.6 4990.5 5072.4 5079.9 5084.5 5106.8 4717.0 4724.6 4751.6 4757.4 4761.9 5455.4 5483.4 5497.0 5504.8 5521.3 3930.6 4023.6 4053.4 4068.3 4073.9 5715.5 5725.2 5750.4 5755.3 5760.7 4176.5 4176.6 4180.0 4197.2 4217.2 4062.3 4229.9 4235.5 4242.4 4255.1 4696.7 4745.1 4770.4 4777.4 4784.4 5574.0 5603.6 5637.2 5682.3 5697.6 1336.4 1400.6 1412.3 1444.2 1473.6 898.5 905.4 915.3 918.8 919.9 4657.1 4705.8 4738.0 4754.8 4831.9 4982.4 4984.6 5033.3 5058.2 5072.0 4584.1 4773.9 4783.8 4801.6 4826.8 2752.7 2760.1 2762.7 2763.6 2774.5 5128.7 5198.6 5214.8 5222.7 5257.4 4633.8 5059.9 5086.4 5118.4 5173.4 5199.3 5231.7 5248.4 5265.4 5283.6 5046.7 5068.9 5077.4 5110.9 5154.8 4819.9 4992.7 4993.9 5075.0 5076.1 5070.3 5131.9 5140.4 5192.9 5207.9 3713.7 3717.3 3777.1 3804.3 3891.4 5681.3 5692.8 5701.8 5713.3 5771.7 5478.5 5492.1 5509.9 5516.2 5563.2 5299.8 5539.0 5539.5 5547.8 5560.7 5446.9 5456.8 5458.0 5493.8 5499.4 5393.4 5556.3 5583.7 5585.2 5599.5 5459.6 5465.6 5488.6 5491.6 5497.7 04:31:05 INFO - PROCESS | 16744 | 04:31:05 INFO - PROCESS | 16744 | [#5] yui.html Cycles:180 Average:15155.43 Median:47877.88 stddev:18484.84 (38.6%) stddev-sans-first:18504.71 04:31:05 INFO - PROCESS | 16744 | Values: 674.7 726.0 740.6 745.9 776.4 12675.4 13479.3 13483.4 13506.0 13519.1 12569.1 12577.1 12612.8 12636.2 12943.5 687.8 806.8 830.4 831.8 844.9 825.9 833.3 833.4 833.9 834.0 878.3 881.6 881.6 881.9 882.4 713.3 846.7 874.6 874.8 877.1 641.6 642.0 642.3 642.3 642.3 12940.9 12955.4 12990.0 13004.9 13024.0 12950.3 12963.3 13190.6 13405.3 13439.0 11570.7 11577.4 11605.2 11648.2 11756.9 4251.7 4267.5 4271.8 4305.9 4419.2 52764.5 54797.7 55766.0 55794.4 55958.0 9831.9 9913.1 10024.4 10032.7 10209.6 18700.4 18713.2 18752.2 18782.0 18999.1 7782.2 7791.5 7807.4 7814.1 8027.3 4346.3 4373.4 4393.7 4487.6 4540.6 3382.7 3475.4 3478.3 3481.2 3483.2 692.7 721.7 722.4 724.7 725.2 636.7 654.9 656.6 691.8 714.8 8454.5 8763.6 8807.5 8960.2 9154.9 620.5 693.4 738.8 746.8 757.2 3828.2 4131.9 4219.1 4238.0 4333.3 66005.7 68842.7 69164.3 69292.3 69306.7 59594.4 60425.7 60809.0 61253.4 61928.1 54207.7 54456.5 54636.5 54646.0 54699.5 7813.6 7851.5 7985.4 7998.7 8052.2 35962.8 36093.3 36246.6 36580.8 36731.3 45239.1 47292.0 47818.8 47937.0 48985.3 12387.8 12409.9 12522.8 12716.7 13062.0 13405.7 13500.6 13995.2 14096.7 14234.6 9451.7 11683.8 11711.2 12032.8 12130.6 11295.3 11443.1 11974.6 11986.6 12003.2 12289.7 12737.5 13033.5 13066.1 13097.9 9845.6 9849.4 9957.2 10056.8 10175.9 9508.6 10129.3 10301.9 10359.7 10405.1 04:31:05 INFO - PROCESS | 16744 | -------- Summary: end -------- 04:31:05 INFO - PROCESS | 16744 | 04:31:06 INFO - TEST-INFO | 16744: exit 0 04:31:06 INFO - TEST-OK | dromaeo_css | took 1112874ms 04:31:06 INFO - TEST-START | kraken 04:31:06 INFO - operating with platform_type : linux_ 04:31:06 INFO - Initialising browser for kraken test... 04:31:06 INFO - TEST-INFO | started process 16926 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOkEm8J/profile http://localhost:38110/getInfo.html) 04:31:10 INFO - PROCESS | 16926 | __metrics Screen width/height:1600/1200 04:31:10 INFO - PROCESS | 16926 | colorDepth:24 04:31:10 INFO - PROCESS | 16926 | Browser inner width/height: 1024/697 04:31:10 INFO - PROCESS | 16926 | __metrics 04:31:11 ERROR - PROCESS | 16926 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:31:12 INFO - TEST-INFO | 16926: exit 0 04:31:12 INFO - Browser initialized. 04:31:12 INFO - Running cycle 1/1 for kraken test... 04:31:12 INFO - TEST-INFO | started process 17010 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOkEm8J/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:31:24 INFO - PROCESS | 17010 | RSS: Main: 151691264 04:31:24 INFO - PROCESS | 17010 | 04:31:26 INFO - PROCESS | 17010 | Cycle 1(1): loaded http://localhost:38110/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38110/tests/kraken/driver.html?testName=audio-beat-detection) 04:31:27 INFO - PROCESS | 17010 | RSS: Main: 208326656 04:31:27 INFO - PROCESS | 17010 | 04:31:30 INFO - PROCESS | 17010 | Cycle 1(1): loaded http://localhost:38110/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38110/tests/kraken/driver.html?testName=audio-dft) 04:31:30 INFO - PROCESS | 17010 | RSS: Main: 198230016 04:31:30 INFO - PROCESS | 17010 | 04:31:34 INFO - PROCESS | 17010 | Cycle 1(1): loaded http://localhost:38110/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38110/tests/kraken/driver.html?testName=audio-fft) 04:31:34 INFO - PROCESS | 17010 | RSS: Main: 265281536 04:31:34 INFO - PROCESS | 17010 | 04:31:36 INFO - PROCESS | 17010 | Cycle 1(1): loaded http://localhost:38110/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38110/tests/kraken/driver.html?testName=audio-oscillator) 04:31:37 INFO - PROCESS | 17010 | RSS: Main: 174006272 04:31:37 INFO - PROCESS | 17010 | 04:31:39 INFO - PROCESS | 17010 | Cycle 1(1): loaded http://localhost:38110/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38110/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:31:40 INFO - PROCESS | 17010 | RSS: Main: 178438144 04:31:40 INFO - PROCESS | 17010 | 04:31:43 INFO - PROCESS | 17010 | Cycle 1(1): loaded http://localhost:38110/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38110/tests/kraken/driver.html?testName=imaging-darkroom) 04:31:44 INFO - PROCESS | 17010 | RSS: Main: 214704128 04:31:44 INFO - PROCESS | 17010 | 04:31:47 INFO - PROCESS | 17010 | Cycle 1(1): loaded http://localhost:38110/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38110/tests/kraken/driver.html?testName=imaging-desaturate) 04:31:48 INFO - PROCESS | 17010 | RSS: Main: 212774912 04:31:48 INFO - PROCESS | 17010 | 04:31:51 INFO - PROCESS | 17010 | Cycle 1(1): loaded http://localhost:38110/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38110/tests/kraken/driver.html?testName=json-parse-financial) 04:31:51 INFO - PROCESS | 17010 | RSS: Main: 213143552 04:31:51 INFO - PROCESS | 17010 | 04:31:53 INFO - PROCESS | 17010 | Cycle 1(1): loaded http://localhost:38110/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38110/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:31:54 INFO - PROCESS | 17010 | RSS: Main: 202883072 04:31:54 INFO - PROCESS | 17010 | 04:31:55 INFO - PROCESS | 17010 | Cycle 1(1): loaded http://localhost:38110/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38110/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:31:56 INFO - PROCESS | 17010 | RSS: Main: 206766080 04:31:56 INFO - PROCESS | 17010 | 04:31:58 INFO - PROCESS | 17010 | Cycle 1(1): loaded http://localhost:38110/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38110/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:31:59 INFO - PROCESS | 17010 | RSS: Main: 215121920 04:31:59 INFO - PROCESS | 17010 | 04:32:02 INFO - PROCESS | 17010 | Cycle 1(1): loaded http://localhost:38110/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38110/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:32:02 INFO - PROCESS | 17010 | RSS: Main: 221335552 04:32:02 INFO - PROCESS | 17010 | 04:32:05 INFO - PROCESS | 17010 | Cycle 1(1): loaded http://localhost:38110/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38110/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:32:06 INFO - PROCESS | 17010 | RSS: Main: 219480064 04:32:06 INFO - PROCESS | 17010 | 04:32:08 INFO - PROCESS | 17010 | Cycle 1(1): loaded http://localhost:38110/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38110/tests/kraken/driver.html?testName=ai-astar) 04:32:08 INFO - PROCESS | 17010 | RSS: Main: 265388032 04:32:08 INFO - PROCESS | 17010 | 04:32:08 INFO - PROCESS | 17010 | __start_tp_report 04:32:08 INFO - PROCESS | 17010 | _x_x_mozilla_page_load 04:32:08 INFO - PROCESS | 17010 | _x_x_mozilla_page_load_details 04:32:08 INFO - PROCESS | 17010 | |i|pagename|runs| 04:32:08 INFO - PROCESS | 17010 | |0;ai-astar;111;105;110;109;109;111;110;111;109;109 04:32:08 INFO - PROCESS | 17010 | |1;audio-beat-detection;165;124;153;220;129;149;151;125;188;128 04:32:08 INFO - PROCESS | 17010 | |2;audio-dft;162;160;161;161;160;162;160;161;164;163 04:32:08 INFO - PROCESS | 17010 | |3;audio-fft;75;76;76;149;76;74;76;76;135;75 04:32:08 INFO - PROCESS | 17010 | |4;audio-oscillator;91;93;155;91;91;93;129;92;93;117 04:32:08 INFO - PROCESS | 17010 | |5;imaging-gaussian-blur;116;117;117;117;118;118;117;117;117;117 04:32:08 INFO - PROCESS | 17010 | |6;imaging-darkroom;145;146;145;145;145;146;144;145;145;145 04:32:08 INFO - PROCESS | 17010 | |7;imaging-desaturate;95;95;94;94;95;94;95;94;94;95 04:32:08 INFO - PROCESS | 17010 | |8;json-parse-financial;68;58;60;59;59;59;59;129;63;61 04:32:08 INFO - PROCESS | 17010 | |9;json-stringify-tinderbox;58;59;59;59;58;59;58;58;58;59 04:32:08 INFO - PROCESS | 17010 | |10;stanford-crypto-aes;80;79;79;79;80;86;81;80;80;86 04:32:08 INFO - PROCESS | 17010 | |11;stanford-crypto-ccm;133;132;124;123;124;130;123;125;240;135 04:32:08 INFO - PROCESS | 17010 | |12;stanford-crypto-pbkdf2;172;169;172;171;178;170;174;180;168;171 04:32:08 INFO - PROCESS | 17010 | |13;stanford-crypto-sha256-iterative;65;71;66;64;65;64;72;64;63;64 04:32:08 INFO - PROCESS | 17010 | __end_tp_report 04:32:08 INFO - PROCESS | 17010 | __start_cc_report 04:32:08 INFO - PROCESS | 17010 | _x_x_mozilla_cycle_collect,1840 04:32:08 INFO - PROCESS | 17010 | __end_cc_report 04:32:08 INFO - PROCESS | 17010 | __startTimestamp1463052728283__endTimestamp 04:32:08 INFO - PROCESS | 17010 | 04:32:08 INFO - PROCESS | 17010 | ------- Summary: start ------- 04:32:08 INFO - PROCESS | 17010 | Number of tests: 14 04:32:08 INFO - PROCESS | 17010 | 04:32:08 INFO - PROCESS | 17010 | [#0] ai-astar Cycles:10 Average:109.40 Median:110.00 stddev:1.78 (1.6%) stddev-sans-first:1.79 04:32:08 INFO - PROCESS | 17010 | Values: 111.0 105.0 110.0 109.0 109.0 111.0 110.0 111.0 109.0 109.0 04:32:08 INFO - PROCESS | 17010 | 04:32:08 INFO - PROCESS | 17010 | [#1] audio-beat-detection Cycles:10 Average:153.20 Median:152.00 stddev:31.10 (20.5%) stddev-sans-first:32.69 04:32:08 INFO - PROCESS | 17010 | Values: 165.0 124.0 153.0 220.0 129.0 149.0 151.0 125.0 188.0 128.0 04:32:08 INFO - PROCESS | 17010 | 04:32:08 INFO - PROCESS | 17010 | [#2] audio-dft Cycles:10 Average:161.40 Median:161.50 stddev:1.35 (0.8%) stddev-sans-first:1.41 04:32:08 INFO - PROCESS | 17010 | Values: 162.0 160.0 161.0 161.0 160.0 162.0 160.0 161.0 164.0 163.0 04:32:08 INFO - PROCESS | 17010 | 04:32:08 INFO - PROCESS | 17010 | [#3] audio-fft Cycles:10 Average:88.80 Median:76.00 stddev:28.24 (37.2%) stddev-sans-first:29.51 04:32:08 INFO - PROCESS | 17010 | Values: 75.0 76.0 76.0 149.0 76.0 74.0 76.0 76.0 135.0 75.0 04:32:08 INFO - PROCESS | 17010 | 04:32:08 INFO - PROCESS | 17010 | [#4] audio-oscillator Cycles:10 Average:104.50 Median:91.50 stddev:22.13 (24.2%) stddev-sans-first:22.92 04:32:08 INFO - PROCESS | 17010 | Values: 91.0 93.0 155.0 91.0 91.0 93.0 129.0 92.0 93.0 117.0 04:32:08 INFO - PROCESS | 17010 | 04:32:08 INFO - PROCESS | 17010 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.44 04:32:08 INFO - PROCESS | 17010 | Values: 116.0 117.0 117.0 117.0 118.0 118.0 117.0 117.0 117.0 117.0 04:32:08 INFO - PROCESS | 17010 | 04:32:08 INFO - PROCESS | 17010 | [#6] imaging-darkroom Cycles:10 Average:145.10 Median:145.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 04:32:08 INFO - PROCESS | 17010 | Values: 145.0 146.0 145.0 145.0 145.0 146.0 144.0 145.0 145.0 145.0 04:32:08 INFO - PROCESS | 17010 | 04:32:08 INFO - PROCESS | 17010 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:95.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 04:32:08 INFO - PROCESS | 17010 | Values: 95.0 95.0 94.0 94.0 95.0 94.0 95.0 94.0 94.0 95.0 04:32:08 INFO - PROCESS | 17010 | 04:32:08 INFO - PROCESS | 17010 | [#8] json-parse-financial Cycles:10 Average:67.50 Median:59.50 stddev:21.81 (36.7%) stddev-sans-first:23.13 04:32:08 INFO - PROCESS | 17010 | Values: 68.0 58.0 60.0 59.0 59.0 59.0 59.0 129.0 63.0 61.0 04:32:08 INFO - PROCESS | 17010 | 04:32:08 INFO - PROCESS | 17010 | [#9] json-stringify-tinderbox Cycles:10 Average:58.50 Median:59.00 stddev:0.53 (0.9%) stddev-sans-first:0.53 04:32:08 INFO - PROCESS | 17010 | Values: 58.0 59.0 59.0 59.0 58.0 59.0 58.0 58.0 58.0 59.0 04:32:08 INFO - PROCESS | 17010 | 04:32:08 INFO - PROCESS | 17010 | [#10] stanford-crypto-aes Cycles:10 Average:81.00 Median:80.00 stddev:2.71 (3.4%) stddev-sans-first:2.85 04:32:08 INFO - PROCESS | 17010 | Values: 80.0 79.0 79.0 79.0 80.0 86.0 81.0 80.0 80.0 86.0 04:32:08 INFO - PROCESS | 17010 | 04:32:08 INFO - PROCESS | 17010 | [#11] stanford-crypto-ccm Cycles:10 Average:138.90 Median:131.00 stddev:35.81 (27.3%) stddev-sans-first:37.92 04:32:08 INFO - PROCESS | 17010 | Values: 133.0 132.0 124.0 123.0 124.0 130.0 123.0 125.0 240.0 135.0 04:32:08 INFO - PROCESS | 17010 | 04:32:08 INFO - PROCESS | 17010 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.50 Median:172.00 stddev:3.84 (2.2%) stddev-sans-first:4.07 04:32:08 INFO - PROCESS | 17010 | Values: 172.0 169.0 172.0 171.0 178.0 170.0 174.0 180.0 168.0 171.0 04:32:08 INFO - PROCESS | 17010 | 04:32:08 INFO - PROCESS | 17010 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.80 Median:65.00 stddev:3.12 (4.8%) stddev-sans-first:3.30 04:32:08 INFO - PROCESS | 17010 | Values: 65.0 71.0 66.0 64.0 65.0 64.0 72.0 64.0 63.0 64.0 04:32:08 INFO - PROCESS | 17010 | -------- Summary: end -------- 04:32:08 INFO - PROCESS | 17010 | 04:32:09 INFO - TEST-INFO | 17010: exit 0 04:32:09 INFO - TEST-OK | kraken | took 62744ms 04:32:09 INFO - SUITE-END | took 1175s 04:32:09 INFO - Completed test suite (00:19:35) 04:32:09 INFO - javascript benchmark 04:32:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3078.645955715093, 3132.0, 3145.308032232909, 3164.651888292286, 3195.3769015042076, 5170.172772356424, 5246.160614301703, 5259.000789849926, 5275.28783614212, 5284.57723382129, 5292.0, 5294.205869119624, 5299.258103865462, 5440.755166017529, 5455.918161227575, 4822.0, 4846.321514987904, 4849.490803465638, 4854.296127061574, 5001.949980500185, 4877.34155888954, 4916.041371932474, 4941.3329200558, 4969.751512424383, 4973.162449337266, 4709.411323584552, 4777.761111944406, 4786.186348320759, 4789.30555069513, 4821.951780482185, 4778.307145463888, 4794.35276237707, 4863.440704319013, 4868.294097355899, 4908.43552991407, 4702.247640377524, 4818.397700287464, 4845.442774080955, 4847.224444088929, 4874.049560335736, 5254.684718916839, 5297.311349524537, 5306.071437498423, 5406.405295417501, 5413.810516631938, 5794.652320860761, 5856.267966504187, 5878.735456904449, 5886.205362276123, 5887.116932460122, 5562.666240025571, 5630.690312032836, 5914.645121292736, 5919.644821310735, 5921.703914804242, 5329.813456529003, 5403.918941215885, 5425.728713564306, 5430.619856609999, 5433.26650902131, 5907.822765317047, 5909.468147866713, 5910.911336329958, 5915.0, 5915.526757859361, 5476.2333273341765, 5542.168674698747, 5546.112621980464, 5685.147227915763, 5703.344115426696, 5694.202811606378, 5695.088785794253, 5705.885882282331, 5708.20085188074, 5734.340550836707, 5661.3206415229615, 5668.489835914787, 5669.914951275734, 5671.744771485293, 5672.858178545569, 5533.142362933751, 5553.111502159716, 5563.13771365439, 5570.275864137636, 5681.829545113653, 4259.063006138645, 4281.721688090264, 4286.0, 4287.164003019444, 4316.6546676265825, 3849.364854798983, 3861.942070868939, 3871.070942973666, 3897.045223920101, 3903.785291808978, 5236.711980841014, 5262.7631756571045, 5429.8099566515775, 5454.7272636368025, 5477.424870388551, 5764.452377024176, 5779.682117483579, 5780.826575202751, 5783.392743761844, 5828.213191219216, 5489.478499542537, 5500.147477141049, 5502.119660854244, 5506.559475241971, 5512.972435137799, 4604.148232576917, 4625.676202665781, 4669.463011753692, 4712.151812673752, 4842.055799119138, 5801.390853960358, 5817.970910145506, 5831.825045248649, 5833.095870140135, 5837.474627283565, 5631.774729010794, 5635.746391412315, 5636.267285252891, 5638.88722225545, 5643.435656434323, 5666.320041595035, 5705.486506214461, 5856.677882716492, 5869.148973398748, 5873.618214816023, 5531.751071201725, 5560.666360018412, 5568.415316391721, 5571.7492712828835, 5572.91640625399, 5646.943530564806, 5647.943520564741, 5652.547796176378, 5652.717364131695, 5653.067243904709, 5307.389650190277, 5490.615656903979, 5512.0, 5547.084731019337, 5581.302337207849, 5536.861578460571, 5545.889082218414, 5555.0, 5557.083081291703, 5559.360673522597, 5264.131418315935, 5451.0, 5465.92979895033, 5472.370677372153, 5519.337679478328, 5560.388357280777, 5596.048671725735, 5635.380108188178, 5715.028445164249, 5736.541076713769, 5527.309086364205, 5564.137558678412, 5566.053770858883, 5568.0, 5607.467290607386], "value": 5247.641304987628, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [629.1537881549316, 634.7587916591694, 639.7632875835941, 643.5141468191515, 653.5915053091816, 42054.7897260514, 43644.345334820006, 43694.907627309294, 47627.285590716165, 47737.522624773745, 43993.0, 44776.77611611946, 44924.77537612307, 44933.32600011003, 44992.550074499246, 8765.254953328975, 8855.15875991783, 8956.955215223914, 8967.95516022419, 8970.327225458084, 8769.342299327544, 8863.689770858022, 8867.866981995276, 8876.334274929373, 8919.063498332678, 8962.641494340218, 8999.775005624879, 9011.95494022529, 9016.639334426614, 9020.278377729766, 8905.910940890573, 8942.418742781698, 8948.0, 8949.821003579957, 8951.462912225223, 8791.78020549485, 8874.911250887473, 8880.955595222047, 8890.511021893793, 8892.911070889273, 40791.18417631631, 41037.384439233436, 41134.79432602848, 41203.0, 41222.38166427506, 3407.2504049109157, 3456.2569047654624, 3530.223350862832, 3854.1713531590563, 4154.709170358076, 31441.528377074363, 31960.20099497508, 32018.839905800556, 32065.679343206502, 33453.0, 4371.366151907955, 4408.955910440919, 4425.589547482489, 4482.753448560328, 4562.019165879318, 322420.0, 322666.9999999977, 322730.0, 323050.0, 323589.0, 51970.22044669333, 57146.42853571494, 57844.71077644585, 58508.41491585115, 58511.0, 56761.0, 62476.68761656163, 62500.81247156419, 62759.37240627626, 62794.37205627977, 15853.762193567105, 16059.0, 16078.839211607969, 16083.919580402024, 16100.838991609933, 12416.0, 13123.475060997644, 13336.799948000787, 13439.395227214798, 13463.0, 17875.642487150184, 17908.552286192687, 17917.0, 17942.0, 17985.910070449827, 6350.396712312323, 6404.295527491972, 6418.229812422539, 6527.445167160749, 6591.0, 1000.174855744014, 1078.805814953316, 1105.4196546812987, 1128.8193888977723, 1146.2434793036723, 31985.52021719676, 32441.848856943292, 32589.348213035606, 33080.17299567482, 33464.33071338559, 1108.6396921000708, 1117.1063149480383, 1164.057113737875, 1174.1604752601932, 1189.4528516882158, 17106.0, 17179.82820171807, 17452.389166379115, 17478.751703107744, 17578.91210543939, 437657.0, 444976.0, 446157.0, 447207.0, 447836.0, 55563.72218138964, 56726.43273567211, 56726.43273567294, 56745.43254567484, 56793.71603141958, 1399.7620404531253, 1407.352617795805, 1410.4076287959083, 1411.3719394869186, 1443.2855736410545, 30169.69830301669, 31763.68236317607, 31972.0, 32143.51784723278, 32397.838010809795, 50204.49795501998, 50333.49666503435, 50574.747126264134, 50645.746771265905, 50660.493395065576, 386260.0, 386602.0, 386901.0, 388984.0, 435349.0, 41069.38395924123, 41970.58029419667, 42341.36487952745, 45761.542384575725, 45997.310040350094, 47392.28911566398, 48446.27330589973, 50987.0, 51147.48852511427, 52455.21317180169, 41530.58469415267, 42002.57997419986, 43110.56889431066, 43190.0, 43503.0, 41022.58977410188, 42326.0, 42326.0, 42332.0, 42972.78513607412, 43021.784891075346, 44206.0, 44761.55238447704, 44937.32594011158, 47200.62671056274, 36331.818340908125, 38566.69449040077, 38841.417378739905, 38936.610633893295, 39086.0, 29545.26136846596, 29641.407171856874, 30104.69895301019, 30660.846695766377, 31191.376172475968], "value": 20407.616537575217, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [393.4845352588108, 396.1048031448926, 400.7675548182055, 410.4889412681212, 410.8603074954515, 13906.235157066358, 16992.830071699278, 17680.73478897816, 19196.71204931927, 19298.131584078714, 14367.209803460806, 18049.4585162445, 18642.813571864277, 18719.3448229312, 19414.0, 5659.236003139575, 5769.740361683714, 5799.101139323411, 5821.476067153955, 5827.358990511061, 4174.227767862955, 4369.890752731176, 5702.971485142569, 6073.331933487313, 6386.808395748135, 6424.614523128604, 6474.449671777905, 6493.935060649404, 6494.31809659986, 6495.805125846232, 6250.843593935137, 6288.654124023177, 6351.269603995554, 6357.65032923189, 6409.9679501602195, 5039.84880453587, 5387.0, 5623.606347555673, 5637.013522633522, 5647.29408823897, 12624.873751262554, 12806.87193128066, 12815.807762883564, 12907.161034532724, 17602.559936001573, 2192.848754403935, 2235.653473711561, 2436.3665446983737, 2512.660790793238, 2644.167087367473, 9433.811323773487, 10426.530806113667, 10458.68623941283, 12828.294443805587, 13291.0, 1798.2986635212278, 1848.4269876338244, 1862.748528948588, 1909.847212223019, 1982.6530357187578, 78783.0, 81480.59259703664, 83977.16022839755, 84041.57979210126, 84585.57707211425, 10991.725206869893, 11244.325340479434, 11273.94363028196, 11327.433628318551, 11425.143114266462, 15572.454964076203, 15628.609284767972, 15693.293801778947, 15726.05643661384, 15758.133302668233, 8237.711680091168, 8400.495970241805, 8418.957905210435, 8590.613422396007, 8610.526421046903, 8172.918270817335, 8235.1353107924, 8289.4197406181, 8356.540390278593, 8425.241728244366, 4273.252180868336, 4436.64506839452, 4636.235021221461, 4732.881677958009, 4795.904081918412, 1785.5625371783997, 1803.5761596024925, 1815.9273629054953, 1904.5429097016893, 1917.4151883675613, 994.4977786218059, 1001.4592120254981, 1010.8786945566579, 1053.9894601054045, 1085.918556108295, 18794.064092323122, 18840.340588079627, 19435.51411214731, 19497.610047799248, 19527.0, 1011.2718842433436, 1012.9949350253349, 1019.8368261078192, 1022.601185537641, 1098.2751384086464, 10634.468276586294, 10914.504044062824, 10927.125829933586, 10938.453077346101, 11001.834972475419, 166534.1673291626, 337232.0, 474269.0, 484671.0, 485913.0, 54264.728676357154, 79919.60040199762, 88437.55781221182, 89155.55422222847, 89574.0, 999.7900440907491, 1016.187050359724, 1026.7946410717886, 1030.1912998296452, 1034.5913364221242, 16835.074070926217, 16927.15364231759, 17080.145992700564, 17256.396026139024, 17568.912155439142, 36561.634383656885, 37009.629903701694, 37979.62020379761, 38313.4252986211, 39042.609573903894, 51996.74001629968, 53179.0, 53490.73254633858, 53855.73072134614, 54055.459445405046, 8664.523451210243, 8833.64665413402, 8964.417312874642, 9012.774680633036, 9143.177114059767, 12617.43221555014, 13122.60632181036, 13167.407466663832, 13437.731245375233, 13486.0, 11660.825087623523, 11743.41282935867, 11824.349660768741, 11843.881561184278, 12206.694832629255, 11586.0, 11596.884031159918, 11609.941950290195, 11722.70693232676, 11783.175177737476, 11605.883941160819, 11647.475863585989, 11734.70663233426, 11767.705807354885, 12007.159498834997, 8263.338932885235, 8351.081381047958, 8710.520921349133, 8958.193762561401, 8975.730728078168, 10982.341059536133, 11893.345865977108, 12065.336406497727, 12434.191777534432, 12435.0], "value": 9030.88873902745, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1199.3163896578953, 1530.341952960227, 1537.3927298717008, 1726.197318247015, 1876.362036907452, 8083.272505474506, 8417.579121043946, 8466.0, 8674.522901240429, 8687.305015598753, 8598.91401085989, 8720.215180633742, 8781.604827782749, 8781.868271975909, 8799.252063574604, 1992.2529051605648, 2268.410213344526, 2326.3718795925092, 2351.1535847095033, 2351.529694061186, 2337.8129749620075, 2349.659299401586, 2358.8820558971984, 2360.280114565057, 2360.5042940982416, 2320.6983092197993, 2373.1100837186054, 2374.715034195899, 2376.9049238030457, 2376.964345534818, 1989.5225145964937, 2231.319447568491, 2296.919607813735, 2303.585354636165, 2319.5592837360846, 2271.6251818449937, 2276.2602154299752, 2284.017872314904, 2285.634298512247, 2307.7576854430213, 8797.956010219972, 8850.911490885073, 8857.335699822539, 8859.424137431046, 8867.113288671146, 5291.576673866081, 5396.163594642837, 5425.321834770653, 5425.864353391197, 5446.101393270145, 3265.379577880195, 3429.0741499794917, 3429.5198672185916, 3438.9656103438897, 3479.6172421033666, 1125.2798209146154, 1135.7671677306214, 1140.925839820409, 1142.23470274916, 1152.4698638626242, 11926.403679815974, 11994.760104797855, 12023.51905923762, 12042.337671428068, 12048.457819398149, 4369.6722745794195, 4376.6498680105515, 4497.415336006298, 4524.117797029613, 4552.339910712994, 9355.391899526508, 9363.438193708263, 9401.811963760687, 9404.24766018717, 9411.20004799586, 4529.637628989739, 5153.5361817436615, 5167.68993860362, 5203.2195170723935, 5242.842714718565, 4791.161546729309, 4913.287573301851, 4924.113659541317, 4932.580730637936, 4940.580050695731, 3794.734368594227, 3841.5774264830848, 3882.8446862125766, 3920.666743326792, 3920.8039598019986, 1152.2107356460851, 1153.2388623508612, 1160.6227975907864, 1161.8199179127248, 1175.7589694112687, 834.7662654456761, 913.1370854542394, 943.8489841625444, 946.7396465971775, 975.3124047546463, 5718.628289161275, 5800.622959507618, 5891.587588868738, 5907.593059026146, 6169.56813023093, 955.6177528988321, 972.2902281334665, 997.8353571660595, 1011.9392836429838, 1028.6399760083912, 3985.0834308109297, 4003.6797056236014, 4022.0950286185957, 4068.7355321903983, 4069.0, 10461.790764184825, 10770.461476926122, 10773.51519181623, 10912.181586381053, 11067.446627668583, 10759.731006724738, 10822.729431764268, 10839.458027098613, 10857.185711071701, 10950.123990080774, 7902.802429939297, 8058.798530036679, 8119.147489513516, 8143.389245806469, 8169.2647661710735, 5639.661620302795, 5688.345840228427, 5711.657300561979, 5737.770489180386, 5813.534917206529, 9857.901420985698, 9905.207583393456, 9913.355631883904, 10025.649102281384, 10036.447995360326, 9797.314188007056, 9864.85202721974, 9878.308518403643, 9899.851502227328, 10156.898431015596, 6615.569987950767, 6742.561733487308, 6898.931010690029, 7332.706691732485, 7473.6263186841525, 7986.8003299915645, 8024.478408903403, 8080.393970452122, 8087.676492940216, 8098.028236611644, 7170.820729481805, 7234.674439650334, 7274.672639731119, 7410.444216683878, 7419.8145046374275, 7109.395701365442, 7136.357727804522, 7217.989481472493, 7341.59621220838, 7552.773416797285, 7003.929960700328, 7112.0, 7117.8576428470105, 7117.857642847218, 7122.5726456412785, 4798.064377446364, 4905.803767849389, 4952.727599982036, 5078.796848126033, 5134.666246693953, 4969.503049695001, 5069.214271787879, 5091.87270318245, 5119.206522988943, 5180.533751962342], "value": 4549.477691202619, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [329.1218296001466, 341.41617833504705, 349.70275266023884, 351.1186920828719, 351.9331327047862, 5346.866328341794, 5361.222622719703, 5392.0, 5392.4877136672, 5432.945670543293, 5055.898882022367, 5089.0, 5205.219217117435, 5269.41917424773, 5298.390685071218, 4082.142750022499, 4110.753354798707, 4140.606642368985, 4158.708890377675, 4181.581841815824, 4127.257093723144, 4141.62725354718, 4146.108586653869, 4158.688098392618, 4170.0, 3816.6755825754703, 3926.646601805837, 4037.636612704856, 4090.7954602269915, 4125.195586860564, 4084.6732261419015, 4096.795160241976, 4105.220008198433, 4128.731632443882, 4150.273702102135, 3665.4318580620047, 3670.687991520724, 3674.6141655126094, 3679.7185744838102, 3700.6484383983748, 4990.500949905017, 5072.391313042422, 5079.949200508022, 5084.516970887797, 5106.846794596168, 4717.0, 4724.551167639103, 4751.572358487752, 4757.3815403997605, 4761.880952976168, 5455.390659755381, 5483.424240454735, 5496.972515137439, 5504.7522861470925, 5521.282233309644, 3930.5849894038124, 4023.597640235953, 4053.391991201314, 4068.3490641497515, 4073.9388909166387, 5715.5427565794635, 5725.227094342294, 5750.396208398141, 5755.251817263771, 5760.654360738369, 4176.517336345553, 4176.624103830609, 4179.958200418017, 4197.223513649985, 4217.240896638573, 4062.268791617478, 4229.894252643709, 4235.4917409911, 4242.44848169736, 4255.063885945087, 4696.671233013724, 4745.098431298043, 4770.403699537558, 4777.378940737752, 4784.4497882743235, 5573.972130139324, 5603.6077474577205, 5637.154426835926, 5682.289713785777, 5697.572682048863, 1336.4186578838237, 1400.6008287638178, 1412.3150272118014, 1444.169602478579, 1473.5505670770303, 898.5398727068514, 905.4160066756905, 915.3089417489753, 918.779492921694, 919.8620206969008, 4657.138429390574, 4705.811767529261, 4738.028704115648, 4754.833580824655, 4831.903361932742, 4982.377202849644, 4984.5513903748115, 5033.345665063592, 5058.241263810384, 5072.0, 4584.100615131458, 4773.902002539436, 4783.808647654055, 4801.615870730333, 4826.8069277228515, 2752.7109653486496, 2760.061579063128, 2762.709915458888, 2763.585462180689, 2774.4728501584636, 5128.666636668605, 5198.558122559625, 5214.7914083436235, 5222.660527065728, 5257.421683614799, 4633.814647414066, 5059.873503162376, 5086.415062267886, 5118.436971933084, 5173.40505841833, 5199.324087868628, 5231.738413079407, 5248.422673505911, 5265.368155821326, 5283.603729720209, 5046.697198168122, 5068.859506610983, 5077.441481437113, 5110.948890511196, 5154.819581314636, 4819.903601928012, 4992.72540010303, 4993.875153121201, 5075.0, 5076.0863044652315, 5070.262058488375, 5131.897362052663, 5140.3831540215415, 5192.948070519246, 5207.947920520746, 3713.6657700805977, 3717.2937141942944, 3777.112378591084, 3804.2771873343977, 3891.377379619247, 5681.346645135863, 5692.800751973661, 5701.828945131652, 5713.314402271754, 5771.7114144293455, 5478.45215478449, 5492.1212605982855, 5509.889802204014, 5516.172574113915, 5563.1655251710945, 5299.761510731949, 5539.0, 5539.504333829763, 5547.778088876561, 5560.694161821139, 5446.918296225481, 5456.781728730806, 5457.9727101365825, 5493.7802487900035, 5499.4225606310765, 5393.352797664305, 5556.277683901067, 5583.664980101207, 5585.190147428519, 5599.468050535193, 5459.645123067146, 5465.590080744039, 5488.615796894179, 5491.643043202179, 5497.725113744376], "value": 4098.553697524561, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [674.6828990374523, 726.0, 740.574169852335, 745.8508298340333, 776.4215659333797, 12675.366231688413, 13479.258640774753, 13483.393247303871, 13506.0, 13519.12125711828, 12569.057320700938, 12577.11960162789, 12612.81080783789, 12636.241825490477, 12943.546975855847, 687.7799104286605, 806.770070529899, 830.3689196210893, 831.7754206364308, 844.8859403980476, 825.8802473641318, 833.2584000239762, 833.3957880536593, 833.9374546909006, 833.9916600834005, 878.2578720980761, 881.5724373678793, 881.6209030117047, 881.894172699277, 882.4484697064335, 713.3116542536451, 846.7205822078761, 874.558348034245, 874.8425283448977, 877.1228771228771, 641.6054126712086, 642.00809748938, 642.2549842183092, 642.2678146912524, 642.3063091860826, 12940.935295323558, 12955.417006234742, 12990.0, 13004.869951300461, 13024.0, 12950.287734174617, 12963.28701921394, 13190.60428187156, 13405.262710550916, 13439.0, 11570.710732231677, 11577.421128943519, 11605.187636865423, 11648.184627076109, 11756.941215293955, 4251.744895306291, 4267.509236437819, 4271.765052922088, 4305.935410968838, 4419.18245124653, 52764.47235527634, 54797.72601137008, 55766.0, 55794.44205557933, 55958.0, 9831.852522212173, 9913.107820296207, 10024.448655323882, 10032.69901902944, 10209.642662506925, 18700.438986830417, 18713.157907894176, 18752.156152973148, 18782.0, 18999.145038473303, 7782.182870798485, 7791.454598178187, 7807.375409967189, 7814.10137834145, 8027.2775450209765, 4346.304591265382, 4373.365861950063, 4393.692441529126, 4487.618552423015, 4540.636749060133, 3382.729381649462, 3475.4091804393315, 3478.3043391321835, 3481.1819222482695, 3483.2162763378037, 692.6709812838861, 721.7149226055678, 722.3679280629449, 724.7209824217714, 725.2022774947516, 636.6848410037061, 654.9443297319781, 656.5633853487473, 691.8305015271291, 714.7569826259097, 8454.49273043607, 8763.605637746317, 8807.471551706918, 8960.1935825776, 9154.86267705985, 620.5376994139395, 693.4106009891552, 738.7635956493871, 746.805830484078, 757.1784613694203, 3828.2152158807376, 4131.9173616527505, 4219.135077309205, 4237.957620423756, 4333.285007973649, 66005.66997164984, 68842.65578672074, 69164.3083569168, 69292.30707692858, 69306.65346673335, 59594.404055959756, 60425.69787151124, 60809.0, 61253.38746612566, 61928.071078933855, 54207.728961354944, 54456.45543544514, 54636.453635463135, 54646.0, 54699.45300547023, 7813.609319533887, 7851.5289082652935, 7985.441019128605, 7998.680052798056, 8052.154523775153, 35962.82018589995, 36093.27813443769, 36246.63753362433, 36580.817095915416, 36731.26537469182, 45239.09521809611, 47292.0, 47818.760906195246, 47937.0, 48985.265221022426, 12387.814182787086, 12409.93795031019, 12522.812157817458, 12716.682082948, 13062.020348473712, 13405.66485837862, 13500.594982150551, 13995.230262335263, 14096.718065638835, 14234.572962811133, 9451.716448506555, 11683.824742629038, 11711.238769479956, 12032.819507707567, 12130.575429859913, 11295.322280663186, 11443.084553235887, 11974.58088966882, 11986.580469683518, 12003.1597788154, 12289.692757680772, 12737.490500379881, 13033.543825966046, 13066.085374024107, 13097.934510327768, 9845.556949937414, 9849.359791613522, 9957.153641940517, 10056.798864022532, 10175.949120254352, 9508.619655213713, 10129.290949633749, 10301.896981030393, 10359.741006474898, 10405.115565177044], "value": 6682.131065954716, "unit": "score"}], "name": "dromaeo_css", "value": 7028.138451970732, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 105.0, 110.0, 109.0, 109.0, 111.0, 110.0, 111.0, 109.0, 109.0], "value": 109.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 124.0, 153.0, 220.0, 129.0, 149.0, 151.0, 125.0, 188.0, 128.0], "value": 153.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 160.0, 161.0, 161.0, 160.0, 162.0, 160.0, 161.0, 164.0, 163.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 149.0, 76.0, 74.0, 76.0, 76.0, 135.0, 75.0], "value": 88.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 93.0, 155.0, 91.0, 91.0, 93.0, 129.0, 92.0, 93.0, 117.0], "value": 104.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 118.0, 118.0, 117.0, 117.0, 117.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 145.0, 145.0, 145.0, 146.0, 144.0, 145.0, 145.0, 145.0], "value": 145.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 94.0, 95.0, 94.0, 95.0, 94.0, 94.0, 95.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 58.0, 60.0, 59.0, 59.0, 59.0, 59.0, 129.0, 63.0, 61.0], "value": 67.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 59.0, 59.0, 58.0, 59.0, 58.0, 58.0, 58.0, 59.0], "value": 58.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 79.0, 79.0, 80.0, 86.0, 81.0, 80.0, 80.0, 86.0], "value": 81.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 132.0, 124.0, 123.0, 124.0, 130.0, 123.0, 125.0, 240.0, 135.0], "value": 138.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 169.0, 172.0, 171.0, 178.0, 170.0, 174.0, 180.0, 168.0, 171.0], "value": 172.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 71.0, 66.0, 64.0, 65.0, 64.0, 72.0, 64.0, 63.0, 64.0], "value": 65.8, "unit": "score"}], "name": "kraken", "value": 1558.2, "alertThreshold": 2.0}]} 04:32:09 INFO - Return code: 0 04:32:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:32:09 ERROR - # TBPL SUCCESS # 04:32:09 INFO - Running post-action listener: _resource_record_post_action 04:32:09 INFO - ##### 04:32:09 INFO - ##### Finished run-tests step (success) 04:32:09 INFO - ##### 04:32:09 INFO - Running post-run listener: _resource_record_post_run 04:32:10 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 535076864; Read time: 16; Write time: 621624 04:32:10 INFO - TinderboxPrint: CPU usage
13.2% 04:32:10 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 04:32:10 INFO - TinderboxPrint: I/O write bytes / time
535,076,864 / 621,624 04:32:10 INFO - TinderboxPrint: CPU idle
8,266.1 (86.8%) 04:32:10 INFO - TinderboxPrint: CPU user
1,208.6 (12.7%) 04:32:10 INFO - TinderboxPrint: Swap in / out
0 / 0 04:32:10 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 250933248; Read time: 0; Write time: 284944 04:32:10 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 4096; Write bytes: 284143616; Read time: 16; Write time: 336680 04:32:10 INFO - Running post-run listener: _upload_blobber_files 04:32:10 INFO - Blob upload gear active. 04:32:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:32:10 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 04:32:10 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', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:32:10 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 Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:32:11 INFO - (blobuploader) - INFO - Open directory for files ... 04:32:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:32:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:32:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:32:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:32:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:32:11 INFO - (blobuploader) - INFO - Done attempting. 04:32:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:32:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:32:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:32:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:32:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:32:12 INFO - (blobuploader) - INFO - Done attempting. 04:32:12 INFO - (blobuploader) - INFO - Iteration through files over. 04:32:12 INFO - Return code: 0 04:32:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:32:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:32:12 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f183e5f3b93ba030003f99c21214637adc075235a7d1b63409ddcbf136ad8bc29240c7ace265775d588c1a892f5a5dd6a6c57f77def9d0d2c9a091eff8df2cfd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/2618f1e3ad31d1348b85cdd286b68df7f33be06d6639422eb9e2df7e357371c7b95b271a832919b90da76c7146010723454286ec76e62091f7be0f1cd14bbb86"} 04:32:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:32:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:32:12 INFO - Contents: 04:32:12 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f183e5f3b93ba030003f99c21214637adc075235a7d1b63409ddcbf136ad8bc29240c7ace265775d588c1a892f5a5dd6a6c57f77def9d0d2c9a091eff8df2cfd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/2618f1e3ad31d1348b85cdd286b68df7f33be06d6639422eb9e2df7e357371c7b95b271a832919b90da76c7146010723454286ec76e62091f7be0f1cd14bbb86"} 04:32:12 INFO - Running post-run listener: copy_logs_to_upload_dir 04:32:12 INFO - Copying logs to upload dir... 04:32:12 INFO - mkdir: /builds/slave/test/build/upload/logs 04:32:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.268765 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-05-12 04:32:12.476271) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-12 04:32:12.479936) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1463051464.510196-153851708 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f183e5f3b93ba030003f99c21214637adc075235a7d1b63409ddcbf136ad8bc29240c7ace265775d588c1a892f5a5dd6a6c57f77def9d0d2c9a091eff8df2cfd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/2618f1e3ad31d1348b85cdd286b68df7f33be06d6639422eb9e2df7e357371c7b95b271a832919b90da76c7146010723454286ec76e62091f7be0f1cd14bbb86"} build_url:https://queue.taskcluster.net/v1/task/XRYBGfG2Q3aB06rFyVAMPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011149 build_url: 'https://queue.taskcluster.net/v1/task/XRYBGfG2Q3aB06rFyVAMPw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f183e5f3b93ba030003f99c21214637adc075235a7d1b63409ddcbf136ad8bc29240c7ace265775d588c1a892f5a5dd6a6c57f77def9d0d2c9a091eff8df2cfd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/2618f1e3ad31d1348b85cdd286b68df7f33be06d6639422eb9e2df7e357371c7b95b271a832919b90da76c7146010723454286ec76e62091f7be0f1cd14bbb86"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-12 04:32:12.505152) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 04:32:12.505503) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1463051464.510196-153851708 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004407 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 04:32:12.588042) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-12 04:32:12.588364) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-12 04:32:12.588695) ========= ========= Total master_lag: 0.17 =========