builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-042 starttime: 1461261758.91 results: success (0) buildid: 20160421083523 builduid: a556c14bea2d461aa93adb037c137191 revision: c277eb72ddb0eafcc8068d9dd38a341a45d0155b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-21 11:02:38.907342) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-21 11:02:38.907871) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-21 11:02:38.908169) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-21 11:02:38.923240) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 11:02:38.923533) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1461261734.561604-1132430608 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-21 11:02:39-- 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.3M=0s 2016-04-21 11:02:39 (50.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.128782 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 11:02:39.068218) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 1 secs) (at 2016-04-21 11:02:39.068544) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1461261734.561604-1132430608 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017875 ========= master_lag: 1.12 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 1 secs) (at 2016-04-21 11:02:40.206861) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-21 11:02:40.207315) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev c277eb72ddb0eafcc8068d9dd38a341a45d0155b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev c277eb72ddb0eafcc8068d9dd38a341a45d0155b --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=74d6aec007b0fa31a864ebd7000001f8-1461261734.561604-1132430608 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-21 11:02:40,435 truncating revision to first 12 chars 2016-04-21 11:02:40,435 Setting DEBUG logging. 2016-04-21 11:02:40,435 attempt 1/10 2016-04-21 11:02:40,435 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/c277eb72ddb0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-21 11:02:41,763 unpacking tar archive at: fx-team-c277eb72ddb0/testing/mozharness/ program finished with exit code 0 elapsedTime=1.611224 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-21 11:02:41.834932) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-21 11:02:41.835967) ========= script_repo_revision: c277eb72ddb0eafcc8068d9dd38a341a45d0155b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-21 11:02:41.836387) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-21 11:02:41.836663) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-21 11:02:41.844371) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-04-21 11:02:41.844641) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=74d6aec007b0fa31a864ebd7000001f8-1461261734.561604-1132430608 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:02:42 INFO - MultiFileLogger online at 20160421 11:02:42 in /builds/slave/test 11:02:42 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 11:02:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:02:42 INFO - {'append_to_log': False, 11:02:42 INFO - 'base_work_dir': '/builds/slave/test', 11:02:42 INFO - 'blob_upload_branch': 'Fx-Team', 11:02:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:02:42 INFO - 'branch': 'Fx-Team', 11:02:42 INFO - 'buildbot_json_path': 'buildprops.json', 11:02:42 INFO - 'config_files': ('talos/linux_config.py',), 11:02:42 INFO - 'default_actions': ('clobber', 11:02:42 INFO - 'read-buildbot-config', 11:02:42 INFO - 'download-and-extract', 11:02:42 INFO - 'populate-webroot', 11:02:42 INFO - 'create-virtualenv', 11:02:42 INFO - 'install', 11:02:42 INFO - 'run-tests'), 11:02:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:02:42 INFO - 'download_minidump_stackwalk': True, 11:02:42 INFO - 'download_symbols': 'ondemand', 11:02:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:02:42 INFO - 'tooltool.py': '/tools/tooltool.py', 11:02:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:02:42 INFO - '/tools/misc-python/virtualenv.py')}, 11:02:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:02:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:02:42 INFO - 'installer_path': 'installer.exe', 11:02:42 INFO - 'log_level': 'info', 11:02:42 INFO - 'log_name': 'talos', 11:02:42 INFO - 'log_to_console': True, 11:02:42 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:02:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:02:42 INFO - 'opt_config_files': (), 11:02:42 INFO - 'pip_index': False, 11:02:42 INFO - 'sps_profile': False, 11:02:42 INFO - 'sps_profile_interval': 0, 11:02:42 INFO - 'suite': 'dromaeojs', 11:02:42 INFO - 'system_bits': '32', 11:02:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:02:42 INFO - 'title': 'talos-linux64-ix-042', 11:02:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:02:42 INFO - 'use_talos_json': True, 11:02:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:02:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:02:42 INFO - 'work_dir': 'build'} 11:02:42 INFO - ##### 11:02:42 INFO - ##### Running clobber step. 11:02:42 INFO - ##### 11:02:42 INFO - Running pre-action listener: _resource_record_pre_action 11:02:42 INFO - Running main action method: clobber 11:02:42 INFO - rmtree: /builds/slave/test/build 11:02:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:02:42 INFO - Running post-action listener: _resource_record_post_action 11:02:42 INFO - ##### 11:02:42 INFO - ##### Running read-buildbot-config step. 11:02:42 INFO - ##### 11:02:42 INFO - Running pre-action listener: _resource_record_pre_action 11:02:42 INFO - Running main action method: read_buildbot_config 11:02:42 INFO - Using buildbot properties: 11:02:42 INFO - { 11:02:42 INFO - "project": "", 11:02:42 INFO - "product": "firefox", 11:02:42 INFO - "script_repo_revision": "production", 11:02:42 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 11:02:42 INFO - "repository": "", 11:02:42 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 11:02:42 INFO - "buildid": "20160421083523", 11:02:42 INFO - "pgo_build": "True", 11:02:42 INFO - "basedir": "/builds/slave/test", 11:02:42 INFO - "buildnumber": 1107, 11:02:42 INFO - "slavename": "talos-linux64-ix-042", 11:02:42 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:02:42 INFO - "platform": "ubuntu64_hw", 11:02:42 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 11:02:42 INFO - "branch": "fx-team", 11:02:42 INFO - "repo_path": "integration/fx-team", 11:02:42 INFO - "revision": "c277eb72ddb0eafcc8068d9dd38a341a45d0155b", 11:02:42 INFO - "stage_platform": "linux64-pgo", 11:02:42 INFO - "builduid": "a556c14bea2d461aa93adb037c137191", 11:02:42 INFO - "slavebuilddir": "test" 11:02:42 INFO - } 11:02:42 INFO - Found installer url https://queue.taskcluster.net/v1/task/HF-KsnUjRXeTrnN56Y4sJQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 11:02:42 INFO - Running post-action listener: _resource_record_post_action 11:02:42 INFO - ##### 11:02:42 INFO - ##### Running download-and-extract step. 11:02:42 INFO - ##### 11:02:42 INFO - Running pre-action listener: _resource_record_pre_action 11:02:42 INFO - Running main action method: download_and_extract 11:02:42 INFO - mkdir: /builds/slave/test/build/tests 11:02:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:02:42 INFO - https://queue.taskcluster.net/v1/task/HF-KsnUjRXeTrnN56Y4sJQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 11:02:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HF-KsnUjRXeTrnN56Y4sJQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 11:02:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HF-KsnUjRXeTrnN56Y4sJQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 11:02:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HF-KsnUjRXeTrnN56Y4sJQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 11:02:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HF-KsnUjRXeTrnN56Y4sJQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 11:02:43 INFO - Downloaded 1361 bytes. 11:02:43 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 11:02:43 INFO - Using the following test package requirements: 11:02:43 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 11:02:43 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:02:43 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:02:43 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:02:43 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:02:43 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:02:43 INFO - u'jsshell-linux-x86_64.zip'], 11:02:43 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:02:43 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:02:43 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 11:02:43 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:02:43 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:02:43 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:02:43 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:02:43 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:02:43 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:02:43 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:02:43 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:02:43 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:02:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:02:43 INFO - https://queue.taskcluster.net/v1/task/HF-KsnUjRXeTrnN56Y4sJQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:02:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HF-KsnUjRXeTrnN56Y4sJQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 11:02:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HF-KsnUjRXeTrnN56Y4sJQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 11:02:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HF-KsnUjRXeTrnN56Y4sJQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 11:02:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HF-KsnUjRXeTrnN56Y4sJQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:02:44 INFO - Downloaded 23847634 bytes. 11:02:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:02:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 11:02:45 INFO - Return code: 0 11:02:45 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11:02: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')]} 11:02:45 INFO - https://queue.taskcluster.net/v1/task/HF-KsnUjRXeTrnN56Y4sJQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:02:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HF-KsnUjRXeTrnN56Y4sJQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 11:02:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HF-KsnUjRXeTrnN56Y4sJQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 11:02:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HF-KsnUjRXeTrnN56Y4sJQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 11:02:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HF-KsnUjRXeTrnN56Y4sJQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:02:47 INFO - Downloaded 23847634 bytes. 11:02:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:02:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 11:02:48 INFO - Return code: 0 11:02:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:02:48 INFO - https://queue.taskcluster.net/v1/task/HF-KsnUjRXeTrnN56Y4sJQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:02:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HF-KsnUjRXeTrnN56Y4sJQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 11:02:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HF-KsnUjRXeTrnN56Y4sJQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 11:02:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HF-KsnUjRXeTrnN56Y4sJQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 11:02:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HF-KsnUjRXeTrnN56Y4sJQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:02:49 INFO - Downloaded 10845952 bytes. 11:02:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:02:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 11:02:49 INFO - Return code: 0 11:02:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:02:49 INFO - https://queue.taskcluster.net/v1/task/HF-KsnUjRXeTrnN56Y4sJQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:02:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HF-KsnUjRXeTrnN56Y4sJQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 11:02:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HF-KsnUjRXeTrnN56Y4sJQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 11:02:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HF-KsnUjRXeTrnN56Y4sJQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 11:02:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HF-KsnUjRXeTrnN56Y4sJQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 11:02:52 INFO - Downloaded 58315177 bytes. 11:02:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HF-KsnUjRXeTrnN56Y4sJQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 11:02:52 INFO - mkdir: /builds/slave/test/properties 11:02:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:02:52 INFO - Writing to file /builds/slave/test/properties/build_url 11:02:52 INFO - Contents: 11:02:52 INFO - build_url:https://queue.taskcluster.net/v1/task/HF-KsnUjRXeTrnN56Y4sJQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 11:02:52 INFO - Running post-action listener: _resource_record_post_action 11:02:52 INFO - Running post-action listener: set_extra_try_arguments 11:02:52 INFO - ##### 11:02:52 INFO - ##### Running populate-webroot step. 11:02:52 INFO - ##### 11:02:52 INFO - Running pre-action listener: _resource_record_pre_action 11:02:52 INFO - Running main action method: populate_webroot 11:02:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:02:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:02:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:02:52 INFO - '--tppagecycles', 11:02:52 INFO - '7'], 11:02:52 INFO - 'tests': ['tsvgm']}}, 11:02:52 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:02:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:02:52 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:02:52 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:02:52 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:02:52 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:02:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:02:52 INFO - 'talos_options': ['--disable-e10s'], 11:02:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:02:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:02:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:02:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:02:52 INFO - 'talos_options': ['--disable-e10s'], 11:02:52 INFO - 'tests': ['damp', 'tps']}, 11:02:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:02:52 INFO - 'tests': ['damp', 'tps']}, 11:02:52 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:02:52 INFO - 'tests': ['dromaeo_dom']}, 11:02:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:02:52 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:02:52 INFO - 'tests': ['a11yr', 11:02:52 INFO - 'ts_paint', 11:02:52 INFO - 'tpaint', 11:02:52 INFO - 'sessionrestore', 11:02:52 INFO - 'sessionrestore_no_auto_restore', 11:02:52 INFO - 'tabpaint']}, 11:02:52 INFO - 'other-e10s': {'tests': ['a11yr', 11:02:52 INFO - 'ts_paint', 11:02:52 INFO - 'tpaint', 11:02:52 INFO - 'sessionrestore', 11:02:52 INFO - 'sessionrestore_no_auto_restore', 11:02:52 INFO - 'tabpaint']}, 11:02:52 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:02:52 INFO - 'ts_paint', 11:02:52 INFO - 'tpaint', 11:02:52 INFO - 'sessionrestore', 11:02:52 INFO - 'sessionrestore_no_auto_restore', 11:02:52 INFO - 'tabpaint']}, 11:02:52 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:02:52 INFO - 'ts_paint', 11:02:52 INFO - 'tpaint', 11:02:52 INFO - 'sessionrestore', 11:02:52 INFO - 'sessionrestore_no_auto_restore', 11:02:52 INFO - 'tabpaint']}, 11:02:52 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:02:52 INFO - 'tests': ['a11yr', 11:02:52 INFO - 'ts_paint', 11:02:52 INFO - 'tpaint', 11:02:52 INFO - 'sessionrestore', 11:02:52 INFO - 'sessionrestore_no_auto_restore', 11:02:52 INFO - 'tabpaint']}, 11:02:52 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:02:52 INFO - 'tests': ['a11yr', 11:02:52 INFO - 'ts_paint', 11:02:52 INFO - 'tpaint', 11:02:52 INFO - 'sessionrestore', 11:02:52 INFO - 'sessionrestore_no_auto_restore', 11:02:52 INFO - 'tabpaint']}, 11:02:52 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:02:52 INFO - 'tests': ['tsvgx', 11:02:52 INFO - 'tsvgr_opacity', 11:02:52 INFO - 'tart', 11:02:52 INFO - 'tscrollx', 11:02:52 INFO - 'cart']}, 11:02:52 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:02:52 INFO - 'tsvgr_opacity', 11:02:52 INFO - 'tart', 11:02:52 INFO - 'tscrollx', 11:02:52 INFO - 'cart']}, 11:02:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:02:52 INFO - 'talos_options': ['--disable-e10s'], 11:02:52 INFO - 'tests': ['tp5o']}, 11:02:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:02:52 INFO - 'tests': ['tp5o']}, 11:02:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:02:52 INFO - 'talos_options': ['--disable-e10s', 11:02:52 INFO - '--xperf_path', 11:02:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:02:52 INFO - 'tests': ['tp5n']}, 11:02:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:02:52 INFO - 'talos_options': ['--xperf_path', 11:02:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:02:52 INFO - 'tests': ['tp5n']}}, 11:02:52 INFO - 'talos.zip': {'path': '', 11:02:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:02:52 INFO - Running post-action listener: _resource_record_post_action 11:02:52 INFO - ##### 11:02:52 INFO - ##### Running create-virtualenv step. 11:02:52 INFO - ##### 11:02:52 INFO - Running pre-action listener: _resource_record_pre_action 11:02:52 INFO - Running main action method: create_virtualenv 11:02:52 INFO - Creating virtualenv /builds/slave/test/build/venv 11:02:52 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 11:02:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:02:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:02:52 INFO - Using real prefix '/usr' 11:02:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:02:53 INFO - Installing distribute.............................................................................................................................................................................................done. 11:02:55 INFO - Installing pip.................done. 11:02:55 INFO - Return code: 0 11:02:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:02:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:02:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:02:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:02:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:02:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:02:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:02:55 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 0x7f539ff41f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d6d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e389a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec7810>, '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 0x1ec8710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ec8ba0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1461261734.561604-1132430608', '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 11:02:55 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 11:02:55 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 11:02:55 INFO - Using env: {'DISPLAY': ':0', 11:02:55 INFO - 'HOME': '/home/cltbld', 11:02:55 INFO - 'LANG': 'en_US.UTF-8', 11:02:55 INFO - 'LANGUAGE': 'en_US:en', 11:02:55 INFO - 'LOGNAME': 'cltbld', 11:02:55 INFO - 'MAIL': '/var/mail/cltbld', 11:02:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:02:55 INFO - 'MOZ_NO_REMOTE': '1', 11:02:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:02:55 INFO - 'NO_EM_RESTART': '1', 11:02:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:02:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:02:55 INFO - 'PWD': '/builds/slave/test', 11:02:55 INFO - 'SHELL': '/bin/bash', 11:02:55 INFO - 'SHLVL': '1', 11:02:55 INFO - 'TERM': 'linux', 11:02:55 INFO - 'TMOUT': '86400', 11:02:55 INFO - 'USER': 'cltbld', 11:02:55 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1461261734.561604-1132430608', 11:02:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:02:55 INFO - '_': '/tools/buildbot/bin/python'} 11:02:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:02:55 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 11:02:55 INFO - Cleaning up... 11:02:55 INFO - Return code: 0 11:02:55 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 11:02:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:02:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:02:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:02:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:02:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:02:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:02:55 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 0x7f539ff41f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d6d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e389a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec7810>, '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 0x1ec8710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ec8ba0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1461261734.561604-1132430608', '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 11:02:55 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 11:02:55 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 11:02:55 INFO - Using env: {'DISPLAY': ':0', 11:02:55 INFO - 'HOME': '/home/cltbld', 11:02:55 INFO - 'LANG': 'en_US.UTF-8', 11:02:55 INFO - 'LANGUAGE': 'en_US:en', 11:02:55 INFO - 'LOGNAME': 'cltbld', 11:02:55 INFO - 'MAIL': '/var/mail/cltbld', 11:02:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:02:55 INFO - 'MOZ_NO_REMOTE': '1', 11:02:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:02:55 INFO - 'NO_EM_RESTART': '1', 11:02:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:02:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:02:55 INFO - 'PWD': '/builds/slave/test', 11:02:55 INFO - 'SHELL': '/bin/bash', 11:02:55 INFO - 'SHLVL': '1', 11:02:55 INFO - 'TERM': 'linux', 11:02:55 INFO - 'TMOUT': '86400', 11:02:55 INFO - 'USER': 'cltbld', 11:02:55 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1461261734.561604-1132430608', 11:02:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:02:55 INFO - '_': '/tools/buildbot/bin/python'} 11:02:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:02:55 INFO - Downloading/unpacking psutil>=0.7.1 11:02:55 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 11:02:55 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 11:02:55 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 11:02:55 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 11:02:55 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 11:02:55 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 11:02:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:02:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:02:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:02:57 INFO - Installing collected packages: psutil 11:02:57 INFO - Running setup.py install for psutil 11:02:57 INFO - building 'psutil._psutil_linux' extension 11:02:57 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 11:02:58 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 11:02:58 INFO - building 'psutil._psutil_posix' extension 11:02:58 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 11:02:58 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 11:02:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:02:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:02:58 INFO - Successfully installed psutil 11:02:58 INFO - Cleaning up... 11:02:58 INFO - Return code: 0 11:02:58 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 11:02:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:02:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:02:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:02:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:02:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:02:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:02:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f539ff41f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d6d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e389a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec7810>, '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 0x1ec8710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ec8ba0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1461261734.561604-1132430608', '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 11:02:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 11:02:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 11:02:58 INFO - Using env: {'DISPLAY': ':0', 11:02:58 INFO - 'HOME': '/home/cltbld', 11:02:58 INFO - 'LANG': 'en_US.UTF-8', 11:02:58 INFO - 'LANGUAGE': 'en_US:en', 11:02:58 INFO - 'LOGNAME': 'cltbld', 11:02:58 INFO - 'MAIL': '/var/mail/cltbld', 11:02:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:02:58 INFO - 'MOZ_NO_REMOTE': '1', 11:02:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:02:58 INFO - 'NO_EM_RESTART': '1', 11:02:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:02:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:02:58 INFO - 'PWD': '/builds/slave/test', 11:02:58 INFO - 'SHELL': '/bin/bash', 11:02:58 INFO - 'SHLVL': '1', 11:02:58 INFO - 'TERM': 'linux', 11:02:58 INFO - 'TMOUT': '86400', 11:02:58 INFO - 'USER': 'cltbld', 11:02:58 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1461261734.561604-1132430608', 11:02:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:02:58 INFO - '_': '/tools/buildbot/bin/python'} 11:02:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:02:58 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:02:58 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 11:02:58 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 11:02:58 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 11:02:58 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 11:02:58 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 11:02:58 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 11:03:00 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:03:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:03:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 11:03:00 INFO - Installing collected packages: mozsystemmonitor 11:03:00 INFO - Running setup.py install for mozsystemmonitor 11:03:00 INFO - Successfully installed mozsystemmonitor 11:03:00 INFO - Cleaning up... 11:03:00 INFO - Return code: 0 11:03:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:03:00 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')]} 11:03:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:03:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:03:00 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')]} 11:03:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:03:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:03:00 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 0x7f539ff41f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d6d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e389a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec7810>, '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 0x1ec8710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ec8ba0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1461261734.561604-1132430608', '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 11:03:00 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 11:03:00 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 11:03:00 INFO - Using env: {'DISPLAY': ':0', 11:03:00 INFO - 'HOME': '/home/cltbld', 11:03:00 INFO - 'LANG': 'en_US.UTF-8', 11:03:00 INFO - 'LANGUAGE': 'en_US:en', 11:03:00 INFO - 'LOGNAME': 'cltbld', 11:03:00 INFO - 'MAIL': '/var/mail/cltbld', 11:03:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:03:00 INFO - 'MOZ_NO_REMOTE': '1', 11:03:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:03:00 INFO - 'NO_EM_RESTART': '1', 11:03:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:03:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:03:00 INFO - 'PWD': '/builds/slave/test', 11:03:00 INFO - 'SHELL': '/bin/bash', 11:03:00 INFO - 'SHLVL': '1', 11:03:00 INFO - 'TERM': 'linux', 11:03:00 INFO - 'TMOUT': '86400', 11:03:00 INFO - 'USER': 'cltbld', 11:03:00 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1461261734.561604-1132430608', 11:03:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:03:00 INFO - '_': '/tools/buildbot/bin/python'} 11:03:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:03:00 INFO - Downloading/unpacking blobuploader==1.2.4 11:03:00 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 11:03:00 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 11:03:00 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 11:03:00 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 11:03:00 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 11:03:00 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 11:03:02 INFO - Downloading blobuploader-1.2.4.tar.gz 11:03:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:03:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:03:02 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 11:03:02 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 11:03:02 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 11:03:02 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 11:03:02 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 11:03:02 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 11:03:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:03:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:03:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:03:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:03:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:03:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:03:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:03:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:03:03 INFO - Downloading docopt-0.6.1.tar.gz 11:03:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:03:03 INFO - Installing collected packages: blobuploader, requests, docopt 11:03:03 INFO - Running setup.py install for blobuploader 11:03:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:03:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:03:03 INFO - Running setup.py install for requests 11:03:03 INFO - Running setup.py install for docopt 11:03:04 INFO - Successfully installed blobuploader requests docopt 11:03:04 INFO - Cleaning up... 11:03:04 INFO - Return code: 0 11:03:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:03:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:03:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:03:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:03:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:03:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:03:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:03:04 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 0x7f539ff41f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d6d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e389a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec7810>, '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 0x1ec8710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ec8ba0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1461261734.561604-1132430608', '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 11:03:04 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 11:03:04 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 11:03:04 INFO - Using env: {'DISPLAY': ':0', 11:03:04 INFO - 'HOME': '/home/cltbld', 11:03:04 INFO - 'LANG': 'en_US.UTF-8', 11:03:04 INFO - 'LANGUAGE': 'en_US:en', 11:03:04 INFO - 'LOGNAME': 'cltbld', 11:03:04 INFO - 'MAIL': '/var/mail/cltbld', 11:03:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:03:04 INFO - 'MOZ_NO_REMOTE': '1', 11:03:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:03:04 INFO - 'NO_EM_RESTART': '1', 11:03:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:03:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:03:04 INFO - 'PWD': '/builds/slave/test', 11:03:04 INFO - 'SHELL': '/bin/bash', 11:03:04 INFO - 'SHLVL': '1', 11:03:04 INFO - 'TERM': 'linux', 11:03:04 INFO - 'TMOUT': '86400', 11:03:04 INFO - 'USER': 'cltbld', 11:03:04 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1461261734.561604-1132430608', 11:03:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:03:04 INFO - '_': '/tools/buildbot/bin/python'} 11:03:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:03:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:03:04 INFO - Running setup.py (path:/tmp/pip-D_TWz0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:03:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:03:04 INFO - Running setup.py (path:/tmp/pip-kKVGtz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:03:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:03:04 INFO - Running setup.py (path:/tmp/pip-VpYkWh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:03:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:03:04 INFO - Running setup.py (path:/tmp/pip-a_Z3Zp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:03:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:03:04 INFO - Running setup.py (path:/tmp/pip-DCCFhp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:03:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:03:04 INFO - Running setup.py (path:/tmp/pip-Vy4yjL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:03:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:03:04 INFO - Running setup.py (path:/tmp/pip-tPwGbT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:03:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:03:04 INFO - Running setup.py (path:/tmp/pip-uGNxS9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:03:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:03:04 INFO - Running setup.py (path:/tmp/pip-R349Ap-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:03:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:03:04 INFO - Running setup.py (path:/tmp/pip-Pw6GQN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:03:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:03:05 INFO - Running setup.py (path:/tmp/pip-nDUNtJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:03:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:03:05 INFO - Running setup.py (path:/tmp/pip-_WxBYx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:03:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:03:05 INFO - Running setup.py (path:/tmp/pip-WlNRBz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:03:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:03:05 INFO - Running setup.py (path:/tmp/pip-1sbBOs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:03:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:03:05 INFO - Running setup.py (path:/tmp/pip-snScOY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:03:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:03:05 INFO - Running setup.py (path:/tmp/pip-DnXRIF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:03:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:03:05 INFO - Running setup.py (path:/tmp/pip-MAMiIM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:03:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:03:05 INFO - Running setup.py install for manifestparser 11:03:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:03:05 INFO - Running setup.py install for mozcrash 11:03:05 INFO - Running setup.py install for mozdebug 11:03:05 INFO - Running setup.py install for mozdevice 11:03:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:03:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:03:06 INFO - Running setup.py install for mozfile 11:03:06 INFO - Running setup.py install for mozhttpd 11:03:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:03:06 INFO - Running setup.py install for mozinfo 11:03:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:03:06 INFO - Running setup.py install for mozInstall 11:03:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:03:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:03:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:03:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:03:06 INFO - Running setup.py install for mozleak 11:03:06 INFO - Running setup.py install for mozlog 11:03:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:03:06 INFO - Running setup.py install for moznetwork 11:03:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:03:06 INFO - Running setup.py install for mozprocess 11:03:06 INFO - Running setup.py install for mozprofile 11:03:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:03:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:03:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:03:06 INFO - Running setup.py install for mozrunner 11:03:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:03:07 INFO - Running setup.py install for mozscreenshot 11:03:07 INFO - Running setup.py install for moztest 11:03:07 INFO - Running setup.py install for mozversion 11:03:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:03:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:03:07 INFO - Cleaning up... 11:03:07 INFO - Return code: 0 11:03:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:03:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:03:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:03:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:03:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:03:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:03:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:03:07 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 0x7f539ff41f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d6d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e389a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec7810>, '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 0x1ec8710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ec8ba0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1461261734.561604-1132430608', '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 11:03:07 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 11:03:07 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 11:03:07 INFO - Using env: {'DISPLAY': ':0', 11:03:07 INFO - 'HOME': '/home/cltbld', 11:03:07 INFO - 'LANG': 'en_US.UTF-8', 11:03:07 INFO - 'LANGUAGE': 'en_US:en', 11:03:07 INFO - 'LOGNAME': 'cltbld', 11:03:07 INFO - 'MAIL': '/var/mail/cltbld', 11:03:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:03:07 INFO - 'MOZ_NO_REMOTE': '1', 11:03:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:03:07 INFO - 'NO_EM_RESTART': '1', 11:03:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:03:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:03:07 INFO - 'PWD': '/builds/slave/test', 11:03:07 INFO - 'SHELL': '/bin/bash', 11:03:07 INFO - 'SHLVL': '1', 11:03:07 INFO - 'TERM': 'linux', 11:03:07 INFO - 'TMOUT': '86400', 11:03:07 INFO - 'USER': 'cltbld', 11:03:07 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1461261734.561604-1132430608', 11:03:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:03:07 INFO - '_': '/tools/buildbot/bin/python'} 11:03:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:03:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:03:07 INFO - Running setup.py (path:/tmp/pip-EX4IQu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:03:07 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)) 11:03:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:03:07 INFO - Running setup.py (path:/tmp/pip-7Rphyu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:03:07 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)) 11:03:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:03:07 INFO - Running setup.py (path:/tmp/pip-_zQ9iN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:03:07 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)) 11:03:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:03:07 INFO - Running setup.py (path:/tmp/pip-pQ6zbg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:03:07 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)) 11:03:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:03:07 INFO - Running setup.py (path:/tmp/pip-8myMx_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:03:07 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)) 11:03:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:03:07 INFO - Running setup.py (path:/tmp/pip-cT3jZC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:03:07 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)) 11:03:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:03:07 INFO - Running setup.py (path:/tmp/pip-BtBzo5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:03:08 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)) 11:03:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:03:08 INFO - Running setup.py (path:/tmp/pip-5W69VG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:03:08 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)) 11:03:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:03:08 INFO - Running setup.py (path:/tmp/pip-wMpMJw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:03:08 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)) 11:03:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:03:08 INFO - Running setup.py (path:/tmp/pip-f2QyeF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:03:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:03:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:03:08 INFO - Running setup.py (path:/tmp/pip-09kCFq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:03:08 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)) 11:03:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:03:08 INFO - Running setup.py (path:/tmp/pip-DDViKK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:03:08 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)) 11:03:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:03:08 INFO - Running setup.py (path:/tmp/pip-Zy7X3s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:03:08 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)) 11:03:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:03:08 INFO - Running setup.py (path:/tmp/pip-2DwF6v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:03:08 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)) 11:03:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:03:08 INFO - Running setup.py (path:/tmp/pip-cLjxYJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:03:08 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)) 11:03:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:03:08 INFO - Running setup.py (path:/tmp/pip-rpI_zP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:03:08 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)) 11:03:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:03:08 INFO - Running setup.py (path:/tmp/pip-65qTFz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:03:08 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)) 11:03:08 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)) 11:03:08 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)) 11:03:08 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)) 11:03:08 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)) 11:03:08 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)) 11:03:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:03:08 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 11:03:08 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 11:03:08 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 11:03:08 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 11:03:08 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 11:03:08 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 11:03:10 INFO - Downloading blessings-1.6.tar.gz 11:03:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:03:10 INFO - Installing collected packages: blessings 11:03:10 INFO - Running setup.py install for blessings 11:03:10 INFO - Successfully installed blessings 11:03:10 INFO - Cleaning up... 11:03:10 INFO - Return code: 0 11:03:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:03:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:03:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:03:11 INFO - Reading from file tmpfile_stdout 11:03:11 INFO - Current package versions: 11:03:11 INFO - argparse == 1.2.1 11:03:11 INFO - blessings == 1.6 11:03:11 INFO - blobuploader == 1.2.4 11:03:11 INFO - docopt == 0.6.1 11:03:11 INFO - manifestparser == 1.1 11:03:11 INFO - mozInstall == 1.12 11:03:11 INFO - mozcrash == 0.17 11:03:11 INFO - mozdebug == 0.1 11:03:11 INFO - mozdevice == 0.48 11:03:11 INFO - mozfile == 1.2 11:03:11 INFO - mozhttpd == 0.7 11:03:11 INFO - mozinfo == 0.9 11:03:11 INFO - mozleak == 0.1 11:03:11 INFO - mozlog == 3.1 11:03:11 INFO - moznetwork == 0.27 11:03:11 INFO - mozprocess == 0.22 11:03:11 INFO - mozprofile == 0.28 11:03:11 INFO - mozrunner == 6.11 11:03:11 INFO - mozscreenshot == 0.1 11:03:11 INFO - mozsystemmonitor == 0.0 11:03:11 INFO - moztest == 0.7 11:03:11 INFO - mozversion == 1.4 11:03:11 INFO - psutil == 3.1.1 11:03:11 INFO - requests == 1.2.3 11:03:11 INFO - wsgiref == 0.1.2 11:03:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:03:11 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')]} 11:03:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:03:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:03:11 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')]} 11:03:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:03:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:03:11 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 0x7f539ff41f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d6d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e389a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec7810>, '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 0x1ec8710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ec8ba0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1461261734.561604-1132430608', '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 11:03:11 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 11:03:11 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 11:03:11 INFO - Using env: {'DISPLAY': ':0', 11:03:11 INFO - 'HOME': '/home/cltbld', 11:03:11 INFO - 'LANG': 'en_US.UTF-8', 11:03:11 INFO - 'LANGUAGE': 'en_US:en', 11:03:11 INFO - 'LOGNAME': 'cltbld', 11:03:11 INFO - 'MAIL': '/var/mail/cltbld', 11:03:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:03:11 INFO - 'MOZ_NO_REMOTE': '1', 11:03:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:03:11 INFO - 'NO_EM_RESTART': '1', 11:03:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:03:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:03:11 INFO - 'PWD': '/builds/slave/test', 11:03:11 INFO - 'SHELL': '/bin/bash', 11:03:11 INFO - 'SHLVL': '1', 11:03:11 INFO - 'TERM': 'linux', 11:03:11 INFO - 'TMOUT': '86400', 11:03:11 INFO - 'USER': 'cltbld', 11:03:11 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1461261734.561604-1132430608', 11:03:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:03:11 INFO - '_': '/tools/buildbot/bin/python'} 11:03:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:03:11 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)) 11:03:11 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)) 11:03:11 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)) 11:03:11 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)) 11:03:11 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)) 11:03:11 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)) 11:03:11 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)) 11:03:11 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)) 11:03:11 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)) 11:03:11 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)) 11:03:11 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)) 11:03:11 INFO - Cleaning up... 11:03:11 INFO - Return code: 0 11:03:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:03:11 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')]} 11:03:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:03:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:03:11 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')]} 11:03:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:03:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:03:11 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 0x7f539ff41f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d6d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e389a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec7810>, '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 0x1ec8710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ec8ba0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1461261734.561604-1132430608', '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 11:03:11 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 11:03:11 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 11:03:11 INFO - Using env: {'DISPLAY': ':0', 11:03:11 INFO - 'HOME': '/home/cltbld', 11:03:11 INFO - 'LANG': 'en_US.UTF-8', 11:03:11 INFO - 'LANGUAGE': 'en_US:en', 11:03:11 INFO - 'LOGNAME': 'cltbld', 11:03:11 INFO - 'MAIL': '/var/mail/cltbld', 11:03:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:03:11 INFO - 'MOZ_NO_REMOTE': '1', 11:03:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:03:11 INFO - 'NO_EM_RESTART': '1', 11:03:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:03:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:03:11 INFO - 'PWD': '/builds/slave/test', 11:03:11 INFO - 'SHELL': '/bin/bash', 11:03:11 INFO - 'SHLVL': '1', 11:03:11 INFO - 'TERM': 'linux', 11:03:11 INFO - 'TMOUT': '86400', 11:03:11 INFO - 'USER': 'cltbld', 11:03:11 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1461261734.561604-1132430608', 11:03:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:03:11 INFO - '_': '/tools/buildbot/bin/python'} 11:03:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:03:11 INFO - Downloading/unpacking jsonschema 11:03: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 11:03: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 11:03: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 11:03: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 11:03: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 11:03: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 11:03:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:03:13 INFO - Downloading/unpacking functools32 (from jsonschema) 11:03:13 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 11:03:13 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 11:03:13 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 11:03:13 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 11:03:13 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 11:03:13 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 11:03:13 INFO - Downloading functools32-3.2.3-2.tar.gz 11:03:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:03:13 INFO - warning: no files found matching '*.txt' 11:03:13 INFO - no previously-included directories found matching 'build' 11:03:13 INFO - no previously-included directories found matching 'dist' 11:03:13 INFO - no previously-included directories found matching '.git*' 11:03:13 INFO - Installing collected packages: jsonschema, functools32 11:03:13 INFO - Running setup.py install for functools32 11:03:13 INFO - warning: no files found matching '*.txt' 11:03:13 INFO - no previously-included directories found matching 'build' 11:03:13 INFO - no previously-included directories found matching 'dist' 11:03:13 INFO - no previously-included directories found matching '.git*' 11:03:13 INFO - Successfully installed jsonschema functools32 11:03:13 INFO - Cleaning up... 11:03:13 INFO - Return code: 0 11:03:13 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:03:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:03:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:03:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:03:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:03:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:03:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:03:13 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 0x7f539ff41f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d6d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e389a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec7810>, '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 0x1ec8710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ec8ba0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1461261734.561604-1132430608', '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 11:03:13 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 11:03:13 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 11:03:13 INFO - Using env: {'DISPLAY': ':0', 11:03:13 INFO - 'HOME': '/home/cltbld', 11:03:13 INFO - 'LANG': 'en_US.UTF-8', 11:03:13 INFO - 'LANGUAGE': 'en_US:en', 11:03:13 INFO - 'LOGNAME': 'cltbld', 11:03:13 INFO - 'MAIL': '/var/mail/cltbld', 11:03:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:03:13 INFO - 'MOZ_NO_REMOTE': '1', 11:03:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:03:13 INFO - 'NO_EM_RESTART': '1', 11:03:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:03:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:03:13 INFO - 'PWD': '/builds/slave/test', 11:03:13 INFO - 'SHELL': '/bin/bash', 11:03:13 INFO - 'SHLVL': '1', 11:03:13 INFO - 'TERM': 'linux', 11:03:13 INFO - 'TMOUT': '86400', 11:03:13 INFO - 'USER': 'cltbld', 11:03:13 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1461261734.561604-1132430608', 11:03:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:03:13 INFO - '_': '/tools/buildbot/bin/python'} 11:03:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:03:14 INFO - Downloading/unpacking flake8 11:03: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 11:03: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 11:03: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 11:03: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 11:03: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 11:03: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 11:03:16 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:03:16 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:03:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:03:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:03:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:03:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:03:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:03:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:03:16 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:03:16 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:03:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:03:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:03:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:03:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:03:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:03:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:03:16 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:03:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:03:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:03:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:03:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:03:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:03:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:03:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:03:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:03:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:03:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:03:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:03:16 INFO - no previously-included directories found matching 'docs/_build' 11:03:16 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:03:16 INFO - Running setup.py install for pep8 11:03:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:03:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:03:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:03:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:03:16 INFO - no previously-included directories found matching 'docs/_build' 11:03:16 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:03:16 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:03:16 INFO - Cleaning up... 11:03:17 INFO - Return code: 0 11:03:17 INFO - Running post-action listener: _resource_record_post_action 11:03:17 INFO - Running post-action listener: _start_resource_monitoring 11:03:17 INFO - Starting resource monitoring. 11:03:17 INFO - ##### 11:03:17 INFO - ##### Running install step. 11:03:17 INFO - ##### 11:03:17 INFO - Running pre-action listener: _resource_record_pre_action 11:03:17 INFO - Running main action method: install 11:03:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:03:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:03:17 INFO - Reading from file tmpfile_stdout 11:03:17 INFO - Detecting whether we're running mozinstall >=1.0... 11:03:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:03:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:03:17 INFO - Reading from file tmpfile_stdout 11:03:17 INFO - Output received: 11:03:17 INFO - Usage: mozinstall [options] installer 11:03:17 INFO - Options: 11:03:17 INFO - -h, --help show this help message and exit 11:03:17 INFO - -d DEST, --destination=DEST 11:03:17 INFO - Directory to install application into. [default: 11:03:17 INFO - "/builds/slave/test"] 11:03:17 INFO - --app=APP Application being installed. [default: firefox] 11:03:17 INFO - mkdir: /builds/slave/test/build/application 11:03:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:03:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 11:03:33 INFO - Reading from file tmpfile_stdout 11:03:33 INFO - Output received: 11:03:33 INFO - /builds/slave/test/build/application/firefox/firefox 11:03:33 INFO - Running post-action listener: _resource_record_post_action 11:03:33 INFO - ##### 11:03:33 INFO - ##### Running run-tests step. 11:03:33 INFO - ##### 11:03:33 INFO - Running pre-action listener: _resource_record_pre_action 11:03:33 INFO - Running main action method: run_tests 11:03:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:03:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:03:33 INFO - Python 2.7.3 11:03:33 INFO - Return code: 0 11:03:33 INFO - grabbing minidump binary from tooltool 11:03:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:03:33 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec7810>, '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 0x1ec8710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ec8ba0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:03:33 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 11:03:33 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 11:03:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:03:33 INFO - Return code: 0 11:03:33 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:03:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:03:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:03:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:03:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:03:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:03:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:03:34 INFO - Return code: 0 11:03:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HF-KsnUjRXeTrnN56Y4sJQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--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 11:03:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HF-KsnUjRXeTrnN56Y4sJQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-042 --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 11:03:34 INFO - Using env: {'DISPLAY': ':0', 11:03:34 INFO - 'HOME': '/home/cltbld', 11:03:34 INFO - 'LANG': 'en_US.UTF-8', 11:03:34 INFO - 'LANGUAGE': 'en_US:en', 11:03:34 INFO - 'LOGNAME': 'cltbld', 11:03:34 INFO - 'MAIL': '/var/mail/cltbld', 11:03:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:03:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:03:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:03:34 INFO - 'MOZ_NO_REMOTE': '1', 11:03:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:03:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:03:34 INFO - 'NO_EM_RESTART': '1', 11:03:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:03:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:03:34 INFO - 'PWD': '/builds/slave/test', 11:03:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:03:34 INFO - 'SHELL': '/bin/bash', 11:03:34 INFO - 'SHLVL': '1', 11:03:34 INFO - 'TERM': 'linux', 11:03:34 INFO - 'TMOUT': '86400', 11:03:34 INFO - 'USER': 'cltbld', 11:03:34 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1461261734.561604-1132430608', 11:03:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:03:34 INFO - '_': '/tools/buildbot/bin/python'} 11:03:34 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HF-KsnUjRXeTrnN56Y4sJQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--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 11:03:35 INFO - mozversion application_buildid: 20160421083523 11:03:35 INFO - mozversion application_changeset: c277eb72ddb0eafcc8068d9dd38a341a45d0155b 11:03:35 INFO - mozversion application_display_name: Nightly 11:03:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:03:35 INFO - mozversion application_name: Firefox 11:03:35 INFO - mozversion application_remotingname: firefox 11:03:35 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:03:35 INFO - mozversion application_vendor: Mozilla 11:03:35 INFO - mozversion application_version: 48.0a1 11:03:35 INFO - mozversion platform_buildid: 20160421083523 11:03:35 INFO - mozversion platform_changeset: c277eb72ddb0eafcc8068d9dd38a341a45d0155b 11:03:35 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:03:35 INFO - mozversion platform_version: 48.0a1 11:03:35 INFO - using testdate: 1461261815 11:03:35 INFO - actual date: 1461261815 11:03:35 INFO - starting webserver on 'localhost:52163' 11:03:35 INFO - SUITE-START | Running 2 tests 11:03:35 INFO - TEST-START | dromaeo_css 11:03:35 INFO - operating with platform_type : linux_ 11:03:35 INFO - Initialising browser for dromaeo_css test... 11:03:35 INFO - TEST-INFO | started process 30167 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxlFDGt/profile http://localhost:52163/getInfo.html) 11:03:39 INFO - PROCESS | 30167 | __metrics Screen width/height:1600/1200 11:03:39 INFO - PROCESS | 30167 | colorDepth:24 11:03:39 INFO - PROCESS | 30167 | Browser inner width/height: 1024/697 11:03:39 INFO - PROCESS | 30167 | __metrics 11:03:40 ERROR - PROCESS | 30167 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 11:03:41 INFO - TEST-INFO | 30167: exit 0 11:03:41 INFO - Browser initialized. 11:03:41 INFO - Running cycle 1/1 for dromaeo_css test... 11:03:41 INFO - TEST-INFO | started process 30248 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxlFDGt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:03:52 INFO - PROCESS | 30248 | RSS: Main: 153432064 11:03:52 INFO - PROCESS | 30248 | 11:04:44 INFO - PROCESS | 30248 | 1461261884076 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] 11:06:51 INFO - PROCESS | 30248 | Cycle 1(1): loaded http://localhost:52163/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52163/tests/dromaeo/cssquery-ext.html) 11:06:52 INFO - PROCESS | 30248 | RSS: Main: 255639552 11:06:52 INFO - PROCESS | 30248 | 11:09:54 INFO - PROCESS | 30248 | Cycle 1(1): loaded http://localhost:52163/tests/dromaeo/cssquery-ext.html (next: http://localhost:52163/tests/dromaeo/cssquery-jquery.html) 11:09:55 INFO - PROCESS | 30248 | RSS: Main: 237297664 11:09:55 INFO - PROCESS | 30248 | 11:12:57 INFO - PROCESS | 30248 | Cycle 1(1): loaded http://localhost:52163/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52163/tests/dromaeo/cssquery-mootools.html) 11:12:57 INFO - PROCESS | 30248 | RSS: Main: 234192896 11:12:57 INFO - PROCESS | 30248 | 11:15:59 INFO - PROCESS | 30248 | Cycle 1(1): loaded http://localhost:52163/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52163/tests/dromaeo/cssquery-prototype.html) 11:16:00 INFO - PROCESS | 30248 | RSS: Main: 228630528 11:16:00 INFO - PROCESS | 30248 | 11:19:03 INFO - PROCESS | 30248 | Cycle 1(1): loaded http://localhost:52163/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52163/tests/dromaeo/cssquery-yui.html) 11:19:03 INFO - PROCESS | 30248 | RSS: Main: 222720000 11:19:03 INFO - PROCESS | 30248 | 11:22:06 INFO - PROCESS | 30248 | Cycle 1(1): loaded http://localhost:52163/tests/dromaeo/cssquery-yui.html (next: http://localhost:52163/tests/dromaeo/cssquery-dojo.html) 11:22:06 INFO - PROCESS | 30248 | RSS: Main: 257384448 11:22:06 INFO - PROCESS | 30248 | 11:22:06 INFO - PROCESS | 30248 | __start_tp_report 11:22:06 INFO - PROCESS | 30248 | _x_x_mozilla_page_load 11:22:06 INFO - PROCESS | 30248 | _x_x_mozilla_page_load_details 11:22:06 INFO - PROCESS | 30248 | |i|pagename|runs| 11:22:06 INFO - PROCESS | 30248 | |0;dojo.html;3109.144985129089;3159.778815482914;3193.80837149771;3196.2808368117176;3221.9516707249395;5359.356877174744;5370.167624018273;5371.355437347514;5435.0760370736925;5476.58925580581;5226.2944502492155;5328.040952628526;5339.70631615261;5364.409914909366;5391.002664507069;4811.8075276988875;4849.3453383793085;4948.208286674133;5013.749312534377;5027.572656324199;4957.454679985199;5042.924356134661;5046.596272298208;5055.721935293557;5058.11482990477;4817.156997525454;4821.228603423453;4828.61371090312;4879.268109783526;4975.27858460523;4853.854384368475;4876;4881.877953051202;4883.218685010382;4918.2376731606655;4727.243641017455;4813.95186048142;4831.0820944020525;4867.780949857265;4904.901901961941;5313.654612450178;5350.197470379435;5355.250264962909;5384.434634363374;5403.324584426947;5582.218489411485;5628.577856660767;5634.4365563443735;5635.126555383922;5642.633228840113;5681.0910254359105;5685.232493613392;5703.4011428799795;5791.102379131242;5845.941540584625;5358.089124848785;5360;5360.490753378423;5382.865428364283;5388.164834450667;5796.275465566804;5805.709714514257;5806;5807.216025836543;5831.766729330864;5483.177523371446;5539.556835453234;5598.020346439438;5608.971955140199;5628.352739434936;5718.7426565804635;5724.8282551523525;5726.685032323179;5727.026405511073;5745.827625171251;5686.402927692533;5694.629849059881;5700.059490184156;5702.173184888168;5704.971475142598;5710.457506536873;5715.8571035724435;5811.360750317462;5865.765369385262;5902.173695682608;4375.059362237134;4381.21138195128;4384.824607015684;4387.298032314814;4419.58013988677;3888.1446081861945;3891.7081218908697;3901.336772748583;3930.6855451563806;3954;5401.3518377794135;5478.479544443271;5521.558275338044;5565.693886836182;5571;5661.547076233891;5699.544036477072;5703.401142879938;5711.371749107595;5712.457316554921;5333.7333133343955;5359;5364;5377.220303056035;5417.972910135424;5017.046761115376;5062;5063.645544811828;5090.720010399464;5108.770105345268;5935.169076329317;5961.314448838352;5964.910526342108;5965.522758179335;5966.433188847052;5743.1385292206505;5766.509846662912;5785.218995435563;5788.681622510634;5798.449147330997;5889.911651325147;5892;5895;5902.085176797603;5942.524598032233;5586.888262234814;5619.80330688424;5625.690587017753;5626.521745651666;5629.0712032514175;5623.1846382273525;5653.406392328746;5706.686132262766;5714.885702286014;5724.971375143097;5661.320641523043;5662.5469962402085;5666.46168613981;5666.575006874418;5668.489835914787;5608.859778505407;5644.6613203207935;5646.124850648156;5646.463585959327;5649.12438572022;5476.123820188751;5477.1510415885605;5550.139728342114;5602.747876345493;5644.040513112863;5600.327960644749;5600.719964001865;5609.411011843697;5623.550115990793;5630.5214056805635;5481.561475081904;5485.61600687964;5490.505854473116;5491.066518691752;5519.337679478328 11:22:06 INFO - PROCESS | 30248 | |1;ext.html;593.9881202375952;626.5770604841732;641.115260939903;649.5420728386488;691.6092407789596;30963.69036309636;31561;31676.841615791916;31764.20589485264;37629;41462.37806432906;42335.78832105835;42365.36451953223;42500.57499425005;42524.14951700972;8535.31717462603;8741.43180693256;8744.8688269676;8748.387612867102;8753.649854005833;8585.484870907734;8702.521361325125;8704.477731336141;8706.651733930636;8707.695230666928;8702.47785132894;8978.147076027799;8987.595558199897;8990.190882820545;8992.910070899305;8862.60118294675;8928.241099506517;8932.553372331422;8936.687215947411;8940.463572185658;8792.8681069784;8907.109289071106;8916.06381329964;8917.92984841823;8925.241354484877;41959.16081678349;42473.57526424727;42493.78753106246;42497.787511062554;42577.78711106456;3502.7548071634997;4009.67922566194;4216.771363047157;4293.141371725667;4326.675499337531;31546.211344716336;31675.524867127013;31844.203894902814;31983.84008079968;32449.35101297961;4108.5275193352845;4139.937900931488;4188.518320393163;4196.643285320752;4387.232234358974;303000;303111;303722;303855;303913;56294;56729.432705672414;57216.71391643015;57251.71374143103;57315;61014;61032.38967610356;61246.693766531775;61315.38684613097;61387.38612613906;15639.452619158503;15919.124448155231;15921.124338161513;15924.601884952737;15932.362705491882;12066;12232.327222002697;12233.571824986082;12247.632571022883;12249.510019599295;16142.19289035567;17359.222524396035;17656.382026629006;17659.73510397345;17664.823351766318;5186.5850731941355;5930.614510056919;6115.510759139258;6228.532860035515;6303.590266632654;1039;1053.0785562632695;1100.7358234023936;1162.2213117211488;1197.3354788092693;32015.83992080025;32852.52163652593;33089;33456.330873382394;33567.83216083953;1142.23470274916;1142.4116579961326;1147;1215.3862299538675;1227.490591404557;16828.411005614744;17139.57151071208;17412.91293543524;17549.21028553718;17694.469165925042;434939;440272;440471;440528;441929;58768;59125.40874591285;59154;59322;59382.70308648429;1267.1889990406148;1408.4647833823083;1411.795160270605;1423.757961146587;1496.2817847433294;28975.5653665191;29754.851225743732;30004.099877003726;30507.389852203276;32620.347593048482;46717;46955.29567056429;47008.29487557758;47293.76353118212;47348.7632561835;291644;293169;294010;294358;295016;36923.26153476969;42419;42502;42972.57027429811;44660.55339446564;47466.28800567925;52615.473845261055;53991;54046;54727.17909231444;39358;40248.597514024485;40944.18111637691;40961.38557921574;41791.58208417999;39082;39319.41020884746;39971.40042899417;40388.19223615452;41208;41995;42264.366034508894;45098.54901450944;46393.30410043785;46478.30282545832;32814.17964550905;35234.47148292829;35243.118922027155;35761.821190893876;35846.103847404025;27390.178294651192;27464.862675686494;27757.44485110246;27825.71525140658;28100.43799124047 11:22:06 INFO - PROCESS | 30248 | |2;jquery.html;380.7106598984773;381.90834199792056;395.4562476594683;405.11078183387457;408.08995939055905;15988.12065336406;18184.63630727388;18319.358822441216;18383.72424413633;18444.723329150074;17136.31454741809;18037.7294340585;19347.806521934777;19661.50846228845;19682.11430485628;5013.573846223076;5082.949170508294;5146.356705411824;5241.292425522563;5244.816431424901;5163.096458119833;5168.638195326329;5197.1424714922;5210.192420174879;5211.42674305826;4982.302477653131;5178.482151784829;5181.01560703467;5182.300389447414;5184.507471790174;5174.689518628894;5188.377394712658;5228.73856307185;5243.2659427680155;5270.631055826094;4844.224924012141;5016.021875734234;5050.343455350818;5060.949390506122;5062.949370506285;16746.6650666986;16825.747613785803;17056.403025894157;22421;22424.215152469584;2187.048633844283;2216.36833502451;2218.1792736687366;2386.140989243871;2650.642163307967;10491.895081049244;10554.47227638615;10721.195910306758;12953.352332383343;13652.931735341259;1932.154792173471;1992.930247441347;1997.2111016148685;2016.2136766661015;2042.2137477071285;75107.24892751058;78422;79110.60444697739;79390;79933.60033199855;10083.495825208856;10604.575816967235;10745.570177192982;10972.451377431096;11080.501377438035;15634.921825391028;15636.140012299205;15762;15781.447649332218;15789;8019.9198008019175;8087.797805054803;8134.349252059821;8177.223163799429;8282.71010514629;7732.149463559004;7795.22047795216;7807;7887.44787864844;7891.960540197262;4764.4520880098535;4785.114753770564;4807.206810876166;4898.191798353303;4925.827596034122;1934.845212383006;1953.6288105259955;1972.635062513411;1990.8506861985409;2021.9393418197478;952.2001518724305;1027.6865556005341;1032.4373216596973;1043.0404028293988;1128.3343918704265;17879.28482860671;19085.332013379466;19134.52163695891;19165.425037248904;19230.23079076821;1055.5777688924338;1055.9577616895392;1065.472591067411;1093.7156339351825;1097.6706987903756;10466.424346661006;10895.400752958663;10902.618408355669;10908.181886358554;10946.741124770593;486304;497893;503340;504659;506381;65199.67400162969;81660;82782.58608707039;91036;95209.52395238118;1059.9788004239872;1064.7870425914848;1068.1988508618535;1103.8564986551696;1119.9888001120048;15421.922890385476;16299.918500407422;17036.65926681484;17107.572310692332;17362.045087520306;37903;38096.61903380931;38780.41829372618;39032.609673902894;39164.21671566496;49461.50538494713;50415;50912.23631645602;51186.48813511966;51486;8163.306118979954;8697.521636310064;8786.704538106074;8857.025727170136;9015.504147271962;9626.037396260317;10824.837627435438;12610.810837837624;12917.095803294054;13633.25017124028;11275.210735248782;11625.709357265798;11675.124365672438;11730.941345293219;11909;10925.344479331265;11386.829197561878;11706.35615041181;11748.706282342668;11972.102092342935;9064.682736104205;11257.268277561932;11347;11574.594889178838;12142.210756300812;8744.956275218838;8829.69096081634;8885.777855553662;8947.463152210888;9075.183233509017;8374.958125209336;10718.303310285119;11103.278286911647;11379.487923043318;11594.76810463803 11:22:06 INFO - PROCESS | 30248 | |3;mootools.html;1363.5023216525958;1541.8381069987652;1574.7559128335106;1754.4385796545102;1870.298638010746;7585.5069420487625;8255.257026867588;8454.365922555802;8469.91530084699;8486.44838085524;8190.385721070928;8354.081051084377;8361.41470097092;8362.038365587943;8365.539895305756;2061.4228016155503;2140.5825863956534;2142;2381.4879800842814;2415.0219161239725;2343.1564636730764;2413.3966508372905;2427.987860060697;2434.8904299306487;2440.3777036855577;2325.9185928492507;2334.2297041976108;2338.4153961509624;2340.96488552671;2393.6648869158244;2060.546679730472;2149.537849362395;2363.1492662641435;2371.5612611666897;2373.276150774022;2123.851330406872;2249.55008998201;2317.640765681322;2319.744828068911;2322.6864373309554;8454.027786804474;8509.106543812872;8534.786630334229;8546.444481108709;8546.487210767375;5090.185570308733;5248.21276808478;5282.524572788468;5297.099493086184;5297.947020529784;3366.1416338833687;3393.6097348804956;3404.6935775780053;3426.6573342665783;3427.674370934782;1124.3254047571475;1137.2494153858413;1140.5494829542283;1166.5683697032068;1172.8944395004492;11348.773024539463;11351.659450216506;11368.488418021127;11373.203875728703;11382.886171138265;4453.643708503312;4472.955270447319;4650.627949764078;4683.414573178353;4730.526947305242;9642.469664168539;9675.612975480903;9680.322377433513;9681.080297371738;9684.08001239881;5166.560842328369;5199.66202196856;5208.0365132450615;5216.37403511581;5219.164933610604;4182.247195504778;4637.188492013884;4727.858164255078;4766;4848.781804818792;3862.1117143057254;3898.3372826619543;3949.4865667463046;3965.4250133730447;3998.4002399640285;1293.644247831835;1300.7073408483204;1307.1764788183384;1320.3530270167741;1324.417256407197;898.5641963647626;995.7049002050344;997.102607653118;1014.2595904989399;1026.1688032693542;5653.067243904709;5657.688827114466;5723.713814309352;5750.051241545182;5775.624584402;453.98184072637383;467.5815145444808;468.5361492122842;474.3548773667809;479.9136155491975;3928;3958.5645578986287;3969.960300397017;3977.76133431995;3982.506560039985;10287.279890407599;10711.143108551452;10809.243352965217;10810.621628242974;10871.27099711628;10326.896731032593;10576.682699519026;10709.357438553712;10736.30214036085;10843.51204195813;8023.1976802319305;8035.919640803517;8091.919080809234;8144.226298501514;8184.549849758201;5766.855828604318;5916.674582897982;6017.518598512196;6070.18052562916;6117.296510901126;9250.95374523123;9431.151196392084;9438.056194380508;9447.480388578419;9496.43021418717;9508.524573771145;9579.712608621752;9579.994100619335;9717.368371055858;9749.463779491913;6939.895901561582;7397.667104980396;7408.592527410829;7480.850382992201;7667.693292268247;8428.747137585882;8469.74590762278;8578.699745508877;8583.699570515002;8595.52724600153;7572.962135189288;7765.844683106419;7808.336291415293;7829;7924.920750792418;7603.289259916474;7657;7675.923240767521;7753.185915479019;7821.178776228414;6907.412869906114;6955.826104347432;6957.965210173917;6976.790696279119;6988.4059854910865;4717.292406139107;4793.859081450785;4859.271109333628;4861.149298872754;4915.631327650369;4726.62187025044;4770.236762118045;4787.066522028171;4826.3243145958895;4832.057748739103 11:22:06 INFO - PROCESS | 30248 | |4;prototype.html;325.4288723290625;335.1604231400342;340.7750884416285;341.0297703034868;343.8160584087512;5451.373092094405;5542.612017158801;5568.638038527492;5691.288588926384;5739.626924249931;5591.944080559193;5598.944010559893;5612.550995920326;5625.578081643883;5642.774289028444;4320.8333749887515;4358.912821743564;4365.716228445157;4382.956170438302;4390.5609439056;3879.35990561557;4114.485689288839;4265.402843601898;4265.509466411371;4279.165562715271;4222.387753775701;4231.619154276114;4240.406343111967;4244.320908654616;4247.575242475758;4038.676905847525;4237.957620423787;4250.638695710883;4253.08611124995;4253.3619957006385;3668.358037343481;3747.962520374816;3760.2855457462992;3775.0751065989007;3783.6027217142077;5397.298351214317;5422.376426710939;5431.185322201662;5432.375276843135;5445.891082178334;4759.61923046159;4923.876903077416;4931.778069986859;4936.284238785356;4949.133901567247;5785.710714464302;5787.305523337226;5822.301323841124;5833.504152147073;5840.737166827503;4114.588541145891;4128.967758060485;4130.483689538808;4137.958620413788;4142.212979533909;5642.6551555302185;5664.660120392789;5972.193753843219;6062.757489700407;6079.422454866781;4216.451861258078;4224.9155016899485;4230.725002874803;4234.894127646833;4235.661147108224;4244.193603215441;4245.235857545671;4248.256555102845;4271.295236285978;4306.074194048295;4869.902601947942;4873.537013983666;4893.657443978887;4907.975460122677;4921;5696.629719068247;5899.46904778572;5910.290765108214;5923.111533270044;5923.970380148072;1468.2365170111482;1487.7098965701584;1488.672492051747;1490.46343316406;1494.0512774388123;959.4003747657714;991.1228562722043;1006.6476733143342;1008.3496144986443;1010.3281317923498;5649.604527683023;5652.689102099342;5669.461401166883;5675.57433192504;5676.091825307931;6071.635701857903;6073.600927633648;6075;6075.513958883367;6094.11635312886;5538.723063846792;5624.97187514068;5657.57568182388;5677.602567820213;5691.630044047124;3234.9029529114164;3237.546743455918;3261.3803377358226;3267.460868956643;3271.247613049012;6019.54853385989;6208.317085120633;6220.7511699531515;6260.718267677966;6277.121203031579;6074.210352654127;6083.8479038023515;6104.267487901391;6124.733848476092;6138.877222455526;5958.255218097738;6021.969890150609;6212;6222.719977601018;6306.558540902093;6139.3553676863285;6140.293866205265;6142.692865356625;6148.907766383597;6159.384061593805;5758.654480731169;6024.789132380346;6060.909086363797;6061.090836374579;6063.242094738158;6287.2769631492965;6293.496520278275;6325.905111423241;6326.2092238470195;6330.873382532415;4232.597903199191;4259.38238955356;4273.529911709772;4287.292596721506;4291.249031419551;5927.8221653350465;6089.54328425361;6118.143459915705;6120.112583675431;6134.38656134383;5886.440788125121;5933.228680271537;5964.463198311999;5970.701464926823;6004.759809607742;5802.912956305574;5900.43945825146;5904.852378690567;5931.673757943355;6011.273010733374;5831.970840145772;5834.970825145847;5841.912371314519;5866.178734977192;5867.647941123546;5941.851453713692;5996.5502587305255;5996.5502587307;6008.8497787553915;6019.307779605227;5730.369659337553;5839.795607153729;5858.121281807763;5870.119482077552;5898.1152827076285 11:22:06 INFO - PROCESS | 30248 | |5;yui.html;732.8314487667833;796.0884786918978;803.3854101612268;869.3827382558384;874.1870060843413;15232.162231077285;15428.61428464289;15432.151231682254;15472.922635386836;15483.922580387083;14016.22910739909;14078.859211407882;14093.859061409383;14110.435582576685;14121.646958826035;690.0856365315964;793.9841203175934;824.5918270456102;826.5371392020458;826.6982551368737;810.0765127754365;820.6184124382161;821.1542111625035;821.593311310902;823.0411570520366;722.7217521254329;881.4358810361374;882.8234353129368;882.8852249207594;883.5361435246515;851.6721062390993;867.4665080975218;867.9522626255554;868.0191383736369;868.6916144768579;638.2819328255713;638.6327861479667;638.8818068657313;638.9105525226425;638.916940797698;14663.266836658231;14723.558293251113;14732.631684207874;14744.55766327012;14805.259737013213;14157.787633185511;14292.571222863331;14354.425822967174;14448.638784030378;14496.130232185997;11510.366929818856;11596.94201528987;11798.705032374173;11982;12341.321227332493;3802.790846503441;3814.294355544233;3845.711571632111;3860.942085868714;3922.7450215735885;51252.74373628108;51255;51308.48691513074;51343.229851552256;51546.74226628843;10264.846027309597;10467.371957682564;10571.260011799253;10697.786044279072;10776.622818201482;19187.712184317246;19492.512687182934;19613.21547138127;19637.60724785525;19653.60692786165;8432.283255923316;8655.394122411371;8709.042005379402;8750.956245218733;8895.599698013604;4495.078508905666;4502.662300327489;4610.423697037871;4727.314539391838;4954.752262386866;3363.64681708422;3432.4164891968426;3455.395305821471;3455.6198818129988;3456.187795867969;634.2895956528625;647.873664635401;654.9672516374162;655.7475371981822;662.0962386342608;701.4073108223542;717.5515302935665;730.9597972111478;789.5105034878412;796.3788245168778;8789.560521974003;8814.691485797966;8863.822723545492;8888.911110888937;8905.243054340453;698.2877464985686;749.6663984526833;754.6000619671582;776.3788968824917;782.7025730222592;4045.150518391171;4558.202314594932;4638.6752927294765;4696.976515117471;4709.3877795887;64822;66052.669736651;66420.66789666118;66691.33308666851;66741.6662916692;43659.126817463475;45871.31193032107;50239.24641130386;53720;53904;45823.31265031027;47054.29418558656;47730.5226947733;47871.28193077107;48588;8206.630701618322;8722.825543488967;8763.868541972002;8783.556215948489;9009.549522523717;31377;31379;31574.526382104745;31899.84050079735;33198.668013319555;36634;38536.6146338533;40485.79757101196;42012.36981445342;44370.55629443664;11569.88430115688;11672.124590655905;11692.883071169179;11698.649040528799;11713.297202167898;12650.746985060063;12973.610791676265;13081.280529570964;13143.934280328536;13228.206307621573;12417.254964702146;12512.374381280717;12892.613221603367;12892.677683057998;12971;12390.132690711564;12872.485100595872;13033.348332583144;13111.868881311064;13133.146345487512;11587.130965177814;11662.183647144957;11698.94150529242;12001.219920705125;12007.579734709243;10144.847827282745;10435.530401131815;10465.319754215952;10916.07213386871;10926.235163538477;10393.896061039293;10593.364398136137;11025.393603351571;11048;11087.44562771842 11:22:06 INFO - PROCESS | 30248 | __end_tp_report 11:22:06 INFO - PROCESS | 30248 | __start_cc_report 11:22:06 INFO - PROCESS | 30248 | _x_x_mozilla_cycle_collect,878 11:22:06 INFO - PROCESS | 30248 | __end_cc_report 11:22:06 INFO - PROCESS | 30248 | __startTimestamp1461262926443__endTimestamp 11:22:06 INFO - PROCESS | 30248 | 11:22:06 INFO - PROCESS | 30248 | ------- Summary: start ------- 11:22:06 INFO - PROCESS | 30248 | Number of tests: 6 11:22:06 INFO - PROCESS | 30248 | 11:22:06 INFO - PROCESS | 30248 | [#0] dojo.html Cycles:165 Average:5333.38 Median:5550.14 stddev:586.96 (10.6%) stddev-sans-first:562.23 11:22:06 INFO - PROCESS | 30248 | Values: 3109.1 3159.8 3193.8 3196.3 3222.0 5359.4 5370.2 5371.4 5435.1 5476.6 5226.3 5328.0 5339.7 5364.4 5391.0 4811.8 4849.3 4948.2 5013.7 5027.6 4957.5 5042.9 5046.6 5055.7 5058.1 4817.2 4821.2 4828.6 4879.3 4975.3 4853.9 4876.0 4881.9 4883.2 4918.2 4727.2 4814.0 4831.1 4867.8 4904.9 5313.7 5350.2 5355.3 5384.4 5403.3 5582.2 5628.6 5634.4 5635.1 5642.6 5681.1 5685.2 5703.4 5791.1 5845.9 5358.1 5360.0 5360.5 5382.9 5388.2 5796.3 5805.7 5806.0 5807.2 5831.8 5483.2 5539.6 5598.0 5609.0 5628.4 5718.7 5724.8 5726.7 5727.0 5745.8 5686.4 5694.6 5700.1 5702.2 5705.0 5710.5 5715.9 5811.4 5865.8 5902.2 4375.1 4381.2 4384.8 4387.3 4419.6 3888.1 3891.7 3901.3 3930.7 3954.0 5401.4 5478.5 5521.6 5565.7 5571.0 5661.5 5699.5 5703.4 5711.4 5712.5 5333.7 5359.0 5364.0 5377.2 5418.0 5017.0 5062.0 5063.6 5090.7 5108.8 5935.2 5961.3 5964.9 5965.5 5966.4 5743.1 5766.5 5785.2 5788.7 5798.4 5889.9 5892.0 5895.0 5902.1 5942.5 5586.9 5619.8 5625.7 5626.5 5629.1 5623.2 5653.4 5706.7 5714.9 5725.0 5661.3 5662.5 5666.5 5666.6 5668.5 5608.9 5644.7 5646.1 5646.5 5649.1 5476.1 5477.2 5550.1 5602.7 5644.0 5600.3 5600.7 5609.4 5623.6 5630.5 5481.6 5485.6 5490.5 5491.1 5519.3 11:22:06 INFO - PROCESS | 30248 | 11:22:06 INFO - PROCESS | 30248 | [#1] ext.html Cycles:180 Average:52261.63 Median:22990.05 stddev:92591.42 (402.7%) stddev-sans-first:92769.90 11:22:06 INFO - PROCESS | 30248 | Values: 594.0 626.6 641.1 649.5 691.6 30963.7 31561.0 31676.8 31764.2 37629.0 41462.4 42335.8 42365.4 42500.6 42524.1 8535.3 8741.4 8744.9 8748.4 8753.6 8585.5 8702.5 8704.5 8706.7 8707.7 8702.5 8978.1 8987.6 8990.2 8992.9 8862.6 8928.2 8932.6 8936.7 8940.5 8792.9 8907.1 8916.1 8917.9 8925.2 41959.2 42473.6 42493.8 42497.8 42577.8 3502.8 4009.7 4216.8 4293.1 4326.7 31546.2 31675.5 31844.2 31983.8 32449.4 4108.5 4139.9 4188.5 4196.6 4387.2 303000.0 303111.0 303722.0 303855.0 303913.0 56294.0 56729.4 57216.7 57251.7 57315.0 61014.0 61032.4 61246.7 61315.4 61387.4 15639.5 15919.1 15921.1 15924.6 15932.4 12066.0 12232.3 12233.6 12247.6 12249.5 16142.2 17359.2 17656.4 17659.7 17664.8 5186.6 5930.6 6115.5 6228.5 6303.6 1039.0 1053.1 1100.7 1162.2 1197.3 32015.8 32852.5 33089.0 33456.3 33567.8 1142.2 1142.4 1147.0 1215.4 1227.5 16828.4 17139.6 17412.9 17549.2 17694.5 434939.0 440272.0 440471.0 440528.0 441929.0 58768.0 59125.4 59154.0 59322.0 59382.7 1267.2 1408.5 1411.8 1423.8 1496.3 28975.6 29754.9 30004.1 30507.4 32620.3 46717.0 46955.3 47008.3 47293.8 47348.8 291644.0 293169.0 294010.0 294358.0 295016.0 36923.3 42419.0 42502.0 42972.6 44660.6 47466.3 52615.5 53991.0 54046.0 54727.2 39358.0 40248.6 40944.2 40961.4 41791.6 39082.0 39319.4 39971.4 40388.2 41208.0 41995.0 42264.4 45098.5 46393.3 46478.3 32814.2 35234.5 35243.1 35761.8 35846.1 27390.2 27464.9 27757.4 27825.7 28100.4 11:22:06 INFO - PROCESS | 30248 | 11:22:06 INFO - PROCESS | 30248 | [#2] jquery.html Cycles:180 Average:28377.43 Median:2217.27 stddev:82118.60 (3703.6%) stddev-sans-first:82322.05 11:22:06 INFO - PROCESS | 30248 | Values: 380.7 381.9 395.5 405.1 408.1 15988.1 18184.6 18319.4 18383.7 18444.7 17136.3 18037.7 19347.8 19661.5 19682.1 5013.6 5082.9 5146.4 5241.3 5244.8 5163.1 5168.6 5197.1 5210.2 5211.4 4982.3 5178.5 5181.0 5182.3 5184.5 5174.7 5188.4 5228.7 5243.3 5270.6 4844.2 5016.0 5050.3 5060.9 5062.9 16746.7 16825.7 17056.4 22421.0 22424.2 2187.0 2216.4 2218.2 2386.1 2650.6 10491.9 10554.5 10721.2 12953.4 13652.9 1932.2 1992.9 1997.2 2016.2 2042.2 75107.2 78422.0 79110.6 79390.0 79933.6 10083.5 10604.6 10745.6 10972.5 11080.5 15634.9 15636.1 15762.0 15781.4 15789.0 8019.9 8087.8 8134.3 8177.2 8282.7 7732.1 7795.2 7807.0 7887.4 7892.0 4764.5 4785.1 4807.2 4898.2 4925.8 1934.8 1953.6 1972.6 1990.9 2021.9 952.2 1027.7 1032.4 1043.0 1128.3 17879.3 19085.3 19134.5 19165.4 19230.2 1055.6 1056.0 1065.5 1093.7 1097.7 10466.4 10895.4 10902.6 10908.2 10946.7 486304.0 497893.0 503340.0 504659.0 506381.0 65199.7 81660.0 82782.6 91036.0 95209.5 1060.0 1064.8 1068.2 1103.9 1120.0 15421.9 16299.9 17036.7 17107.6 17362.0 37903.0 38096.6 38780.4 39032.6 39164.2 49461.5 50415.0 50912.2 51186.5 51486.0 8163.3 8697.5 8786.7 8857.0 9015.5 9626.0 10824.8 12610.8 12917.1 13633.3 11275.2 11625.7 11675.1 11730.9 11909.0 10925.3 11386.8 11706.4 11748.7 11972.1 9064.7 11257.3 11347.0 11574.6 12142.2 8745.0 8829.7 8885.8 8947.5 9075.2 8375.0 10718.3 11103.3 11379.5 11594.8 11:22:06 INFO - PROCESS | 30248 | 11:22:06 INFO - PROCESS | 30248 | [#3] mootools.html Cycles:180 Average:5619.20 Median:4810.09 stddev:3146.07 (65.4%) stddev-sans-first:3138.64 11:22:06 INFO - PROCESS | 30248 | Values: 1363.5 1541.8 1574.8 1754.4 1870.3 7585.5 8255.3 8454.4 8469.9 8486.4 8190.4 8354.1 8361.4 8362.0 8365.5 2061.4 2140.6 2142.0 2381.5 2415.0 2343.2 2413.4 2428.0 2434.9 2440.4 2325.9 2334.2 2338.4 2341.0 2393.7 2060.5 2149.5 2363.1 2371.6 2373.3 2123.9 2249.6 2317.6 2319.7 2322.7 8454.0 8509.1 8534.8 8546.4 8546.5 5090.2 5248.2 5282.5 5297.1 5297.9 3366.1 3393.6 3404.7 3426.7 3427.7 1124.3 1137.2 1140.5 1166.6 1172.9 11348.8 11351.7 11368.5 11373.2 11382.9 4453.6 4473.0 4650.6 4683.4 4730.5 9642.5 9675.6 9680.3 9681.1 9684.1 5166.6 5199.7 5208.0 5216.4 5219.2 4182.2 4637.2 4727.9 4766.0 4848.8 3862.1 3898.3 3949.5 3965.4 3998.4 1293.6 1300.7 1307.2 1320.4 1324.4 898.6 995.7 997.1 1014.3 1026.2 5653.1 5657.7 5723.7 5750.1 5775.6 454.0 467.6 468.5 474.4 479.9 3928.0 3958.6 3970.0 3977.8 3982.5 10287.3 10711.1 10809.2 10810.6 10871.3 10326.9 10576.7 10709.4 10736.3 10843.5 8023.2 8035.9 8091.9 8144.2 8184.5 5766.9 5916.7 6017.5 6070.2 6117.3 9251.0 9431.2 9438.1 9447.5 9496.4 9508.5 9579.7 9580.0 9717.4 9749.5 6939.9 7397.7 7408.6 7480.9 7667.7 8428.7 8469.7 8578.7 8583.7 8595.5 7573.0 7765.8 7808.3 7829.0 7924.9 7603.3 7657.0 7675.9 7753.2 7821.2 6907.4 6955.8 6958.0 6976.8 6988.4 4717.3 4793.9 4859.3 4861.1 4915.6 4726.6 4770.2 4787.1 4826.3 4832.1 11:22:06 INFO - PROCESS | 30248 | 11:22:06 INFO - PROCESS | 30248 | [#4] prototype.html Cycles:180 Average:4932.82 Median:5655.13 stddev:1475.46 (26.1%) stddev-sans-first:1438.51 11:22:06 INFO - PROCESS | 30248 | Values: 325.4 335.2 340.8 341.0 343.8 5451.4 5542.6 5568.6 5691.3 5739.6 5591.9 5598.9 5612.6 5625.6 5642.8 4320.8 4358.9 4365.7 4383.0 4390.6 3879.4 4114.5 4265.4 4265.5 4279.2 4222.4 4231.6 4240.4 4244.3 4247.6 4038.7 4238.0 4250.6 4253.1 4253.4 3668.4 3748.0 3760.3 3775.1 3783.6 5397.3 5422.4 5431.2 5432.4 5445.9 4759.6 4923.9 4931.8 4936.3 4949.1 5785.7 5787.3 5822.3 5833.5 5840.7 4114.6 4129.0 4130.5 4138.0 4142.2 5642.7 5664.7 5972.2 6062.8 6079.4 4216.5 4224.9 4230.7 4234.9 4235.7 4244.2 4245.2 4248.3 4271.3 4306.1 4869.9 4873.5 4893.7 4908.0 4921.0 5696.6 5899.5 5910.3 5923.1 5924.0 1468.2 1487.7 1488.7 1490.5 1494.1 959.4 991.1 1006.6 1008.3 1010.3 5649.6 5652.7 5669.5 5675.6 5676.1 6071.6 6073.6 6075.0 6075.5 6094.1 5538.7 5625.0 5657.6 5677.6 5691.6 3234.9 3237.5 3261.4 3267.5 3271.2 6019.5 6208.3 6220.8 6260.7 6277.1 6074.2 6083.8 6104.3 6124.7 6138.9 5958.3 6022.0 6212.0 6222.7 6306.6 6139.4 6140.3 6142.7 6148.9 6159.4 5758.7 6024.8 6060.9 6061.1 6063.2 6287.3 6293.5 6325.9 6326.2 6330.9 4232.6 4259.4 4273.5 4287.3 4291.2 5927.8 6089.5 6118.1 6120.1 6134.4 5886.4 5933.2 5964.5 5970.7 6004.8 5802.9 5900.4 5904.9 5931.7 6011.3 5832.0 5835.0 5841.9 5866.2 5867.6 5941.9 5996.6 5996.6 6008.8 6019.3 5730.4 5839.8 5858.1 5870.1 5898.1 11:22:06 INFO - PROCESS | 30248 | 11:22:06 INFO - PROCESS | 30248 | [#5] yui.html Cycles:180 Average:14453.82 Median:44014.84 stddev:16427.12 (37.3%) stddev-sans-first:16440.88 11:22:06 INFO - PROCESS | 30248 | Values: 732.8 796.1 803.4 869.4 874.2 15232.2 15428.6 15432.2 15472.9 15483.9 14016.2 14078.9 14093.9 14110.4 14121.6 690.1 794.0 824.6 826.5 826.7 810.1 820.6 821.2 821.6 823.0 722.7 881.4 882.8 882.9 883.5 851.7 867.5 868.0 868.0 868.7 638.3 638.6 638.9 638.9 638.9 14663.3 14723.6 14732.6 14744.6 14805.3 14157.8 14292.6 14354.4 14448.6 14496.1 11510.4 11596.9 11798.7 11982.0 12341.3 3802.8 3814.3 3845.7 3860.9 3922.7 51252.7 51255.0 51308.5 51343.2 51546.7 10264.8 10467.4 10571.3 10697.8 10776.6 19187.7 19492.5 19613.2 19637.6 19653.6 8432.3 8655.4 8709.0 8751.0 8895.6 4495.1 4502.7 4610.4 4727.3 4954.8 3363.6 3432.4 3455.4 3455.6 3456.2 634.3 647.9 655.0 655.7 662.1 701.4 717.6 731.0 789.5 796.4 8789.6 8814.7 8863.8 8888.9 8905.2 698.3 749.7 754.6 776.4 782.7 4045.2 4558.2 4638.7 4697.0 4709.4 64822.0 66052.7 66420.7 66691.3 66741.7 43659.1 45871.3 50239.2 53720.0 53904.0 45823.3 47054.3 47730.5 47871.3 48588.0 8206.6 8722.8 8763.9 8783.6 9009.5 31377.0 31379.0 31574.5 31899.8 33198.7 36634.0 38536.6 40485.8 42012.4 44370.6 11569.9 11672.1 11692.9 11698.6 11713.3 12650.7 12973.6 13081.3 13143.9 13228.2 12417.3 12512.4 12892.6 12892.7 12971.0 12390.1 12872.5 13033.3 13111.9 13133.1 11587.1 11662.2 11698.9 12001.2 12007.6 10144.8 10435.5 10465.3 10916.1 10926.2 10393.9 10593.4 11025.4 11048.0 11087.4 11:22:06 INFO - PROCESS | 30248 | -------- Summary: end -------- 11:22:06 INFO - PROCESS | 30248 | 11:22:07 INFO - TEST-INFO | 30248: exit 0 11:22:07 INFO - TEST-OK | dromaeo_css | took 1111981ms 11:22:07 INFO - TEST-START | kraken 11:22:07 INFO - operating with platform_type : linux_ 11:22:07 INFO - Initialising browser for kraken test... 11:22:07 INFO - TEST-INFO | started process 30436 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMbcmB2/profile http://localhost:52163/getInfo.html) 11:22:10 INFO - PROCESS | 30436 | __metrics Screen width/height:1600/1200 11:22:10 INFO - PROCESS | 30436 | colorDepth:24 11:22:10 INFO - PROCESS | 30436 | Browser inner width/height: 1024/697 11:22:10 INFO - PROCESS | 30436 | __metrics 11:22:12 ERROR - PROCESS | 30436 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 11:22:12 INFO - TEST-INFO | 30436: exit 0 11:22:12 INFO - Browser initialized. 11:22:12 INFO - Running cycle 1/1 for kraken test... 11:22:12 INFO - TEST-INFO | started process 30517 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMbcmB2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:22:24 INFO - PROCESS | 30517 | RSS: Main: 153501696 11:22:24 INFO - PROCESS | 30517 | 11:22:27 INFO - PROCESS | 30517 | Cycle 1(1): loaded http://localhost:52163/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52163/tests/kraken/driver.html?testName=audio-beat-detection) 11:22:27 INFO - PROCESS | 30517 | RSS: Main: 208130048 11:22:28 INFO - PROCESS | 30517 | 11:22:30 INFO - PROCESS | 30517 | Cycle 1(1): loaded http://localhost:52163/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52163/tests/kraken/driver.html?testName=audio-dft) 11:22:31 INFO - PROCESS | 30517 | RSS: Main: 193552384 11:22:31 INFO - PROCESS | 30517 | 11:22:34 INFO - PROCESS | 30517 | Cycle 1(1): loaded http://localhost:52163/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52163/tests/kraken/driver.html?testName=audio-fft) 11:22:35 INFO - PROCESS | 30517 | RSS: Main: 264691712 11:22:35 INFO - PROCESS | 30517 | 11:22:37 INFO - PROCESS | 30517 | Cycle 1(1): loaded http://localhost:52163/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52163/tests/kraken/driver.html?testName=audio-oscillator) 11:22:37 INFO - PROCESS | 30517 | RSS: Main: 172240896 11:22:37 INFO - PROCESS | 30517 | 11:22:39 INFO - PROCESS | 30517 | Cycle 1(1): loaded http://localhost:52163/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52163/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:22:40 INFO - PROCESS | 30517 | RSS: Main: 176951296 11:22:40 INFO - PROCESS | 30517 | 11:22:43 INFO - PROCESS | 30517 | Cycle 1(1): loaded http://localhost:52163/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52163/tests/kraken/driver.html?testName=imaging-darkroom) 11:22:44 INFO - PROCESS | 30517 | RSS: Main: 212676608 11:22:44 INFO - PROCESS | 30517 | 11:22:47 INFO - PROCESS | 30517 | Cycle 1(1): loaded http://localhost:52163/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52163/tests/kraken/driver.html?testName=imaging-desaturate) 11:22:48 INFO - PROCESS | 30517 | RSS: Main: 213880832 11:22:48 INFO - PROCESS | 30517 | 11:22:50 INFO - PROCESS | 30517 | Cycle 1(1): loaded http://localhost:52163/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52163/tests/kraken/driver.html?testName=json-parse-financial) 11:22:51 INFO - PROCESS | 30517 | RSS: Main: 213630976 11:22:51 INFO - PROCESS | 30517 | 11:22:52 INFO - PROCESS | 30517 | Cycle 1(1): loaded http://localhost:52163/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52163/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:22:53 INFO - PROCESS | 30517 | RSS: Main: 199835648 11:22:53 INFO - PROCESS | 30517 | 11:22:55 INFO - PROCESS | 30517 | Cycle 1(1): loaded http://localhost:52163/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52163/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:22:55 INFO - PROCESS | 30517 | RSS: Main: 203325440 11:22:55 INFO - PROCESS | 30517 | 11:22:57 INFO - PROCESS | 30517 | Cycle 1(1): loaded http://localhost:52163/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52163/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:22:58 INFO - PROCESS | 30517 | RSS: Main: 217280512 11:22:58 INFO - PROCESS | 30517 | 11:23:01 INFO - PROCESS | 30517 | Cycle 1(1): loaded http://localhost:52163/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52163/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:23:01 INFO - PROCESS | 30517 | RSS: Main: 222490624 11:23:01 INFO - PROCESS | 30517 | 11:23:04 INFO - PROCESS | 30517 | Cycle 1(1): loaded http://localhost:52163/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52163/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:23:05 INFO - PROCESS | 30517 | RSS: Main: 218402816 11:23:05 INFO - PROCESS | 30517 | 11:23:06 INFO - PROCESS | 30517 | Cycle 1(1): loaded http://localhost:52163/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52163/tests/kraken/driver.html?testName=ai-astar) 11:23:07 INFO - PROCESS | 30517 | RSS: Main: 282578944 11:23:07 INFO - PROCESS | 30517 | 11:23:07 INFO - PROCESS | 30517 | __start_tp_report 11:23:07 INFO - PROCESS | 30517 | _x_x_mozilla_page_load 11:23:07 INFO - PROCESS | 30517 | _x_x_mozilla_page_load_details 11:23:07 INFO - PROCESS | 30517 | |i|pagename|runs| 11:23:07 INFO - PROCESS | 30517 | |0;ai-astar;111;112;110;113;113;111;101;112;112;111 11:23:07 INFO - PROCESS | 30517 | |1;audio-beat-detection;154;127;150;187;138;155;150;135;202;128 11:23:07 INFO - PROCESS | 30517 | |2;audio-dft;162;159;161;160;159;161;162;162;162;162 11:23:07 INFO - PROCESS | 30517 | |3;audio-fft;76;72;110;111;81;72;73;109;99;72 11:23:07 INFO - PROCESS | 30517 | |4;audio-oscillator;92;92;147;92;92;93;150;92;93;150 11:23:07 INFO - PROCESS | 30517 | |5;imaging-gaussian-blur;116;116;116;117;117;116;116;117;117;117 11:23:07 INFO - PROCESS | 30517 | |6;imaging-darkroom;146;145;145;146;145;147;146;147;146;146 11:23:07 INFO - PROCESS | 30517 | |7;imaging-desaturate;95;94;95;95;95;95;95;94;95;94 11:23:07 INFO - PROCESS | 30517 | |8;json-parse-financial;56;58;58;56;58;57;58;77;55;55 11:23:07 INFO - PROCESS | 30517 | |9;json-stringify-tinderbox;63;63;62;61;61;61;61;61;62;62 11:23:07 INFO - PROCESS | 30517 | |10;stanford-crypto-aes;77;77;76;76;78;77;78;78;79;78 11:23:07 INFO - PROCESS | 30517 | |11;stanford-crypto-ccm;132;125;124;125;131;125;132;137;162;125 11:23:07 INFO - PROCESS | 30517 | |12;stanford-crypto-pbkdf2;168;173;170;171;165;170;166;167;168;170 11:23:07 INFO - PROCESS | 30517 | |13;stanford-crypto-sha256-iterative;70;67;76;69;67;67;66;67;68;66 11:23:07 INFO - PROCESS | 30517 | __end_tp_report 11:23:07 INFO - PROCESS | 30517 | __start_cc_report 11:23:07 INFO - PROCESS | 30517 | _x_x_mozilla_cycle_collect,1614 11:23:07 INFO - PROCESS | 30517 | __end_cc_report 11:23:07 INFO - PROCESS | 30517 | __startTimestamp1461262987072__endTimestamp 11:23:07 INFO - PROCESS | 30517 | 11:23:07 INFO - PROCESS | 30517 | ------- Summary: start ------- 11:23:07 INFO - PROCESS | 30517 | Number of tests: 14 11:23:07 INFO - PROCESS | 30517 | 11:23:07 INFO - PROCESS | 30517 | [#0] ai-astar Cycles:10 Average:110.60 Median:112.00 stddev:3.50 (3.1%) stddev-sans-first:3.71 11:23:07 INFO - PROCESS | 30517 | Values: 111.0 112.0 110.0 113.0 113.0 111.0 101.0 112.0 112.0 111.0 11:23:07 INFO - PROCESS | 30517 | 11:23:07 INFO - PROCESS | 30517 | [#1] audio-beat-detection Cycles:10 Average:152.60 Median:152.00 stddev:24.56 (16.2%) stddev-sans-first:26.04 11:23:07 INFO - PROCESS | 30517 | Values: 154.0 127.0 150.0 187.0 138.0 155.0 150.0 135.0 202.0 128.0 11:23:07 INFO - PROCESS | 30517 | 11:23:07 INFO - PROCESS | 30517 | [#2] audio-dft Cycles:10 Average:161.00 Median:162.00 stddev:1.25 (0.8%) stddev-sans-first:1.27 11:23:07 INFO - PROCESS | 30517 | Values: 162.0 159.0 161.0 160.0 159.0 161.0 162.0 162.0 162.0 162.0 11:23:07 INFO - PROCESS | 30517 | 11:23:07 INFO - PROCESS | 30517 | [#3] audio-fft Cycles:10 Average:87.50 Median:72.50 stddev:17.51 (24.1%) stddev-sans-first:18.07 11:23:07 INFO - PROCESS | 30517 | Values: 76.0 72.0 110.0 111.0 81.0 72.0 73.0 109.0 99.0 72.0 11:23:07 INFO - PROCESS | 30517 | 11:23:07 INFO - PROCESS | 30517 | [#4] audio-oscillator Cycles:10 Average:109.30 Median:92.00 stddev:27.41 (29.8%) stddev-sans-first:28.35 11:23:07 INFO - PROCESS | 30517 | Values: 92.0 92.0 147.0 92.0 92.0 93.0 150.0 92.0 93.0 150.0 11:23:07 INFO - PROCESS | 30517 | 11:23:07 INFO - PROCESS | 30517 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:117.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 11:23:07 INFO - PROCESS | 30517 | Values: 116.0 116.0 116.0 117.0 117.0 116.0 116.0 117.0 117.0 117.0 11:23:07 INFO - PROCESS | 30517 | 11:23:07 INFO - PROCESS | 30517 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 11:23:07 INFO - PROCESS | 30517 | Values: 146.0 145.0 145.0 146.0 145.0 147.0 146.0 147.0 146.0 146.0 11:23:07 INFO - PROCESS | 30517 | 11:23:07 INFO - PROCESS | 30517 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 11:23:07 INFO - PROCESS | 30517 | Values: 95.0 94.0 95.0 95.0 95.0 95.0 95.0 94.0 95.0 94.0 11:23:07 INFO - PROCESS | 30517 | 11:23:07 INFO - PROCESS | 30517 | [#8] json-parse-financial Cycles:10 Average:58.80 Median:58.00 stddev:6.51 (11.2%) stddev-sans-first:6.83 11:23:07 INFO - PROCESS | 30517 | Values: 56.0 58.0 58.0 56.0 58.0 57.0 58.0 77.0 55.0 55.0 11:23:07 INFO - PROCESS | 30517 | 11:23:07 INFO - PROCESS | 30517 | [#9] json-stringify-tinderbox Cycles:10 Average:61.70 Median:62.00 stddev:0.82 (1.3%) stddev-sans-first:0.73 11:23:07 INFO - PROCESS | 30517 | Values: 63.0 63.0 62.0 61.0 61.0 61.0 61.0 61.0 62.0 62.0 11:23:07 INFO - PROCESS | 30517 | 11:23:07 INFO - PROCESS | 30517 | [#10] stanford-crypto-aes Cycles:10 Average:77.40 Median:78.00 stddev:0.97 (1.2%) stddev-sans-first:1.01 11:23:07 INFO - PROCESS | 30517 | Values: 77.0 77.0 76.0 76.0 78.0 77.0 78.0 78.0 79.0 78.0 11:23:07 INFO - PROCESS | 30517 | 11:23:07 INFO - PROCESS | 30517 | [#11] stanford-crypto-ccm Cycles:10 Average:131.80 Median:131.50 stddev:11.48 (8.7%) stddev-sans-first:12.17 11:23:07 INFO - PROCESS | 30517 | Values: 132.0 125.0 124.0 125.0 131.0 125.0 132.0 137.0 162.0 125.0 11:23:07 INFO - PROCESS | 30517 | 11:23:07 INFO - PROCESS | 30517 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.80 Median:170.00 stddev:2.44 (1.4%) stddev-sans-first:2.57 11:23:07 INFO - PROCESS | 30517 | Values: 168.0 173.0 170.0 171.0 165.0 170.0 166.0 167.0 168.0 170.0 11:23:07 INFO - PROCESS | 30517 | 11:23:07 INFO - PROCESS | 30517 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.30 Median:67.50 stddev:2.98 (4.4%) stddev-sans-first:3.10 11:23:07 INFO - PROCESS | 30517 | Values: 70.0 67.0 76.0 69.0 67.0 67.0 66.0 67.0 68.0 66.0 11:23:07 INFO - PROCESS | 30517 | -------- Summary: end -------- 11:23:07 INFO - PROCESS | 30517 | 11:23:07 INFO - TEST-INFO | 30517: exit 0 11:23:08 INFO - TEST-OK | kraken | took 60875ms 11:23:08 INFO - SUITE-END | took 1172s 11:23:08 INFO - Completed test suite (00:19:33) 11:23:08 INFO - javascript benchmark 11:23:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3109.144985129089, 3159.778815482914, 3193.80837149771, 3196.2808368117176, 3221.9516707249395, 5359.356877174744, 5370.167624018273, 5371.355437347514, 5435.0760370736925, 5476.58925580581, 5226.2944502492155, 5328.040952628526, 5339.70631615261, 5364.409914909366, 5391.002664507069, 4811.8075276988875, 4849.3453383793085, 4948.208286674133, 5013.749312534377, 5027.572656324199, 4957.454679985199, 5042.924356134661, 5046.596272298208, 5055.721935293557, 5058.11482990477, 4817.156997525454, 4821.228603423453, 4828.61371090312, 4879.268109783526, 4975.27858460523, 4853.854384368475, 4876.0, 4881.877953051202, 4883.218685010382, 4918.2376731606655, 4727.243641017455, 4813.95186048142, 4831.0820944020525, 4867.780949857265, 4904.901901961941, 5313.654612450178, 5350.197470379435, 5355.250264962909, 5384.434634363374, 5403.324584426947, 5582.218489411485, 5628.577856660767, 5634.4365563443735, 5635.126555383922, 5642.633228840113, 5681.0910254359105, 5685.232493613392, 5703.4011428799795, 5791.102379131242, 5845.941540584625, 5358.089124848785, 5360.0, 5360.490753378423, 5382.865428364283, 5388.164834450667, 5796.275465566804, 5805.709714514257, 5806.0, 5807.216025836543, 5831.766729330864, 5483.177523371446, 5539.556835453234, 5598.020346439438, 5608.971955140199, 5628.352739434936, 5718.7426565804635, 5724.8282551523525, 5726.685032323179, 5727.026405511073, 5745.827625171251, 5686.402927692533, 5694.629849059881, 5700.059490184156, 5702.173184888168, 5704.971475142598, 5710.457506536873, 5715.8571035724435, 5811.360750317462, 5865.765369385262, 5902.173695682608, 4375.059362237134, 4381.21138195128, 4384.824607015684, 4387.298032314814, 4419.58013988677, 3888.1446081861945, 3891.7081218908697, 3901.336772748583, 3930.6855451563806, 3954.0, 5401.3518377794135, 5478.479544443271, 5521.558275338044, 5565.693886836182, 5571.0, 5661.547076233891, 5699.544036477072, 5703.401142879938, 5711.371749107595, 5712.457316554921, 5333.7333133343955, 5359.0, 5364.0, 5377.220303056035, 5417.972910135424, 5017.046761115376, 5062.0, 5063.645544811828, 5090.720010399464, 5108.770105345268, 5935.169076329317, 5961.314448838352, 5964.910526342108, 5965.522758179335, 5966.433188847052, 5743.1385292206505, 5766.509846662912, 5785.218995435563, 5788.681622510634, 5798.449147330997, 5889.911651325147, 5892.0, 5895.0, 5902.085176797603, 5942.524598032233, 5586.888262234814, 5619.80330688424, 5625.690587017753, 5626.521745651666, 5629.0712032514175, 5623.1846382273525, 5653.406392328746, 5706.686132262766, 5714.885702286014, 5724.971375143097, 5661.320641523043, 5662.5469962402085, 5666.46168613981, 5666.575006874418, 5668.489835914787, 5608.859778505407, 5644.6613203207935, 5646.124850648156, 5646.463585959327, 5649.12438572022, 5476.123820188751, 5477.1510415885605, 5550.139728342114, 5602.747876345493, 5644.040513112863, 5600.327960644749, 5600.719964001865, 5609.411011843697, 5623.550115990793, 5630.5214056805635, 5481.561475081904, 5485.61600687964, 5490.505854473116, 5491.066518691752, 5519.337679478328], "value": 5295.003207286252, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [593.9881202375952, 626.5770604841732, 641.115260939903, 649.5420728386488, 691.6092407789596, 30963.69036309636, 31561.0, 31676.841615791916, 31764.20589485264, 37629.0, 41462.37806432906, 42335.78832105835, 42365.36451953223, 42500.57499425005, 42524.14951700972, 8535.31717462603, 8741.43180693256, 8744.8688269676, 8748.387612867102, 8753.649854005833, 8585.484870907734, 8702.521361325125, 8704.477731336141, 8706.651733930636, 8707.695230666928, 8702.47785132894, 8978.147076027799, 8987.595558199897, 8990.190882820545, 8992.910070899305, 8862.60118294675, 8928.241099506517, 8932.553372331422, 8936.687215947411, 8940.463572185658, 8792.8681069784, 8907.109289071106, 8916.06381329964, 8917.92984841823, 8925.241354484877, 41959.16081678349, 42473.57526424727, 42493.78753106246, 42497.787511062554, 42577.78711106456, 3502.7548071634997, 4009.67922566194, 4216.771363047157, 4293.141371725667, 4326.675499337531, 31546.211344716336, 31675.524867127013, 31844.203894902814, 31983.84008079968, 32449.35101297961, 4108.5275193352845, 4139.937900931488, 4188.518320393163, 4196.643285320752, 4387.232234358974, 303000.0, 303111.0, 303722.0, 303855.0, 303913.0, 56294.0, 56729.432705672414, 57216.71391643015, 57251.71374143103, 57315.0, 61014.0, 61032.38967610356, 61246.693766531775, 61315.38684613097, 61387.38612613906, 15639.452619158503, 15919.124448155231, 15921.124338161513, 15924.601884952737, 15932.362705491882, 12066.0, 12232.327222002697, 12233.571824986082, 12247.632571022883, 12249.510019599295, 16142.19289035567, 17359.222524396035, 17656.382026629006, 17659.73510397345, 17664.823351766318, 5186.5850731941355, 5930.614510056919, 6115.510759139258, 6228.532860035515, 6303.590266632654, 1039.0, 1053.0785562632695, 1100.7358234023936, 1162.2213117211488, 1197.3354788092693, 32015.83992080025, 32852.52163652593, 33089.0, 33456.330873382394, 33567.83216083953, 1142.23470274916, 1142.4116579961326, 1147.0, 1215.3862299538675, 1227.490591404557, 16828.411005614744, 17139.57151071208, 17412.91293543524, 17549.21028553718, 17694.469165925042, 434939.0, 440272.0, 440471.0, 440528.0, 441929.0, 58768.0, 59125.40874591285, 59154.0, 59322.0, 59382.70308648429, 1267.1889990406148, 1408.4647833823083, 1411.795160270605, 1423.757961146587, 1496.2817847433294, 28975.5653665191, 29754.851225743732, 30004.099877003726, 30507.389852203276, 32620.347593048482, 46717.0, 46955.29567056429, 47008.29487557758, 47293.76353118212, 47348.7632561835, 291644.0, 293169.0, 294010.0, 294358.0, 295016.0, 36923.26153476969, 42419.0, 42502.0, 42972.57027429811, 44660.55339446564, 47466.28800567925, 52615.473845261055, 53991.0, 54046.0, 54727.17909231444, 39358.0, 40248.597514024485, 40944.18111637691, 40961.38557921574, 41791.58208417999, 39082.0, 39319.41020884746, 39971.40042899417, 40388.19223615452, 41208.0, 41995.0, 42264.366034508894, 45098.54901450944, 46393.30410043785, 46478.30282545832, 32814.17964550905, 35234.47148292829, 35243.118922027155, 35761.821190893876, 35846.103847404025, 27390.178294651192, 27464.862675686494, 27757.44485110246, 27825.71525140658, 28100.43799124047], "value": 19713.75277904256, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [380.7106598984773, 381.90834199792056, 395.4562476594683, 405.11078183387457, 408.08995939055905, 15988.12065336406, 18184.63630727388, 18319.358822441216, 18383.72424413633, 18444.723329150074, 17136.31454741809, 18037.7294340585, 19347.806521934777, 19661.50846228845, 19682.11430485628, 5013.573846223076, 5082.949170508294, 5146.356705411824, 5241.292425522563, 5244.816431424901, 5163.096458119833, 5168.638195326329, 5197.1424714922, 5210.192420174879, 5211.42674305826, 4982.302477653131, 5178.482151784829, 5181.01560703467, 5182.300389447414, 5184.507471790174, 5174.689518628894, 5188.377394712658, 5228.73856307185, 5243.2659427680155, 5270.631055826094, 4844.224924012141, 5016.021875734234, 5050.343455350818, 5060.949390506122, 5062.949370506285, 16746.6650666986, 16825.747613785803, 17056.403025894157, 22421.0, 22424.215152469584, 2187.048633844283, 2216.36833502451, 2218.1792736687366, 2386.140989243871, 2650.642163307967, 10491.895081049244, 10554.47227638615, 10721.195910306758, 12953.352332383343, 13652.931735341259, 1932.154792173471, 1992.930247441347, 1997.2111016148685, 2016.2136766661015, 2042.2137477071285, 75107.24892751058, 78422.0, 79110.60444697739, 79390.0, 79933.60033199855, 10083.495825208856, 10604.575816967235, 10745.570177192982, 10972.451377431096, 11080.501377438035, 15634.921825391028, 15636.140012299205, 15762.0, 15781.447649332218, 15789.0, 8019.9198008019175, 8087.797805054803, 8134.349252059821, 8177.223163799429, 8282.71010514629, 7732.149463559004, 7795.22047795216, 7807.0, 7887.44787864844, 7891.960540197262, 4764.4520880098535, 4785.114753770564, 4807.206810876166, 4898.191798353303, 4925.827596034122, 1934.845212383006, 1953.6288105259955, 1972.635062513411, 1990.8506861985409, 2021.9393418197478, 952.2001518724305, 1027.6865556005341, 1032.4373216596973, 1043.0404028293988, 1128.3343918704265, 17879.28482860671, 19085.332013379466, 19134.52163695891, 19165.425037248904, 19230.23079076821, 1055.5777688924338, 1055.9577616895392, 1065.472591067411, 1093.7156339351825, 1097.6706987903756, 10466.424346661006, 10895.400752958663, 10902.618408355669, 10908.181886358554, 10946.741124770593, 486304.0, 497893.0, 503340.0, 504659.0, 506381.0, 65199.67400162969, 81660.0, 82782.58608707039, 91036.0, 95209.52395238118, 1059.9788004239872, 1064.7870425914848, 1068.1988508618535, 1103.8564986551696, 1119.9888001120048, 15421.922890385476, 16299.918500407422, 17036.65926681484, 17107.572310692332, 17362.045087520306, 37903.0, 38096.61903380931, 38780.41829372618, 39032.609673902894, 39164.21671566496, 49461.50538494713, 50415.0, 50912.23631645602, 51186.48813511966, 51486.0, 8163.306118979954, 8697.521636310064, 8786.704538106074, 8857.025727170136, 9015.504147271962, 9626.037396260317, 10824.837627435438, 12610.810837837624, 12917.095803294054, 13633.25017124028, 11275.210735248782, 11625.709357265798, 11675.124365672438, 11730.941345293219, 11909.0, 10925.344479331265, 11386.829197561878, 11706.35615041181, 11748.706282342668, 11972.102092342935, 9064.682736104205, 11257.268277561932, 11347.0, 11574.594889178838, 12142.210756300812, 8744.956275218838, 8829.69096081634, 8885.777855553662, 8947.463152210888, 9075.183233509017, 8374.958125209336, 10718.303310285119, 11103.278286911647, 11379.487923043318, 11594.76810463803], "value": 8962.531377325917, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1363.5023216525958, 1541.8381069987652, 1574.7559128335106, 1754.4385796545102, 1870.298638010746, 7585.5069420487625, 8255.257026867588, 8454.365922555802, 8469.91530084699, 8486.44838085524, 8190.385721070928, 8354.081051084377, 8361.41470097092, 8362.038365587943, 8365.539895305756, 2061.4228016155503, 2140.5825863956534, 2142.0, 2381.4879800842814, 2415.0219161239725, 2343.1564636730764, 2413.3966508372905, 2427.987860060697, 2434.8904299306487, 2440.3777036855577, 2325.9185928492507, 2334.2297041976108, 2338.4153961509624, 2340.96488552671, 2393.6648869158244, 2060.546679730472, 2149.537849362395, 2363.1492662641435, 2371.5612611666897, 2373.276150774022, 2123.851330406872, 2249.55008998201, 2317.640765681322, 2319.744828068911, 2322.6864373309554, 8454.027786804474, 8509.106543812872, 8534.786630334229, 8546.444481108709, 8546.487210767375, 5090.185570308733, 5248.21276808478, 5282.524572788468, 5297.099493086184, 5297.947020529784, 3366.1416338833687, 3393.6097348804956, 3404.6935775780053, 3426.6573342665783, 3427.674370934782, 1124.3254047571475, 1137.2494153858413, 1140.5494829542283, 1166.5683697032068, 1172.8944395004492, 11348.773024539463, 11351.659450216506, 11368.488418021127, 11373.203875728703, 11382.886171138265, 4453.643708503312, 4472.955270447319, 4650.627949764078, 4683.414573178353, 4730.526947305242, 9642.469664168539, 9675.612975480903, 9680.322377433513, 9681.080297371738, 9684.08001239881, 5166.560842328369, 5199.66202196856, 5208.0365132450615, 5216.37403511581, 5219.164933610604, 4182.247195504778, 4637.188492013884, 4727.858164255078, 4766.0, 4848.781804818792, 3862.1117143057254, 3898.3372826619543, 3949.4865667463046, 3965.4250133730447, 3998.4002399640285, 1293.644247831835, 1300.7073408483204, 1307.1764788183384, 1320.3530270167741, 1324.417256407197, 898.5641963647626, 995.7049002050344, 997.102607653118, 1014.2595904989399, 1026.1688032693542, 5653.067243904709, 5657.688827114466, 5723.713814309352, 5750.051241545182, 5775.624584402, 453.98184072637383, 467.5815145444808, 468.5361492122842, 474.3548773667809, 479.9136155491975, 3928.0, 3958.5645578986287, 3969.960300397017, 3977.76133431995, 3982.506560039985, 10287.279890407599, 10711.143108551452, 10809.243352965217, 10810.621628242974, 10871.27099711628, 10326.896731032593, 10576.682699519026, 10709.357438553712, 10736.30214036085, 10843.51204195813, 8023.1976802319305, 8035.919640803517, 8091.919080809234, 8144.226298501514, 8184.549849758201, 5766.855828604318, 5916.674582897982, 6017.518598512196, 6070.18052562916, 6117.296510901126, 9250.95374523123, 9431.151196392084, 9438.056194380508, 9447.480388578419, 9496.43021418717, 9508.524573771145, 9579.712608621752, 9579.994100619335, 9717.368371055858, 9749.463779491913, 6939.895901561582, 7397.667104980396, 7408.592527410829, 7480.850382992201, 7667.693292268247, 8428.747137585882, 8469.74590762278, 8578.699745508877, 8583.699570515002, 8595.52724600153, 7572.962135189288, 7765.844683106419, 7808.336291415293, 7829.0, 7924.920750792418, 7603.289259916474, 7657.0, 7675.923240767521, 7753.185915479019, 7821.178776228414, 6907.412869906114, 6955.826104347432, 6957.965210173917, 6976.790696279119, 6988.4059854910865, 4717.292406139107, 4793.859081450785, 4859.271109333628, 4861.149298872754, 4915.631327650369, 4726.62187025044, 4770.236762118045, 4787.066522028171, 4826.3243145958895, 4832.057748739103], "value": 4466.865212897466, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [325.4288723290625, 335.1604231400342, 340.7750884416285, 341.0297703034868, 343.8160584087512, 5451.373092094405, 5542.612017158801, 5568.638038527492, 5691.288588926384, 5739.626924249931, 5591.944080559193, 5598.944010559893, 5612.550995920326, 5625.578081643883, 5642.774289028444, 4320.8333749887515, 4358.912821743564, 4365.716228445157, 4382.956170438302, 4390.5609439056, 3879.35990561557, 4114.485689288839, 4265.402843601898, 4265.509466411371, 4279.165562715271, 4222.387753775701, 4231.619154276114, 4240.406343111967, 4244.320908654616, 4247.575242475758, 4038.676905847525, 4237.957620423787, 4250.638695710883, 4253.08611124995, 4253.3619957006385, 3668.358037343481, 3747.962520374816, 3760.2855457462992, 3775.0751065989007, 3783.6027217142077, 5397.298351214317, 5422.376426710939, 5431.185322201662, 5432.375276843135, 5445.891082178334, 4759.61923046159, 4923.876903077416, 4931.778069986859, 4936.284238785356, 4949.133901567247, 5785.710714464302, 5787.305523337226, 5822.301323841124, 5833.504152147073, 5840.737166827503, 4114.588541145891, 4128.967758060485, 4130.483689538808, 4137.958620413788, 4142.212979533909, 5642.6551555302185, 5664.660120392789, 5972.193753843219, 6062.757489700407, 6079.422454866781, 4216.451861258078, 4224.9155016899485, 4230.725002874803, 4234.894127646833, 4235.661147108224, 4244.193603215441, 4245.235857545671, 4248.256555102845, 4271.295236285978, 4306.074194048295, 4869.902601947942, 4873.537013983666, 4893.657443978887, 4907.975460122677, 4921.0, 5696.629719068247, 5899.46904778572, 5910.290765108214, 5923.111533270044, 5923.970380148072, 1468.2365170111482, 1487.7098965701584, 1488.672492051747, 1490.46343316406, 1494.0512774388123, 959.4003747657714, 991.1228562722043, 1006.6476733143342, 1008.3496144986443, 1010.3281317923498, 5649.604527683023, 5652.689102099342, 5669.461401166883, 5675.57433192504, 5676.091825307931, 6071.635701857903, 6073.600927633648, 6075.0, 6075.513958883367, 6094.11635312886, 5538.723063846792, 5624.97187514068, 5657.57568182388, 5677.602567820213, 5691.630044047124, 3234.9029529114164, 3237.546743455918, 3261.3803377358226, 3267.460868956643, 3271.247613049012, 6019.54853385989, 6208.317085120633, 6220.7511699531515, 6260.718267677966, 6277.121203031579, 6074.210352654127, 6083.8479038023515, 6104.267487901391, 6124.733848476092, 6138.877222455526, 5958.255218097738, 6021.969890150609, 6212.0, 6222.719977601018, 6306.558540902093, 6139.3553676863285, 6140.293866205265, 6142.692865356625, 6148.907766383597, 6159.384061593805, 5758.654480731169, 6024.789132380346, 6060.909086363797, 6061.090836374579, 6063.242094738158, 6287.2769631492965, 6293.496520278275, 6325.905111423241, 6326.2092238470195, 6330.873382532415, 4232.597903199191, 4259.38238955356, 4273.529911709772, 4287.292596721506, 4291.249031419551, 5927.8221653350465, 6089.54328425361, 6118.143459915705, 6120.112583675431, 6134.38656134383, 5886.440788125121, 5933.228680271537, 5964.463198311999, 5970.701464926823, 6004.759809607742, 5802.912956305574, 5900.43945825146, 5904.852378690567, 5931.673757943355, 6011.273010733374, 5831.970840145772, 5834.970825145847, 5841.912371314519, 5866.178734977192, 5867.647941123546, 5941.851453713692, 5996.5502587305255, 5996.5502587307, 6008.8497787553915, 6019.307779605227, 5730.369659337553, 5839.795607153729, 5858.121281807763, 5870.119482077552, 5898.1152827076285], "value": 4459.44935712469, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [732.8314487667833, 796.0884786918978, 803.3854101612268, 869.3827382558384, 874.1870060843413, 15232.162231077285, 15428.61428464289, 15432.151231682254, 15472.922635386836, 15483.922580387083, 14016.22910739909, 14078.859211407882, 14093.859061409383, 14110.435582576685, 14121.646958826035, 690.0856365315964, 793.9841203175934, 824.5918270456102, 826.5371392020458, 826.6982551368737, 810.0765127754365, 820.6184124382161, 821.1542111625035, 821.593311310902, 823.0411570520366, 722.7217521254329, 881.4358810361374, 882.8234353129368, 882.8852249207594, 883.5361435246515, 851.6721062390993, 867.4665080975218, 867.9522626255554, 868.0191383736369, 868.6916144768579, 638.2819328255713, 638.6327861479667, 638.8818068657313, 638.9105525226425, 638.916940797698, 14663.266836658231, 14723.558293251113, 14732.631684207874, 14744.55766327012, 14805.259737013213, 14157.787633185511, 14292.571222863331, 14354.425822967174, 14448.638784030378, 14496.130232185997, 11510.366929818856, 11596.94201528987, 11798.705032374173, 11982.0, 12341.321227332493, 3802.790846503441, 3814.294355544233, 3845.711571632111, 3860.942085868714, 3922.7450215735885, 51252.74373628108, 51255.0, 51308.48691513074, 51343.229851552256, 51546.74226628843, 10264.846027309597, 10467.371957682564, 10571.260011799253, 10697.786044279072, 10776.622818201482, 19187.712184317246, 19492.512687182934, 19613.21547138127, 19637.60724785525, 19653.60692786165, 8432.283255923316, 8655.394122411371, 8709.042005379402, 8750.956245218733, 8895.599698013604, 4495.078508905666, 4502.662300327489, 4610.423697037871, 4727.314539391838, 4954.752262386866, 3363.64681708422, 3432.4164891968426, 3455.395305821471, 3455.6198818129988, 3456.187795867969, 634.2895956528625, 647.873664635401, 654.9672516374162, 655.7475371981822, 662.0962386342608, 701.4073108223542, 717.5515302935665, 730.9597972111478, 789.5105034878412, 796.3788245168778, 8789.560521974003, 8814.691485797966, 8863.822723545492, 8888.911110888937, 8905.243054340453, 698.2877464985686, 749.6663984526833, 754.6000619671582, 776.3788968824917, 782.7025730222592, 4045.150518391171, 4558.202314594932, 4638.6752927294765, 4696.976515117471, 4709.3877795887, 64822.0, 66052.669736651, 66420.66789666118, 66691.33308666851, 66741.6662916692, 43659.126817463475, 45871.31193032107, 50239.24641130386, 53720.0, 53904.0, 45823.31265031027, 47054.29418558656, 47730.5226947733, 47871.28193077107, 48588.0, 8206.630701618322, 8722.825543488967, 8763.868541972002, 8783.556215948489, 9009.549522523717, 31377.0, 31379.0, 31574.526382104745, 31899.84050079735, 33198.668013319555, 36634.0, 38536.6146338533, 40485.79757101196, 42012.36981445342, 44370.55629443664, 11569.88430115688, 11672.124590655905, 11692.883071169179, 11698.649040528799, 11713.297202167898, 12650.746985060063, 12973.610791676265, 13081.280529570964, 13143.934280328536, 13228.206307621573, 12417.254964702146, 12512.374381280717, 12892.613221603367, 12892.677683057998, 12971.0, 12390.132690711564, 12872.485100595872, 13033.348332583144, 13111.868881311064, 13133.146345487512, 11587.130965177814, 11662.183647144957, 11698.94150529242, 12001.219920705125, 12007.579734709243, 10144.847827282745, 10435.530401131815, 10465.319754215952, 10916.07213386871, 10926.235163538477, 10393.896061039293, 10593.364398136137, 11025.393603351571, 11048.0, 11087.44562771842], "value": 6735.848587729031, "unit": "score"}], "name": "dromaeo_css", "value": 7076.160257733466, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 112.0, 110.0, 113.0, 113.0, 111.0, 101.0, 112.0, 112.0, 111.0], "value": 110.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 127.0, 150.0, 187.0, 138.0, 155.0, 150.0, 135.0, 202.0, 128.0], "value": 152.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 159.0, 161.0, 160.0, 159.0, 161.0, 162.0, 162.0, 162.0, 162.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 72.0, 110.0, 111.0, 81.0, 72.0, 73.0, 109.0, 99.0, 72.0], "value": 87.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 147.0, 92.0, 92.0, 93.0, 150.0, 92.0, 93.0, 150.0], "value": 109.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 116.0, 117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 145.0, 146.0, 145.0, 147.0, 146.0, 147.0, 146.0, 146.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 94.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 58.0, 58.0, 56.0, 58.0, 57.0, 58.0, 77.0, 55.0, 55.0], "value": 58.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 62.0, 61.0, 61.0, 61.0, 61.0, 61.0, 62.0, 62.0], "value": 61.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 76.0, 76.0, 78.0, 77.0, 78.0, 78.0, 79.0, 78.0], "value": 77.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 125.0, 124.0, 125.0, 131.0, 125.0, 132.0, 137.0, 162.0, 125.0], "value": 131.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 173.0, 170.0, 171.0, 165.0, 170.0, 166.0, 167.0, 168.0, 170.0], "value": 168.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 67.0, 76.0, 69.0, 67.0, 67.0, 66.0, 67.0, 68.0, 66.0], "value": 68.3, "unit": "score"}], "name": "kraken", "value": 1544.9, "alertThreshold": 2.0}]} 11:23:08 INFO - Return code: 0 11:23:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 11:23:08 ERROR - # TBPL SUCCESS # 11:23:08 INFO - Running post-action listener: _resource_record_post_action 11:23:08 INFO - Running post-run listener: _resource_record_post_run 11:23:09 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 542482432; Read time: 12; Write time: 736956 11:23:09 INFO - install - Wall time: 17s; CPU: 16.0%; Read bytes: 0; Write bytes: 256307200; Read time: 0; Write time: 482688 11:23:09 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4096; Write bytes: 286175232; Read time: 12; Write time: 254268 11:23:09 INFO - Running post-run listener: _upload_blobber_files 11:23:09 INFO - Blob upload gear active. 11:23:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:23:09 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 11:23:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:23:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:23:09 INFO - (blobuploader) - INFO - Open directory for files ... 11:23:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:23:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:23:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:23:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:23:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:23:10 INFO - (blobuploader) - INFO - Done attempting. 11:23:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:23:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:23:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:23:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:23:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:23:11 INFO - (blobuploader) - INFO - Done attempting. 11:23:11 INFO - (blobuploader) - INFO - Iteration through files over. 11:23:11 INFO - Return code: 0 11:23:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:23:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:23:11 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/19b239096a24d9300e9af4bdad20a6b01529761bd4cd9f6ed17273130ff3ef65df90ee889c69a2100874f6c28fc0e72dd750c83948df458a446cd2f309e5f5cf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5fd17091e7d868c4d1b04cfce6246f742a01c40d33dc97b17e26f324c339acb3293436a03774e17428efd14d502b965794ae6481fcfbc93ea356dc60b87c48d3"} 11:23:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:23:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:23:11 INFO - Contents: 11:23:11 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/19b239096a24d9300e9af4bdad20a6b01529761bd4cd9f6ed17273130ff3ef65df90ee889c69a2100874f6c28fc0e72dd750c83948df458a446cd2f309e5f5cf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5fd17091e7d868c4d1b04cfce6246f742a01c40d33dc97b17e26f324c339acb3293436a03774e17428efd14d502b965794ae6481fcfbc93ea356dc60b87c48d3"} 11:23:11 INFO - Running post-run listener: copy_logs_to_upload_dir 11:23:11 INFO - Copying logs to upload dir... 11:23:11 INFO - mkdir: /builds/slave/test/build/upload/logs 11:23:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1229.832923 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-04-21 11:23:11.685725) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-21 11:23:11.689461) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1461261734.561604-1132430608 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/19b239096a24d9300e9af4bdad20a6b01529761bd4cd9f6ed17273130ff3ef65df90ee889c69a2100874f6c28fc0e72dd750c83948df458a446cd2f309e5f5cf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5fd17091e7d868c4d1b04cfce6246f742a01c40d33dc97b17e26f324c339acb3293436a03774e17428efd14d502b965794ae6481fcfbc93ea356dc60b87c48d3"} build_url:https://queue.taskcluster.net/v1/task/HF-KsnUjRXeTrnN56Y4sJQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011391 build_url: 'https://queue.taskcluster.net/v1/task/HF-KsnUjRXeTrnN56Y4sJQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/19b239096a24d9300e9af4bdad20a6b01529761bd4cd9f6ed17273130ff3ef65df90ee889c69a2100874f6c28fc0e72dd750c83948df458a446cd2f309e5f5cf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5fd17091e7d868c4d1b04cfce6246f742a01c40d33dc97b17e26f324c339acb3293436a03774e17428efd14d502b965794ae6481fcfbc93ea356dc60b87c48d3"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-21 11:23:11.713474) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 11:23:11.713778) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1461261734.561604-1132430608 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004650 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 11:23:11.795558) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-21 11:23:11.795868) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-21 11:23:11.796143) ========= ========= Total master_lag: 1.25 =========