builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-047 starttime: 1460883973.39 results: success (0) buildid: 20160416233055 builduid: 5ea39c7f7bd44a6e98214fe19ac83de1 revision: 2f58e7ce1ab8ff2ed3181a80cb3ac45ee3975799 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-17 02:06:13.389605) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-17 02:06:13.390014) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-17 02:06:13.390330) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-17 02:06:13.410378) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-17 02:06:13.410705) ========= 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=03627c79f6bb3d1578c4a402000001ba-1460878634.716219-684682743 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-17 02:06:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.7M=0s 2016-04-17 02:06:13 (42.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.104753 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-17 02:06:13.528639) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-17 02:06:13.528941) ========= 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=03627c79f6bb3d1578c4a402000001ba-1460878634.716219-684682743 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018290 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-17 02:06:13.579982) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-17 02:06:13.580306) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 2f58e7ce1ab8ff2ed3181a80cb3ac45ee3975799 --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 2f58e7ce1ab8ff2ed3181a80cb3ac45ee3975799 --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=03627c79f6bb3d1578c4a402000001ba-1460878634.716219-684682743 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-17 02:06:13,703 truncating revision to first 12 chars 2016-04-17 02:06:13,703 Setting DEBUG logging. 2016-04-17 02:06:13,703 attempt 1/10 2016-04-17 02:06:13,703 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/2f58e7ce1ab8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-17 02:06:14,467 unpacking tar archive at: fx-team-2f58e7ce1ab8/testing/mozharness/ program finished with exit code 0 elapsedTime=1.073655 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-17 02:06:14.667616) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-17 02:06:14.667942) ========= script_repo_revision: 2f58e7ce1ab8ff2ed3181a80cb3ac45ee3975799 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-17 02:06:14.668372) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-17 02:06:14.668653) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-17 02:06:14.676595) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-04-17 02:06:14.676869) ========= /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=03627c79f6bb3d1578c4a402000001ba-1460878634.716219-684682743 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:06:14 INFO - MultiFileLogger online at 20160417 02:06:14 in /builds/slave/test 02:06:14 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 02:06:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:06:14 INFO - {'append_to_log': False, 02:06:14 INFO - 'base_work_dir': '/builds/slave/test', 02:06:14 INFO - 'blob_upload_branch': 'Fx-Team', 02:06:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:06:14 INFO - 'branch': 'Fx-Team', 02:06:14 INFO - 'buildbot_json_path': 'buildprops.json', 02:06:14 INFO - 'config_files': ('talos/linux_config.py',), 02:06:14 INFO - 'default_actions': ('clobber', 02:06:14 INFO - 'read-buildbot-config', 02:06:14 INFO - 'download-and-extract', 02:06:14 INFO - 'populate-webroot', 02:06:14 INFO - 'create-virtualenv', 02:06:14 INFO - 'install', 02:06:14 INFO - 'run-tests'), 02:06:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:06:14 INFO - 'download_minidump_stackwalk': True, 02:06:14 INFO - 'download_symbols': 'ondemand', 02:06:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:06:14 INFO - 'tooltool.py': '/tools/tooltool.py', 02:06:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:06:14 INFO - '/tools/misc-python/virtualenv.py')}, 02:06:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:06:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:06:14 INFO - 'installer_path': 'installer.exe', 02:06:14 INFO - 'log_level': 'info', 02:06:14 INFO - 'log_name': 'talos', 02:06:14 INFO - 'log_to_console': True, 02:06:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:06:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:06:14 INFO - 'opt_config_files': (), 02:06:14 INFO - 'pip_index': False, 02:06:14 INFO - 'sps_profile': False, 02:06:14 INFO - 'sps_profile_interval': 0, 02:06:14 INFO - 'suite': 'dromaeojs', 02:06:14 INFO - 'system_bits': '32', 02:06:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:06:14 INFO - 'title': 'talos-linux64-ix-047', 02:06:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:06:14 INFO - 'use_talos_json': True, 02:06:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:06:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:06:14 INFO - 'work_dir': 'build'} 02:06:14 INFO - ##### 02:06:14 INFO - ##### Running clobber step. 02:06:14 INFO - ##### 02:06:14 INFO - Running pre-action listener: _resource_record_pre_action 02:06:14 INFO - Running main action method: clobber 02:06:14 INFO - rmtree: /builds/slave/test/build 02:06:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:06:15 INFO - Running post-action listener: _resource_record_post_action 02:06:15 INFO - ##### 02:06:15 INFO - ##### Running read-buildbot-config step. 02:06:15 INFO - ##### 02:06:15 INFO - Running pre-action listener: _resource_record_pre_action 02:06:15 INFO - Running main action method: read_buildbot_config 02:06:15 INFO - Using buildbot properties: 02:06:15 INFO - { 02:06:15 INFO - "project": "", 02:06:15 INFO - "product": "firefox", 02:06:15 INFO - "script_repo_revision": "production", 02:06:15 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 02:06:15 INFO - "repository": "", 02:06:15 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 02:06:15 INFO - "buildid": "20160416233055", 02:06:15 INFO - "pgo_build": "True", 02:06:15 INFO - "basedir": "/builds/slave/test", 02:06:15 INFO - "buildnumber": 37, 02:06:15 INFO - "slavename": "talos-linux64-ix-047", 02:06:15 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 02:06:15 INFO - "platform": "ubuntu64_hw", 02:06:15 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 02:06:15 INFO - "branch": "fx-team", 02:06:15 INFO - "repo_path": "integration/fx-team", 02:06:15 INFO - "revision": "2f58e7ce1ab8ff2ed3181a80cb3ac45ee3975799", 02:06:15 INFO - "stage_platform": "linux64-pgo", 02:06:15 INFO - "builduid": "5ea39c7f7bd44a6e98214fe19ac83de1", 02:06:15 INFO - "slavebuilddir": "test" 02:06:15 INFO - } 02:06:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/BOaYpnahT9OTWNv43IgMRw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 02:06:15 INFO - Running post-action listener: _resource_record_post_action 02:06:15 INFO - ##### 02:06:15 INFO - ##### Running download-and-extract step. 02:06:15 INFO - ##### 02:06:15 INFO - Running pre-action listener: _resource_record_pre_action 02:06:15 INFO - Running main action method: download_and_extract 02:06:15 INFO - mkdir: /builds/slave/test/build/tests 02:06:15 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')]} 02:06:15 INFO - https://queue.taskcluster.net/v1/task/BOaYpnahT9OTWNv43IgMRw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 02:06:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BOaYpnahT9OTWNv43IgMRw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 02:06:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BOaYpnahT9OTWNv43IgMRw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 02:06:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BOaYpnahT9OTWNv43IgMRw/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 02:06:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BOaYpnahT9OTWNv43IgMRw/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 02:06:25 INFO - Downloaded 1361 bytes. 02:06:25 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 02:06:25 INFO - Using the following test package requirements: 02:06:25 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 02:06:25 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:06:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:06:25 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:06:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:06:25 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:06:25 INFO - u'jsshell-linux-x86_64.zip'], 02:06:25 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:06:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:06:25 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 02:06:25 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:06:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:06:25 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:06:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:06:25 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:06:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:06:25 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:06:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:06:25 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:06:25 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')]} 02:06:25 INFO - https://queue.taskcluster.net/v1/task/BOaYpnahT9OTWNv43IgMRw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:06:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BOaYpnahT9OTWNv43IgMRw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 02:06:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BOaYpnahT9OTWNv43IgMRw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 02:06:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BOaYpnahT9OTWNv43IgMRw/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 02:06:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BOaYpnahT9OTWNv43IgMRw/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 02:06:34 INFO - Downloaded 23774918 bytes. 02:06:34 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'] 02:06:34 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 02:06:35 INFO - Return code: 0 02:06:35 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 02:06:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:06:35 INFO - https://queue.taskcluster.net/v1/task/BOaYpnahT9OTWNv43IgMRw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:06:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BOaYpnahT9OTWNv43IgMRw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 02:06:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BOaYpnahT9OTWNv43IgMRw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 02:06:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BOaYpnahT9OTWNv43IgMRw/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 02:06:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BOaYpnahT9OTWNv43IgMRw/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 02:06:37 INFO - Downloaded 23774918 bytes. 02:06:37 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'] 02:06:37 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 02:06:39 INFO - Return code: 0 02:06:39 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')]} 02:06:39 INFO - https://queue.taskcluster.net/v1/task/BOaYpnahT9OTWNv43IgMRw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:06:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BOaYpnahT9OTWNv43IgMRw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 02:06:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BOaYpnahT9OTWNv43IgMRw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 02:06:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BOaYpnahT9OTWNv43IgMRw/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 02:06:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BOaYpnahT9OTWNv43IgMRw/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 02:06:40 INFO - Downloaded 10841076 bytes. 02:06:40 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'] 02:06:40 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 02:06:40 INFO - Return code: 0 02:06:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:06:40 INFO - https://queue.taskcluster.net/v1/task/BOaYpnahT9OTWNv43IgMRw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:06:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BOaYpnahT9OTWNv43IgMRw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 02:06:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BOaYpnahT9OTWNv43IgMRw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 02:06:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BOaYpnahT9OTWNv43IgMRw/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 02:06:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BOaYpnahT9OTWNv43IgMRw/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 02:06:42 INFO - Downloaded 58243534 bytes. 02:06:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BOaYpnahT9OTWNv43IgMRw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 02:06:42 INFO - mkdir: /builds/slave/test/properties 02:06:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:06:42 INFO - Writing to file /builds/slave/test/properties/build_url 02:06:42 INFO - Contents: 02:06:42 INFO - build_url:https://queue.taskcluster.net/v1/task/BOaYpnahT9OTWNv43IgMRw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 02:06:42 INFO - Running post-action listener: _resource_record_post_action 02:06:42 INFO - Running post-action listener: set_extra_try_arguments 02:06:42 INFO - ##### 02:06:42 INFO - ##### Running populate-webroot step. 02:06:42 INFO - ##### 02:06:42 INFO - Running pre-action listener: _resource_record_pre_action 02:06:42 INFO - Running main action method: populate_webroot 02:06:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:06:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:06:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:06:42 INFO - '--tppagecycles', 02:06:42 INFO - '7'], 02:06:42 INFO - 'tests': ['tsvgm']}}, 02:06:42 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:06:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:06:42 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:06:42 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:06:42 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:06:42 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:06:42 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:06:42 INFO - 'talos_options': ['--disable-e10s'], 02:06:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:06:42 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:06:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:06:42 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:06:42 INFO - 'talos_options': ['--disable-e10s'], 02:06:42 INFO - 'tests': ['damp', 'tps']}, 02:06:42 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:06:42 INFO - 'tests': ['damp', 'tps']}, 02:06:42 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:06:42 INFO - 'tests': ['dromaeo_dom']}, 02:06:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:06:42 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:06:42 INFO - 'tests': ['a11yr', 02:06:42 INFO - 'ts_paint', 02:06:42 INFO - 'tpaint', 02:06:42 INFO - 'sessionrestore', 02:06:42 INFO - 'sessionrestore_no_auto_restore', 02:06:42 INFO - 'tabpaint']}, 02:06:42 INFO - 'other-e10s': {'tests': ['a11yr', 02:06:42 INFO - 'ts_paint', 02:06:42 INFO - 'tpaint', 02:06:42 INFO - 'sessionrestore', 02:06:42 INFO - 'sessionrestore_no_auto_restore', 02:06:42 INFO - 'tabpaint']}, 02:06:42 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:06:42 INFO - 'ts_paint', 02:06:42 INFO - 'tpaint', 02:06:42 INFO - 'sessionrestore', 02:06:42 INFO - 'sessionrestore_no_auto_restore', 02:06:42 INFO - 'tabpaint']}, 02:06:42 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:06:42 INFO - 'ts_paint', 02:06:42 INFO - 'tpaint', 02:06:42 INFO - 'sessionrestore', 02:06:42 INFO - 'sessionrestore_no_auto_restore', 02:06:42 INFO - 'tabpaint']}, 02:06:42 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:06:42 INFO - 'tests': ['a11yr', 02:06:42 INFO - 'ts_paint', 02:06:42 INFO - 'tpaint', 02:06:42 INFO - 'sessionrestore', 02:06:42 INFO - 'sessionrestore_no_auto_restore', 02:06:42 INFO - 'tabpaint']}, 02:06:42 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:06:42 INFO - 'tests': ['a11yr', 02:06:42 INFO - 'ts_paint', 02:06:42 INFO - 'tpaint', 02:06:42 INFO - 'sessionrestore', 02:06:42 INFO - 'sessionrestore_no_auto_restore', 02:06:42 INFO - 'tabpaint']}, 02:06:42 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:06:42 INFO - 'tests': ['tsvgx', 02:06:42 INFO - 'tsvgr_opacity', 02:06:42 INFO - 'tart', 02:06:42 INFO - 'tscrollx', 02:06:42 INFO - 'cart']}, 02:06:42 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:06:42 INFO - 'tsvgr_opacity', 02:06:42 INFO - 'tart', 02:06:42 INFO - 'tscrollx', 02:06:42 INFO - 'cart']}, 02:06:42 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:06:42 INFO - 'talos_options': ['--disable-e10s'], 02:06:42 INFO - 'tests': ['tp5o']}, 02:06:42 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:06:42 INFO - 'tests': ['tp5o']}, 02:06:42 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:06:42 INFO - 'talos_options': ['--disable-e10s', 02:06:42 INFO - '--xperf_path', 02:06:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:06:42 INFO - 'tests': ['tp5n']}, 02:06:42 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:06:42 INFO - 'talos_options': ['--xperf_path', 02:06:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:06:42 INFO - 'tests': ['tp5n']}}, 02:06:42 INFO - 'talos.zip': {'path': '', 02:06:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:06:42 INFO - Running post-action listener: _resource_record_post_action 02:06:42 INFO - ##### 02:06:42 INFO - ##### Running create-virtualenv step. 02:06:42 INFO - ##### 02:06:42 INFO - Running pre-action listener: _resource_record_pre_action 02:06:42 INFO - Running main action method: create_virtualenv 02:06:42 INFO - Creating virtualenv /builds/slave/test/build/venv 02:06:42 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 02:06:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:06:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:06:42 INFO - Using real prefix '/usr' 02:06:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:06:43 INFO - Installing distribute.............................................................................................................................................................................................done. 02:06:45 INFO - Installing pip.................done. 02:06:45 INFO - Return code: 0 02:06:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:06: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')]} 02:06:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:06:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06: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')]} 02:06:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:06:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f31ad9b9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26d39a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2762810>, '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 0x2763710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2763ba0>, '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': '03627c79f6bb3d1578c4a402000001ba-1460878634.716219-684682743', '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 02:06:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:06:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:06:45 INFO - Using env: {'DISPLAY': ':0', 02:06:45 INFO - 'HOME': '/home/cltbld', 02:06:45 INFO - 'LANG': 'en_US.UTF-8', 02:06:45 INFO - 'LANGUAGE': 'en_US:en', 02:06:45 INFO - 'LOGNAME': 'cltbld', 02:06:45 INFO - 'MAIL': '/var/mail/cltbld', 02:06:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:06:45 INFO - 'MOZ_NO_REMOTE': '1', 02:06:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:06:45 INFO - 'NO_EM_RESTART': '1', 02:06:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:06:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:06:45 INFO - 'PWD': '/builds/slave/test', 02:06:45 INFO - 'SHELL': '/bin/bash', 02:06:45 INFO - 'SHLVL': '1', 02:06:45 INFO - 'TERM': 'linux', 02:06:45 INFO - 'TMOUT': '86400', 02:06:45 INFO - 'USER': 'cltbld', 02:06:45 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1460878634.716219-684682743', 02:06:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:06:45 INFO - '_': '/tools/buildbot/bin/python'} 02:06:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:06:45 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 02:06:45 INFO - Cleaning up... 02:06:45 INFO - Return code: 0 02:06:45 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 02:06: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')]} 02:06:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:06:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06: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')]} 02:06:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:06:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f31ad9b9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26d39a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2762810>, '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 0x2763710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2763ba0>, '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': '03627c79f6bb3d1578c4a402000001ba-1460878634.716219-684682743', '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 02:06:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 02:06:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 02:06:45 INFO - Using env: {'DISPLAY': ':0', 02:06:45 INFO - 'HOME': '/home/cltbld', 02:06:45 INFO - 'LANG': 'en_US.UTF-8', 02:06:45 INFO - 'LANGUAGE': 'en_US:en', 02:06:45 INFO - 'LOGNAME': 'cltbld', 02:06:45 INFO - 'MAIL': '/var/mail/cltbld', 02:06:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:06:45 INFO - 'MOZ_NO_REMOTE': '1', 02:06:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:06:45 INFO - 'NO_EM_RESTART': '1', 02:06:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:06:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:06:45 INFO - 'PWD': '/builds/slave/test', 02:06:45 INFO - 'SHELL': '/bin/bash', 02:06:45 INFO - 'SHLVL': '1', 02:06:45 INFO - 'TERM': 'linux', 02:06:45 INFO - 'TMOUT': '86400', 02:06:45 INFO - 'USER': 'cltbld', 02:06:45 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1460878634.716219-684682743', 02:06:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:06:45 INFO - '_': '/tools/buildbot/bin/python'} 02:06:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:06:45 INFO - Downloading/unpacking psutil>=0.7.1 02:06:45 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 02:06:45 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 02:06:45 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 02:06:45 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 02:06:45 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 02:06:45 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 02:06:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:06:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:06:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:06:47 INFO - Installing collected packages: psutil 02:06:47 INFO - Running setup.py install for psutil 02:06:47 INFO - building 'psutil._psutil_linux' extension 02:06:47 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 02:06:48 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 02:06:48 INFO - building 'psutil._psutil_posix' extension 02:06:48 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 02:06:48 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 02:06:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:06:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:06:48 INFO - Successfully installed psutil 02:06:48 INFO - Cleaning up... 02:06:48 INFO - Return code: 0 02:06:48 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 02:06: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')]} 02:06:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:06:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06: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')]} 02:06:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:06:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f31ad9b9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26d39a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2762810>, '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 0x2763710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2763ba0>, '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': '03627c79f6bb3d1578c4a402000001ba-1460878634.716219-684682743', '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 02:06:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 02:06:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 02:06:48 INFO - Using env: {'DISPLAY': ':0', 02:06:48 INFO - 'HOME': '/home/cltbld', 02:06:48 INFO - 'LANG': 'en_US.UTF-8', 02:06:48 INFO - 'LANGUAGE': 'en_US:en', 02:06:48 INFO - 'LOGNAME': 'cltbld', 02:06:48 INFO - 'MAIL': '/var/mail/cltbld', 02:06:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:06:48 INFO - 'MOZ_NO_REMOTE': '1', 02:06:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:06:48 INFO - 'NO_EM_RESTART': '1', 02:06:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:06:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:06:48 INFO - 'PWD': '/builds/slave/test', 02:06:48 INFO - 'SHELL': '/bin/bash', 02:06:48 INFO - 'SHLVL': '1', 02:06:48 INFO - 'TERM': 'linux', 02:06:48 INFO - 'TMOUT': '86400', 02:06:48 INFO - 'USER': 'cltbld', 02:06:48 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1460878634.716219-684682743', 02:06:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:06:48 INFO - '_': '/tools/buildbot/bin/python'} 02:06:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:06:48 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02:06:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:06:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:06:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:06:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:06:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:06:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:06:50 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:06:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:06:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 02:06:50 INFO - Installing collected packages: mozsystemmonitor 02:06:50 INFO - Running setup.py install for mozsystemmonitor 02:06:50 INFO - Successfully installed mozsystemmonitor 02:06:50 INFO - Cleaning up... 02:06:50 INFO - Return code: 0 02:06:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:06:50 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')]} 02:06:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:06:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:50 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')]} 02:06:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:06:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:50 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 0x7f31ad9b9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26d39a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2762810>, '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 0x2763710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2763ba0>, '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': '03627c79f6bb3d1578c4a402000001ba-1460878634.716219-684682743', '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 02:06:50 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 02:06:50 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 02:06:50 INFO - Using env: {'DISPLAY': ':0', 02:06:50 INFO - 'HOME': '/home/cltbld', 02:06:50 INFO - 'LANG': 'en_US.UTF-8', 02:06:50 INFO - 'LANGUAGE': 'en_US:en', 02:06:50 INFO - 'LOGNAME': 'cltbld', 02:06:50 INFO - 'MAIL': '/var/mail/cltbld', 02:06:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:06:50 INFO - 'MOZ_NO_REMOTE': '1', 02:06:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:06:50 INFO - 'NO_EM_RESTART': '1', 02:06:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:06:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:06:50 INFO - 'PWD': '/builds/slave/test', 02:06:50 INFO - 'SHELL': '/bin/bash', 02:06:50 INFO - 'SHLVL': '1', 02:06:50 INFO - 'TERM': 'linux', 02:06:50 INFO - 'TMOUT': '86400', 02:06:50 INFO - 'USER': 'cltbld', 02:06:50 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1460878634.716219-684682743', 02:06:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:06:50 INFO - '_': '/tools/buildbot/bin/python'} 02:06:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:06:50 INFO - Downloading/unpacking blobuploader==1.2.4 02:06:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:06:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:06:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:06:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:06:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:06:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:06:52 INFO - Downloading blobuploader-1.2.4.tar.gz 02:06:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:06:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:06:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:06:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:06:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:06:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:06:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:06:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:06:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:06:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:06:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:06:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:06:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:06:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:06:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:06:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:06:53 INFO - Downloading docopt-0.6.1.tar.gz 02:06:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:06:53 INFO - Installing collected packages: blobuploader, requests, docopt 02:06:53 INFO - Running setup.py install for blobuploader 02:06:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:06:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:06:53 INFO - Running setup.py install for requests 02:06:54 INFO - Running setup.py install for docopt 02:06:54 INFO - Successfully installed blobuploader requests docopt 02:06:54 INFO - Cleaning up... 02:06:54 INFO - Return code: 0 02:06:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:06:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:06:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:06:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:06:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:06:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:54 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 0x7f31ad9b9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26d39a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2762810>, '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 0x2763710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2763ba0>, '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': '03627c79f6bb3d1578c4a402000001ba-1460878634.716219-684682743', '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 02:06:54 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 02:06:54 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 02:06:54 INFO - Using env: {'DISPLAY': ':0', 02:06:54 INFO - 'HOME': '/home/cltbld', 02:06:54 INFO - 'LANG': 'en_US.UTF-8', 02:06:54 INFO - 'LANGUAGE': 'en_US:en', 02:06:54 INFO - 'LOGNAME': 'cltbld', 02:06:54 INFO - 'MAIL': '/var/mail/cltbld', 02:06:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:06:54 INFO - 'MOZ_NO_REMOTE': '1', 02:06:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:06:54 INFO - 'NO_EM_RESTART': '1', 02:06:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:06:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:06:54 INFO - 'PWD': '/builds/slave/test', 02:06:54 INFO - 'SHELL': '/bin/bash', 02:06:54 INFO - 'SHLVL': '1', 02:06:54 INFO - 'TERM': 'linux', 02:06:54 INFO - 'TMOUT': '86400', 02:06:54 INFO - 'USER': 'cltbld', 02:06:54 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1460878634.716219-684682743', 02:06:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:06:54 INFO - '_': '/tools/buildbot/bin/python'} 02:06:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:06:54 INFO - Running setup.py (path:/tmp/pip-LxSjrr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:06:54 INFO - Running setup.py (path:/tmp/pip-tb0vPs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:06:54 INFO - Running setup.py (path:/tmp/pip-mFYO4V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:06:54 INFO - Running setup.py (path:/tmp/pip-ZAN32M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:06:54 INFO - Running setup.py (path:/tmp/pip-Osx6NG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:06:54 INFO - Running setup.py (path:/tmp/pip-JCDROv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:06:54 INFO - Running setup.py (path:/tmp/pip-zl8vro-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:06:54 INFO - Running setup.py (path:/tmp/pip-B8abjY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:06:54 INFO - Running setup.py (path:/tmp/pip-0LnFbm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:06:55 INFO - Running setup.py (path:/tmp/pip-XF94Uf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:06:55 INFO - Running setup.py (path:/tmp/pip-f6X5wy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:06:55 INFO - Running setup.py (path:/tmp/pip-eRFOZm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:06:55 INFO - Running setup.py (path:/tmp/pip-ofeXyX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:06:55 INFO - Running setup.py (path:/tmp/pip-AOVf1O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:06:55 INFO - Running setup.py (path:/tmp/pip-p7kOom-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:06:55 INFO - Running setup.py (path:/tmp/pip-D0LEMC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:06:55 INFO - Running setup.py (path:/tmp/pip-PnAjhK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:06:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:06:55 INFO - Running setup.py install for manifestparser 02:06:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:06:55 INFO - Running setup.py install for mozcrash 02:06:55 INFO - Running setup.py install for mozdebug 02:06:55 INFO - Running setup.py install for mozdevice 02:06:56 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:06:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:06:56 INFO - Running setup.py install for mozfile 02:06:56 INFO - Running setup.py install for mozhttpd 02:06:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:06:56 INFO - Running setup.py install for mozinfo 02:06:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:06:56 INFO - Running setup.py install for mozInstall 02:06:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:06:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:06:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:06:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:06:56 INFO - Running setup.py install for mozleak 02:06:56 INFO - Running setup.py install for mozlog 02:06:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:06:56 INFO - Running setup.py install for moznetwork 02:06:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:06:56 INFO - Running setup.py install for mozprocess 02:06:56 INFO - Running setup.py install for mozprofile 02:06:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:06:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:06:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:06:56 INFO - Running setup.py install for mozrunner 02:06:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:06:57 INFO - Running setup.py install for mozscreenshot 02:06:57 INFO - Running setup.py install for moztest 02:06:57 INFO - Running setup.py install for mozversion 02:06:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:06:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:06:57 INFO - Cleaning up... 02:06:57 INFO - Return code: 0 02:06:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:06:57 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')]} 02:06:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:06:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:57 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')]} 02:06:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:06:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:57 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 0x7f31ad9b9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26d39a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2762810>, '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 0x2763710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2763ba0>, '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': '03627c79f6bb3d1578c4a402000001ba-1460878634.716219-684682743', '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 02:06:57 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 02:06:57 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 02:06:57 INFO - Using env: {'DISPLAY': ':0', 02:06:57 INFO - 'HOME': '/home/cltbld', 02:06:57 INFO - 'LANG': 'en_US.UTF-8', 02:06:57 INFO - 'LANGUAGE': 'en_US:en', 02:06:57 INFO - 'LOGNAME': 'cltbld', 02:06:57 INFO - 'MAIL': '/var/mail/cltbld', 02:06:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:06:57 INFO - 'MOZ_NO_REMOTE': '1', 02:06:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:06:57 INFO - 'NO_EM_RESTART': '1', 02:06:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:06:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:06:57 INFO - 'PWD': '/builds/slave/test', 02:06:57 INFO - 'SHELL': '/bin/bash', 02:06:57 INFO - 'SHLVL': '1', 02:06:57 INFO - 'TERM': 'linux', 02:06:57 INFO - 'TMOUT': '86400', 02:06:57 INFO - 'USER': 'cltbld', 02:06:57 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1460878634.716219-684682743', 02:06:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:06:57 INFO - '_': '/tools/buildbot/bin/python'} 02:06:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:06:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:06:57 INFO - Running setup.py (path:/tmp/pip-EGRFFS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:06:57 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)) 02:06:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:06:57 INFO - Running setup.py (path:/tmp/pip-HuusWG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:06:57 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)) 02:06:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:06:57 INFO - Running setup.py (path:/tmp/pip-4h0GDX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:06:57 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)) 02:06:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:06:57 INFO - Running setup.py (path:/tmp/pip-DVL8Bp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:06:57 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)) 02:06:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:06:57 INFO - Running setup.py (path:/tmp/pip-tnNmnu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:06:58 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)) 02:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:06:58 INFO - Running setup.py (path:/tmp/pip-JlMNgt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:06:58 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)) 02:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:06:58 INFO - Running setup.py (path:/tmp/pip-oZH5Sg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:06:58 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)) 02:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:06:58 INFO - Running setup.py (path:/tmp/pip-I7W8HY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:06:58 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)) 02:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:06:58 INFO - Running setup.py (path:/tmp/pip-SLXwXG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:06:58 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)) 02:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:06:58 INFO - Running setup.py (path:/tmp/pip-a_iQ4g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:06:58 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)) 02:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:06:58 INFO - Running setup.py (path:/tmp/pip-Rb_cmj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:06:58 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)) 02:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:06:58 INFO - Running setup.py (path:/tmp/pip-lY76bR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:06:58 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)) 02:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:06:58 INFO - Running setup.py (path:/tmp/pip-vnYULb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:06:58 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)) 02:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:06:58 INFO - Running setup.py (path:/tmp/pip-Iiz7lk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:06:58 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)) 02:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:06:58 INFO - Running setup.py (path:/tmp/pip-DcRqWb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:06:58 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)) 02:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:06:58 INFO - Running setup.py (path:/tmp/pip-DhStsz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:06:58 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)) 02:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:06:58 INFO - Running setup.py (path:/tmp/pip-B5oYRf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:06:58 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)) 02:06:58 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)) 02:06:58 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)) 02:06:58 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)) 02:06:58 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)) 02:06:58 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)) 02:06:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:06: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 02:06: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 02:06: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 02:06: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 02:06: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 02:06: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 02:07:00 INFO - Downloading blessings-1.6.tar.gz 02:07:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:07:00 INFO - Installing collected packages: blessings 02:07:00 INFO - Running setup.py install for blessings 02:07:00 INFO - Successfully installed blessings 02:07:00 INFO - Cleaning up... 02:07:01 INFO - Return code: 0 02:07:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:07:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:07:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:07:01 INFO - Reading from file tmpfile_stdout 02:07:01 INFO - Current package versions: 02:07:01 INFO - argparse == 1.2.1 02:07:01 INFO - blessings == 1.6 02:07:01 INFO - blobuploader == 1.2.4 02:07:01 INFO - docopt == 0.6.1 02:07:01 INFO - manifestparser == 1.1 02:07:01 INFO - mozInstall == 1.12 02:07:01 INFO - mozcrash == 0.17 02:07:01 INFO - mozdebug == 0.1 02:07:01 INFO - mozdevice == 0.48 02:07:01 INFO - mozfile == 1.2 02:07:01 INFO - mozhttpd == 0.7 02:07:01 INFO - mozinfo == 0.9 02:07:01 INFO - mozleak == 0.1 02:07:01 INFO - mozlog == 3.1 02:07:01 INFO - moznetwork == 0.27 02:07:01 INFO - mozprocess == 0.22 02:07:01 INFO - mozprofile == 0.28 02:07:01 INFO - mozrunner == 6.11 02:07:01 INFO - mozscreenshot == 0.1 02:07:01 INFO - mozsystemmonitor == 0.0 02:07:01 INFO - moztest == 0.7 02:07:01 INFO - mozversion == 1.4 02:07:01 INFO - psutil == 3.1.1 02:07:01 INFO - requests == 1.2.3 02:07:01 INFO - wsgiref == 0.1.2 02:07:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:07:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:07:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:07:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:07:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:07:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:01 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 0x7f31ad9b9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26d39a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2762810>, '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 0x2763710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2763ba0>, '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': '03627c79f6bb3d1578c4a402000001ba-1460878634.716219-684682743', '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 02:07:01 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 02:07:01 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 02:07:01 INFO - Using env: {'DISPLAY': ':0', 02:07:01 INFO - 'HOME': '/home/cltbld', 02:07:01 INFO - 'LANG': 'en_US.UTF-8', 02:07:01 INFO - 'LANGUAGE': 'en_US:en', 02:07:01 INFO - 'LOGNAME': 'cltbld', 02:07:01 INFO - 'MAIL': '/var/mail/cltbld', 02:07:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:07:01 INFO - 'MOZ_NO_REMOTE': '1', 02:07:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:07:01 INFO - 'NO_EM_RESTART': '1', 02:07:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:07:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:07:01 INFO - 'PWD': '/builds/slave/test', 02:07:01 INFO - 'SHELL': '/bin/bash', 02:07:01 INFO - 'SHLVL': '1', 02:07:01 INFO - 'TERM': 'linux', 02:07:01 INFO - 'TMOUT': '86400', 02:07:01 INFO - 'USER': 'cltbld', 02:07:01 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1460878634.716219-684682743', 02:07:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:07:01 INFO - '_': '/tools/buildbot/bin/python'} 02:07:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:07:01 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)) 02:07:01 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)) 02:07:01 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)) 02:07:01 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)) 02:07:01 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)) 02:07:01 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)) 02:07:01 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)) 02:07:01 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)) 02:07:01 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)) 02:07:01 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)) 02:07:01 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)) 02:07:01 INFO - Cleaning up... 02:07:01 INFO - Return code: 0 02:07:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:07:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:07:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:07:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:07:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:07:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f31ad9b9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26d39a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2762810>, '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 0x2763710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2763ba0>, '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': '03627c79f6bb3d1578c4a402000001ba-1460878634.716219-684682743', '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 02:07:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:07:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:07:01 INFO - Using env: {'DISPLAY': ':0', 02:07:01 INFO - 'HOME': '/home/cltbld', 02:07:01 INFO - 'LANG': 'en_US.UTF-8', 02:07:01 INFO - 'LANGUAGE': 'en_US:en', 02:07:01 INFO - 'LOGNAME': 'cltbld', 02:07:01 INFO - 'MAIL': '/var/mail/cltbld', 02:07:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:07:01 INFO - 'MOZ_NO_REMOTE': '1', 02:07:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:07:01 INFO - 'NO_EM_RESTART': '1', 02:07:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:07:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:07:01 INFO - 'PWD': '/builds/slave/test', 02:07:01 INFO - 'SHELL': '/bin/bash', 02:07:01 INFO - 'SHLVL': '1', 02:07:01 INFO - 'TERM': 'linux', 02:07:01 INFO - 'TMOUT': '86400', 02:07:01 INFO - 'USER': 'cltbld', 02:07:01 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1460878634.716219-684682743', 02:07:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:07:01 INFO - '_': '/tools/buildbot/bin/python'} 02:07:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:07:01 INFO - Downloading/unpacking jsonschema 02:07:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:07:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:07:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:07:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:07:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:07:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:07:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:07:03 INFO - Downloading/unpacking functools32 (from jsonschema) 02:07: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 02:07: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 02:07: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 02:07: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 02:07: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 02:07: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 02:07:03 INFO - Downloading functools32-3.2.3-2.tar.gz 02:07:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:07:03 INFO - warning: no files found matching '*.txt' 02:07:03 INFO - no previously-included directories found matching 'build' 02:07:03 INFO - no previously-included directories found matching 'dist' 02:07:03 INFO - no previously-included directories found matching '.git*' 02:07:03 INFO - Installing collected packages: jsonschema, functools32 02:07:03 INFO - Running setup.py install for functools32 02:07:03 INFO - warning: no files found matching '*.txt' 02:07:03 INFO - no previously-included directories found matching 'build' 02:07:03 INFO - no previously-included directories found matching 'dist' 02:07:03 INFO - no previously-included directories found matching '.git*' 02:07:03 INFO - Successfully installed jsonschema functools32 02:07:03 INFO - Cleaning up... 02:07:04 INFO - Return code: 0 02:07:04 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:07: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')]} 02:07:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:07:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07: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')]} 02:07:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:07:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:04 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 0x7f31ad9b9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26d39a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2762810>, '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 0x2763710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2763ba0>, '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': '03627c79f6bb3d1578c4a402000001ba-1460878634.716219-684682743', '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 02:07:04 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 02:07:04 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 02:07:04 INFO - Using env: {'DISPLAY': ':0', 02:07:04 INFO - 'HOME': '/home/cltbld', 02:07:04 INFO - 'LANG': 'en_US.UTF-8', 02:07:04 INFO - 'LANGUAGE': 'en_US:en', 02:07:04 INFO - 'LOGNAME': 'cltbld', 02:07:04 INFO - 'MAIL': '/var/mail/cltbld', 02:07:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:07:04 INFO - 'MOZ_NO_REMOTE': '1', 02:07:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:07:04 INFO - 'NO_EM_RESTART': '1', 02:07:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:07:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:07:04 INFO - 'PWD': '/builds/slave/test', 02:07:04 INFO - 'SHELL': '/bin/bash', 02:07:04 INFO - 'SHLVL': '1', 02:07:04 INFO - 'TERM': 'linux', 02:07:04 INFO - 'TMOUT': '86400', 02:07:04 INFO - 'USER': 'cltbld', 02:07:04 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1460878634.716219-684682743', 02:07:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:07:04 INFO - '_': '/tools/buildbot/bin/python'} 02:07:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:07:04 INFO - Downloading/unpacking flake8 02:07:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:07:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:07:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:07:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:07:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:07:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:07:06 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:07:06 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:07:06 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 02:07:06 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 02:07:06 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 02:07:06 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 02:07:06 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 02:07:06 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 02:07:06 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:07:06 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:07:06 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 02:07:06 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 02:07:06 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 02:07:06 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 02:07:06 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 02:07:06 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 02:07:06 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:07:06 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 02:07:06 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 02:07:06 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 02:07:06 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 02:07:06 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 02:07:06 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 02:07:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:07:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:07:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:07:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:07:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:07:06 INFO - no previously-included directories found matching 'docs/_build' 02:07:06 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:07:06 INFO - Running setup.py install for pep8 02:07:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:07:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:07:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:07:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:07:06 INFO - no previously-included directories found matching 'docs/_build' 02:07:07 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:07:07 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:07:07 INFO - Cleaning up... 02:07:07 INFO - Return code: 0 02:07:07 INFO - Running post-action listener: _resource_record_post_action 02:07:07 INFO - Running post-action listener: _start_resource_monitoring 02:07:07 INFO - Starting resource monitoring. 02:07:07 INFO - ##### 02:07:07 INFO - ##### Running install step. 02:07:07 INFO - ##### 02:07:07 INFO - Running pre-action listener: _resource_record_pre_action 02:07:07 INFO - Running main action method: install 02:07:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:07:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:07:07 INFO - Reading from file tmpfile_stdout 02:07:07 INFO - Detecting whether we're running mozinstall >=1.0... 02:07:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:07:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:07:07 INFO - Reading from file tmpfile_stdout 02:07:07 INFO - Output received: 02:07:07 INFO - Usage: mozinstall [options] installer 02:07:07 INFO - Options: 02:07:07 INFO - -h, --help show this help message and exit 02:07:07 INFO - -d DEST, --destination=DEST 02:07:07 INFO - Directory to install application into. [default: 02:07:07 INFO - "/builds/slave/test"] 02:07:07 INFO - --app=APP Application being installed. [default: firefox] 02:07:07 INFO - mkdir: /builds/slave/test/build/application 02:07:07 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'] 02:07:07 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 02:07:23 INFO - Reading from file tmpfile_stdout 02:07:23 INFO - Output received: 02:07:23 INFO - /builds/slave/test/build/application/firefox/firefox 02:07:23 INFO - Running post-action listener: _resource_record_post_action 02:07:23 INFO - ##### 02:07:23 INFO - ##### Running run-tests step. 02:07:23 INFO - ##### 02:07:23 INFO - Running pre-action listener: _resource_record_pre_action 02:07:23 INFO - Running main action method: run_tests 02:07:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:07:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:07:23 INFO - Python 2.7.3 02:07:23 INFO - Return code: 0 02:07:23 INFO - grabbing minidump binary from tooltool 02:07:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:07:23 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 0x2762810>, '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 0x2763710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2763ba0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:07:23 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 02:07:23 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 02:07:23 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:07:23 INFO - Return code: 0 02:07:23 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:07:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:07:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:07:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:07:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:07:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:07:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:07:24 INFO - Return code: 0 02:07:24 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/BOaYpnahT9OTWNv43IgMRw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--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 02:07:24 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/BOaYpnahT9OTWNv43IgMRw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-047 --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 02:07:24 INFO - Using env: {'DISPLAY': ':0', 02:07:24 INFO - 'HOME': '/home/cltbld', 02:07:24 INFO - 'LANG': 'en_US.UTF-8', 02:07:24 INFO - 'LANGUAGE': 'en_US:en', 02:07:24 INFO - 'LOGNAME': 'cltbld', 02:07:24 INFO - 'MAIL': '/var/mail/cltbld', 02:07:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:07:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:07:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:07:24 INFO - 'MOZ_NO_REMOTE': '1', 02:07:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:07:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:07:24 INFO - 'NO_EM_RESTART': '1', 02:07:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:07:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:07:24 INFO - 'PWD': '/builds/slave/test', 02:07:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:07:24 INFO - 'SHELL': '/bin/bash', 02:07:24 INFO - 'SHLVL': '1', 02:07:24 INFO - 'TERM': 'linux', 02:07:24 INFO - 'TMOUT': '86400', 02:07:24 INFO - 'USER': 'cltbld', 02:07:24 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1460878634.716219-684682743', 02:07:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:07:24 INFO - '_': '/tools/buildbot/bin/python'} 02:07:24 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/BOaYpnahT9OTWNv43IgMRw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--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 02:07:25 INFO - mozversion application_buildid: 20160416233055 02:07:25 INFO - mozversion application_changeset: 2f58e7ce1ab8ff2ed3181a80cb3ac45ee3975799 02:07:25 INFO - mozversion application_display_name: Nightly 02:07:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:07:25 INFO - mozversion application_name: Firefox 02:07:25 INFO - mozversion application_remotingname: firefox 02:07:25 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 02:07:25 INFO - mozversion application_vendor: Mozilla 02:07:25 INFO - mozversion application_version: 48.0a1 02:07:25 INFO - mozversion platform_buildid: 20160416233055 02:07:25 INFO - mozversion platform_changeset: 2f58e7ce1ab8ff2ed3181a80cb3ac45ee3975799 02:07:25 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 02:07:25 INFO - mozversion platform_version: 48.0a1 02:07:25 INFO - using testdate: 1460884045 02:07:25 INFO - actual date: 1460884045 02:07:25 INFO - starting webserver on 'localhost:53826' 02:07:25 INFO - SUITE-START | Running 2 tests 02:07:25 INFO - TEST-START | dromaeo_css 02:07:25 INFO - operating with platform_type : linux_ 02:07:25 INFO - Initialising browser for dromaeo_css test... 02:07:25 INFO - TEST-INFO | started process 11466 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppQ3GyA/profile http://localhost:53826/getInfo.html) 02:07:29 INFO - PROCESS | 11466 | __metrics Screen width/height:1600/1200 02:07:29 INFO - PROCESS | 11466 | colorDepth:24 02:07:29 INFO - PROCESS | 11466 | Browser inner width/height: 1024/697 02:07:29 INFO - PROCESS | 11466 | __metrics 02:07:30 ERROR - PROCESS | 11466 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 02:07:31 INFO - TEST-INFO | 11466: exit 0 02:07:31 INFO - Browser initialized. 02:07:31 INFO - Running cycle 1/1 for dromaeo_css test... 02:07:31 INFO - TEST-INFO | started process 11549 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppQ3GyA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:07:43 INFO - PROCESS | 11549 | RSS: Main: 153698304 02:07:43 INFO - PROCESS | 11549 | 02:08:34 INFO - PROCESS | 11549 | 1460884114352 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] 02:10:41 INFO - PROCESS | 11549 | Cycle 1(1): loaded http://localhost:53826/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53826/tests/dromaeo/cssquery-ext.html) 02:10:43 INFO - PROCESS | 11549 | RSS: Main: 278192128 02:10:43 INFO - PROCESS | 11549 | 02:13:45 INFO - PROCESS | 11549 | Cycle 1(1): loaded http://localhost:53826/tests/dromaeo/cssquery-ext.html (next: http://localhost:53826/tests/dromaeo/cssquery-jquery.html) 02:13:45 INFO - PROCESS | 11549 | RSS: Main: 229167104 02:13:45 INFO - PROCESS | 11549 | 02:16:47 INFO - PROCESS | 11549 | Cycle 1(1): loaded http://localhost:53826/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53826/tests/dromaeo/cssquery-mootools.html) 02:16:48 INFO - PROCESS | 11549 | RSS: Main: 234885120 02:16:48 INFO - PROCESS | 11549 | 02:19:50 INFO - PROCESS | 11549 | Cycle 1(1): loaded http://localhost:53826/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53826/tests/dromaeo/cssquery-prototype.html) 02:19:50 INFO - PROCESS | 11549 | RSS: Main: 226054144 02:19:50 INFO - PROCESS | 11549 | 02:22:53 INFO - PROCESS | 11549 | Cycle 1(1): loaded http://localhost:53826/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53826/tests/dromaeo/cssquery-yui.html) 02:22:54 INFO - PROCESS | 11549 | RSS: Main: 221626368 02:22:54 INFO - PROCESS | 11549 | 02:25:56 INFO - PROCESS | 11549 | Cycle 1(1): loaded http://localhost:53826/tests/dromaeo/cssquery-yui.html (next: http://localhost:53826/tests/dromaeo/cssquery-dojo.html) 02:25:56 INFO - PROCESS | 11549 | RSS: Main: 268296192 02:25:56 INFO - PROCESS | 11549 | 02:25:56 INFO - PROCESS | 11549 | __start_tp_report 02:25:56 INFO - PROCESS | 11549 | _x_x_mozilla_page_load 02:25:56 INFO - PROCESS | 11549 | _x_x_mozilla_page_load_details 02:25:56 INFO - PROCESS | 11549 | |i|pagename|runs| 02:25:56 INFO - PROCESS | 11549 | |0;dojo.html;3043.923901902452;3065.3562751822114;3098.7211150996404;3100.0234925998316;3126.3434678717467;5039.874003149923;5160.277561141444;5182.844514664562;5192.766325515351;5236.162214045753;5277.102892508273;5282.07563676357;5292.2061690746405;5306.522412982831;5324.893502129955;4670.556297151765;4704.764761761915;4725.5510726480925;4737.099951009314;4825.276208568707;4767.11808315461;4789.497102804207;4802.495737947517;4803.519648035203;4835.323054772335;4549.317602359656;4623.190941585242;4627.213373726475;4718.433787945434;4719.339292499053;4669.392978912753;4671.953280467186;4705.694129881546;4763.476017638057;4788.3056956741075;4645.465771436295;4676.95323046772;4681.859544213645;4692.0381321828945;4718;4985.501449854985;5136.075506408845;5149.871253218699;5159.097157997336;5200.5059519345605;5573.247611572427;5583.553315734732;5599.524040456566;5645.661260324394;5653.23681303027;5575.135853942646;5576;5591.10542313228;5607.495325420691;5618.269624948731;5057.645964782503;5066.240063990431;5208;5222.216667499867;5228.032813929397;5702.6293290935955;5709.800156994568;5718.685472299064;5748.367679555246;5758.942410575841;5482.095454250084;5484.670919744828;5488.890222195534;5495.917561236584;5499.422560631157;5372.62391632582;5539.556835453154;5548.278723765965;5591.161325801162;5614.9719251403485;5531.585131115183;5532.5573954083575;5548.5838562108;5549.417311182348;5578.693171875505;5529.806456773994;5540.9168862467095;5544.944550554443;5549.1676248563035;5556.583256255797;4125.97937010313;4186.874393768192;4227.7463352198965;4273.508546517128;4277.486701595766;3765.3410653135593;3782.829772660182;3806.2197249563774;3833.0225792422752;3841.058940559525;5311.973440132774;5313.628046036818;5315.867103322371;5317.9202311965355;5362.973185134049;5396.514313711785;5533.6403133796175;5597.552195824324;5617.634853734576;5641.915371269434;5269.156934890476;5283.128283833202;5288.286081379041;5290.920636190383;5317.867053323698;4775.6657034007285;4795.992841503254;4799.616030717534;4810.470848206694;4841.515848415131;5564.137558678412;5725.427457254241;5763.510101641407;5829.387914268941;5851.093080572518;5627.099664053813;5639.548836093185;5642.6614403135945;5643;5646;5579.13523403873;5813.244278243801;5828.446297601721;5832.883342333214;5835.533157347317;5501.944980550144;5502.394736579053;5522.6134170607675;5575.7490912909825;5591.944080559142;5526.530244929226;5544.112941929272;5545.584081194007;5546.584006199632;5547.1679248113105;5298.523132917901;5408.188771684278;5437.4562543745305;5456.890862182813;5480.177973304037;5490.890182196414;5496.725163741877;5498.340199176125;5508.091164957737;5539.169124631338;5376.381716102698;5397.973010134924;5407.405185429679;5408.864778380572;5451.64564303319;5337.359516858002;5464.071107911744;5464.508194262536;5505.6696598204235;5508.614396992332;5212.713300768494;5313.468653134656;5350.30446042012;5382.973085134549;5408.675479471244 02:25:56 INFO - PROCESS | 11549 | |1;ext.html;566.4420545762426;639.8464368551549;651.6676494987557;651.7458191305391;666.8966310221916;28768;29215.707842921536;29319.853400732994;36890.81554592223;38265.617343826554;39761;40428;40430.19139617213;40471.190576188535;40627.796861015726;8305.418620696553;8483.830323393528;8500.489970601753;8501.447405918627;8504.617292221865;8379.706710265142;8500.44747091437;8502.404831661786;8503.659853605848;8503.702370417037;8459.4078414511;8496.235338819504;8506.191911768403;8684.2618377438;8707.869381959275;8621.094785047573;8692.478451292942;8693.217610415093;8696.782580435476;8703.651853925836;8649.870251946226;8749.693760718344;8758.824823503557;8767.430117042435;8772.517511536864;39668;40196.59803401987;40201;40240.79879600583;40327.39508907369;3385.542951701538;3560.305740380627;3584.6415358464205;3587.443946188319;3693.445983102529;30689;31166.22084447884;31221.37557248842;31293.374132517223;31753.8412307937;4173.31140361843;4189.245935731567;4222.5566315536735;4331.6534677225745;4361.127774445124;279025;280093;280729.596352019;280904;281450;55816;56100;56330.155047674314;56338.718306408206;56420.71789641026;55158;64328;65688.67155664286;65803;66218.66890665516;15728.449504267524;15744.370225190863;15779.447719329997;15900.443484477988;15917.761233581505;11624.709382265342;12038.337891416057;12453;12624.621261362174;12642.810357844639;16990.915045424696;17469.7379539307;17520.474385768448;17621.47135585909;17757.378491752726;5611.607187496836;5922.170896074553;5968.492678122321;5996.850078747979;6010.939890601038;1033.850091736694;1112.8887111288807;1130.6099395708468;1140.3613976173203;1150.7813515432042;29982.700172998426;30058;31764.04707858768;32170.678293217235;32374.190645233586;1139.367650953712;1140.7889540435046;1176.4294317256124;1225.3199474291853;1235.932023738703;17058.48824535266;17108.230129644195;17285.13574321304;17372.47882563525;17383.391581294592;433183;440676;442833;444239;444473;55984.440155598735;56602.43397565972;56694.43305566974;56738.43261567414;56748.432515674314;1321.5506727712432;1381.9980514127178;1408.7323408552547;1416.6387571169287;1418.6240646228757;27776.305592359546;30736.538951915292;31685.84157079292;31967.36065278635;32242.83878580592;45773.77113114413;46049.30926036045;46193.30710039285;46254.537454625024;46276.30585541152;282435;284249;285075;285766;286445;34966.30067398689;35590.8220458896;39464.210715786096;40004.79997599994;40258.19483610253;43975.340369893835;44201.65973035663;44450.55549444464;44981.32528012017;45350;39192.804035979636;39242.290925089175;39975.80012100037;40100.3984940232;40845.38731919083;38369;38780.6121938777;38827.2234555313;39032;40065.39901901532;41806.58193418027;41958.370624440046;42481.36277955895;43748.56251437445;43836;34088.318233634694;36104.42363897537;36496.63503365039;36649.63350366569;37101.25797484089;28579.142625721262;28722.856385717936;28994.27514312159;29028.27429314284;29076 02:25:56 INFO - PROCESS | 11549 | |2;jquery.html;395.5589517687779;395.6261333040278;403.7052951345517;405.6916743275111;412.90709590342175;13131.277779722112;14372.784408233885;16705.74941375879;17703.55741106473;17736.46790596281;16994.49016529503;17500.737488937677;17805.821941780578;17829.73255401167;18419.447416577492;5507.146392309189;5601.971990140064;5659.6321239119325;5682.6306290091015;5699.2590963174725;5409.459054094598;5542.722863856811;5607.607467477278;5611.579131565129;5628.802991895284;5551.361593416768;5552.5280351169995;5560.2493663355335;5570.637908535952;5623.606347555673;5417.64785288957;5554.972225138848;5611.494965453129;5616.410276920926;5618.381977982439;4856.975715121437;4956.925646115275;5028.547430731252;5046.09170349337;5047.242913562958;19627;22553.323400298017;22911.31266062021;23011.309660710205;23164.65253021206;2260.604394231003;2402.2793162051316;2557.83374080686;2681.5441374966304;3004.459197344477;13913.652158696012;13977.58067257984;14160.645983850487;14195.432182712679;14622.780658290134;1949.3079956615481;1960.4216756056996;1966;2006.809353111452;2052.445839623308;74918.25081749221;76468;76657.23342766556;76957.845632315;77267.61366193133;10271.845922311171;10364.378137311785;10610.469476526143;10720.517576709066;10751.139908807276;14688.485902993343;14695.26523673812;14696.26518674062;14769.926150369394;14786.408543658134;7898.881516777253;8135.471194372347;8213.589320533949;8334.083250842403;8341.16588341161;7815.3356964657505;7817.179196184319;7929.135030519555;8017.078036025931;8044.235797599219;6576.934230657728;6605.273419923805;6608.669566521655;6656.434203092695;6695;1922.4905400068992;1939.7187407826068;1973.9013049347761;1980.386080315107;2004.6592079346547;918.3800934369274;989;995.0845222395413;1069.9995504203594;1078.6440474643348;18937.810621893605;19495.12271947766;19705.408837734893;19752.407427776903;19793.30723424673;1063.9148868090533;1064.8562444070105;1120.966371008871;1144.250515912079;1151.6084531259412;10767.730806729738;11153.442327883573;11189.72025699364;11247;11298.37858917751;507155;521559;525109;537090;544941;89886;97126;97972.51013745028;98377.50811245898;99760.501197495;1068.1081297116993;1119.6920846767366;1126.2622981946838;1155.9884401156048;1165.5454372794618;17095.48713538596;17328.39350622722;17330.39343622967;17522.91238543799;17609.647807044043;38849.22301553896;38872.8338149856;39299.41050884182;39752.204955901296;40024.59975400209;54362;54535.45464545462;54616;54678.453215467336;55694.72152639211;7106.609136497542;7393.186749457663;8151.755447336589;8696.652133914826;8855.114488551093;8395.874061889199;10743.818180000037;13502.324883755577;13720.725585488433;13885.722285554435;10768.3538987661;10947.616833410792;11194;11267.549298028314;11329.943350283196;11456.828147577626;11538.250013749079;11571.884281157081;11613.070954323464;11639.6508104757;11338.206325557132;11403.600873969372;11509.07927365792;11653.126015548698;11684.824727628922;7694.192109828387;7754.612269386395;7818;7864.72473463426;7877.7636670899965;11077.723056923642;11107.944460277648;11217.775644487228;11247.100231981585;11422.25755325901 02:25:56 INFO - PROCESS | 11549 | |3;mootools.html;1227.7851376009196;1455.1123814473174;1502.384022550754;1616.6362568422107;1783.8840475369093;8114.188581141882;8421.621027053781;8432.494050356983;8439.831203375928;8441.240288374045;8209.917900821005;8320.625571849267;8331.791705207374;8353.665853365857;8364.414490985619;2048.0886005727457;2298.528801595669;2362.9527409451803;2379.4527258730504;2391.772781585755;2380.2502211803226;2400.939976500593;2403.975960240393;2405.9639105413435;2407.2296865003204;2321.4080409495555;2358.0921345282018;2360.2565191964563;2360.6459031145296;2364.0425627620757;2026.7466566679166;2284.1662793080573;2340.6372012338115;2348.248560460653;2349.083857295656;2281.3726225288015;2290.9885450572806;2292.2435596253194;2304.5621331946877;2308.90764369425;8304.252617264416;8413.83172336556;8427.32581393487;8434.156584341577;8443.535605541692;5098.923516147261;5241.606879484016;5247.501487358733;5257.053730328539;5260.053190425722;3252.5283833844196;3295.505674148897;3318.776419798741;3333.233356328058;3359.6640335966454;1115.8047341715167;1131.9773604527863;1140.1847678909537;1161.506359797083;1167.6788883057143;12003.879961200364;12005.519779208822;12056.095792815573;12059.09556783236;12079.154459187772;4557.156925968707;4680.555347242007;4782.258749893772;4829.6860704054125;4858.58702010326;10076.445795481171;10116.190704743603;10119.59521619127;10129.645462408927;10146.695599132037;4611.377464042378;5315.654482458705;5324.840254792362;5356.1697936819855;5369.785208591691;4323.913521729548;4333.285007973649;4628.652851036186;4757.643176761757;4796.160671882407;3893.4938458000847;3932.8426862925735;3992.341263691458;4006.0385507477995;4054.9189016220103;1292.1084451728277;1301.323311877837;1311.1280998136324;1312.8293321868287;1332.6335257803987;800.6757263308253;855.9186877246651;892.9642814287486;957.6507753593768;989.8168838764851;6004.609700369462;6052.364501727343;6079.088136779518;6113.510919126459;6200.782972596027;461.8245066874566;466.2074473395174;470.1396444506545;471.54260367443527;472.6738550400213;4180.644645205191;4183.5398106208295;4197.265478541243;4250.171216612731;4261.722988005769;10329.483525823678;10794.838077428845;10864.565417383374;10865.239433239756;10880.564777408974;10598.682039538826;10711.517981690688;10725.78548429027;10733.141348692086;10744.247902646895;7646.273604007611;7965.920340796633;7991.120976692559;8062.475939064059;8097.2307630774985;6032.517398608188;6170.228721409824;6171.382861713792;6293.811185664437;6316.210473690789;9860.30977831545;9876.061774131445;9889.703308900744;10013.549390277309;10178.592856285963;9971.152452041657;10101.14140298083;10192.337498062601;10208.336458130494;10367.27429079957;6994.720211191496;7177.3899218567;7186.712531498891;7566.092068951761;7673.772196448765;7522.511036782592;8059.637316320663;8144.511329320259;8168.754937351889;8170;7160.892586611101;7245.601491917995;7317.5609463432365;7419.554826710415;7500.774976750707;6931.89602155958;7035.226125126334;7067.399271061811;7073.540219885691;7132.108486439195;6748.93251067483;6813.625250611264;6819.283975182733;6822.283660215606;6825.55633883796;4971.328870602567;5023.045621332081;5067.87330316745;5095.515925987025;5125.461826508312;5161.870953226049;5219.373675158853;5226.216067589892;5241.528262456245;5267.183586543939 02:25:56 INFO - PROCESS | 11549 | |4;prototype.html;325.6076427904377;338.1191994853407;339.6518568467321;340.8312885121865;345.5404312264688;5430.348358197022;5500.3949565547755;5530.861728456785;5668.206451096845;5673.255651270162;5616.663000219979;5623.915641265374;5630.042892708239;5655.434456554342;5674;4359.891002724933;4380.58384453478;4381.07997320563;4381.408509851161;4384.539623339551;4165.229432554987;4306.784660766949;4319.82720691172;4383.211022016036;4401.911961760763;4219.07180420307;4238.109996900655;4258.87223383299;4267.658587313008;4276.18752437036;4093.3246014407587;4240.809163587631;4245.87262382129;4253.936190957138;4267.445232119836;3724.1806802503675;3747.2318174774377;3770.26479836432;3773.2264885698364;3774.622537746231;5381.650192737459;5389.946100538984;5426.294581704353;5429.67421954684;5442.482964118402;4892.730899800509;4899.387576552931;4941.604671626261;4992.226204938241;5008.524190201925;5883.02930016551;5913.05391137416;5919;5923.778583031363;5928.814237152586;4120.546739858613;4132.91734165318;4149.522804877448;4153.709240353177;4156.2726522858375;5947.851303717398;6093.664848433335;6109.725062372248;6136.631802091889;6152.907706384408;4175.457190565207;4239.215745087169;4256.638185754246;4257.531671516131;4263.8081286342185;4264.0832221072;4307.633851122627;4321.870343889688;4323.524412314643;4324.221640104812;4821.927671084936;4958.7024778513405;4963.329950456714;4967.205247160509;4967.3542439482635;5645.548356131581;5852.356240813507;5910.763569457259;5917.7572709730575;5943.524518038546;1431.155618185255;1433.1114708880561;1452.1432354910653;1478.4529724001973;1480.3116550803713;968.7626531499827;991.980160396788;1000.5297510170209;1004.2769206171545;1009.3842755918884;5577.860553486195;5648.209250704905;5679.574031947538;5682.829515114553;5702.914456283159;5971.134185543159;6016.127661489147;6021.488173505301;6027.276726792813;6039.879202416015;5456.645318054393;5670.319561652628;5705.62913410627;5741.942580574141;5801.53587712982;3222.758293128025;3223.597050368704;3243.6918492743152;3268.9182770430452;3269.313444176702;6216.445888527868;6271.937280627227;6329.810105696836;6395.968020159962;6422.710978005907;6166.4758495527485;6166.9383306167265;6170.765846830652;6171.783987560503;6180.289266734383;6280.623162610258;6320.945692649907;6325.968370158212;6351.936480635227;6381.521385896076;5894.204282421818;6071.2714474263375;6085.665288409003;6086.786962456293;6089.908651370144;5987.31145918225;5994.580379373402;5997.070454079625;5997.6701281428195;6045.183900173421;6082.787102451393;6291.528135389773;6298.590591611531;6304.873902521832;6377.202849643794;4310.116426132573;4347.76087315188;4361.6074553290355;4371.469985505175;4380.27725425314;5861.706914654165;6067.089936509559;6070.666113363807;6071.241094863142;6072.056941778588;5557.860638569003;5848.473637372657;5942.970285148546;5943.405659434195;5954.702264886651;5900.203472531153;5940.435658612425;5941.405859414024;5946.07835785454;5952.166696662384;5628;5842.795502157574;5859.572150292127;5862.970685146547;5870.765169393348;5978.342382338026;5978.701064946648;5991.614737673201;6001.5798894077;6032.5521874748865;5821.592488525763;5824.475797178275;5851.502622277154;5852.239208902815;5864.912026319524 02:25:56 INFO - PROCESS | 11549 | |5;yui.html;729.686234918985;733.5232099135561;779.614091024942;814.88998985137;823.1603764160558;14677.999999999987;15037.62405939852;15061.62345941352;15071.321790519425;15105.6978860423;14287.499937502189;14397.784033239484;14529.854701452983;14552.854471455283;14560.635984100403;660.408934004066;767.57399643198;795.9811441355075;798.5807451088167;799.276654627563;800.4196957206037;800.5596921693075;801.210807354755;803.3492870774692;803.6544285957036;686.8900975843866;837.3803385494721;840.0885039731899;840.6721378662327;840.7099550655045;817.4768148385009;833.2833762963846;833.6498670558319;833.7123692326168;834.6661335465832;602.9095635654643;604.8336707405499;605.2132228103447;605.2464681471552;608.85996220869;15041.623959400993;15132.167730774803;15154.469593564172;15155.393784248618;15234.085954842745;13896.652583685387;13946.93026534871;14092.154470731788;14338.928305358511;14570.490032848906;11609.535618575246;11816.940915295454;11834.822477662841;11909.702257443547;12004.51981920731;3916.686665066788;3925.646691797752;3954.8022598869943;4016.7790771507557;4050.878473645766;55055.44944550583;55401;55814.720926395516;57180.42819571793;57583;10397.84403233952;10621.468926553642;10813.891861081445;10835.945820270848;10900;20233.291834785712;20252.594948100956;20254.898725506573;20280;20307.796922030888;7834.608269586498;7884.172161922916;8031.437799353989;8194.959025204955;8439.789005274795;4641.74470404131;4684.81260749573;4782.928256076161;4784.186688263004;4817;3311.850966706504;3418.8461519231696;3422.57217847769;3429.6227414984332;3430.622631510532;562.9774809007594;577.6014549960514;585.0814221671934;587.2747157260779;591.9940800592025;722.9457790665721;726.5313872552174;737.848741008092;742.8142964258827;755.8715018446877;8623.525706086226;8670.393072484992;8769.12308769118;8777.780555486037;9019.278457723367;620.8634100497883;631.1290419221446;654.5418207254845;743.7099531182843;762.272030211147;4197.345004810499;4208.452901122834;4212.368144778307;4275.273203555403;4328.788934222336;62040.68979655163;62713;62808;64170;64199.35800641934;55820.44179558234;55902;56498.43501564932;57128.42871571231;57167.71416142893;49639;50074.49925500698;50775.23837142446;50799.23801142986;51993.7400312996;8038.236367545074;8118.114055493478;8135.552544610104;8405.747827565183;8489.108643592333;33873.32253354968;33885.49171762475;34108;34986;35377.1155721109;42633;46423;47221.291680624134;47523.76238118787;48203.75898120487;10437.32157409766;10577;10727.463626818784;10756.784864302826;10817.40504272241;11567.88432115668;12097.69755756078;12713.745725085631;12731.363431828557;12864.807027894401;11617.419129043683;11841.526338946345;11884.10869184832;11954.342511161969;12309.26144431337;11445.713857153305;11466.598669046543;11485.712857178638;11487.885121148682;11513.078953683518;10982.162475281362;11020.173486988668;11112.833307500232;11393.772124557629;11420.200585959235;9524.14282714559;9615.663451779154;9695.224382049279;9974;10332.60727618935;9247.630094796134;9374;9497.43015419077;9504.204145969208;9590.760230994001 02:25:56 INFO - PROCESS | 11549 | __end_tp_report 02:25:56 INFO - PROCESS | 11549 | __start_cc_report 02:25:56 INFO - PROCESS | 11549 | _x_x_mozilla_cycle_collect,1022 02:25:56 INFO - PROCESS | 11549 | __end_cc_report 02:25:56 INFO - PROCESS | 11549 | __startTimestamp1460885156833__endTimestamp 02:25:56 INFO - PROCESS | 11549 | 02:25:56 INFO - PROCESS | 11549 | ------- Summary: start ------- 02:25:56 INFO - PROCESS | 11549 | Number of tests: 6 02:25:56 INFO - PROCESS | 11549 | 02:25:56 INFO - PROCESS | 11549 | [#0] dojo.html Cycles:165 Average:5176.54 Median:5382.97 stddev:587.22 (10.9%) stddev-sans-first:564.69 02:25:56 INFO - PROCESS | 11549 | Values: 3043.9 3065.4 3098.7 3100.0 3126.3 5039.9 5160.3 5182.8 5192.8 5236.2 5277.1 5282.1 5292.2 5306.5 5324.9 4670.6 4704.8 4725.6 4737.1 4825.3 4767.1 4789.5 4802.5 4803.5 4835.3 4549.3 4623.2 4627.2 4718.4 4719.3 4669.4 4672.0 4705.7 4763.5 4788.3 4645.5 4677.0 4681.9 4692.0 4718.0 4985.5 5136.1 5149.9 5159.1 5200.5 5573.2 5583.6 5599.5 5645.7 5653.2 5575.1 5576.0 5591.1 5607.5 5618.3 5057.6 5066.2 5208.0 5222.2 5228.0 5702.6 5709.8 5718.7 5748.4 5758.9 5482.1 5484.7 5488.9 5495.9 5499.4 5372.6 5539.6 5548.3 5591.2 5615.0 5531.6 5532.6 5548.6 5549.4 5578.7 5529.8 5540.9 5544.9 5549.2 5556.6 4126.0 4186.9 4227.7 4273.5 4277.5 3765.3 3782.8 3806.2 3833.0 3841.1 5312.0 5313.6 5315.9 5317.9 5363.0 5396.5 5533.6 5597.6 5617.6 5641.9 5269.2 5283.1 5288.3 5290.9 5317.9 4775.7 4796.0 4799.6 4810.5 4841.5 5564.1 5725.4 5763.5 5829.4 5851.1 5627.1 5639.5 5642.7 5643.0 5646.0 5579.1 5813.2 5828.4 5832.9 5835.5 5501.9 5502.4 5522.6 5575.7 5591.9 5526.5 5544.1 5545.6 5546.6 5547.2 5298.5 5408.2 5437.5 5456.9 5480.2 5490.9 5496.7 5498.3 5508.1 5539.2 5376.4 5398.0 5407.4 5408.9 5451.6 5337.4 5464.1 5464.5 5505.7 5508.6 5212.7 5313.5 5350.3 5383.0 5408.7 02:25:56 INFO - PROCESS | 11549 | 02:25:56 INFO - PROCESS | 11549 | [#1] ext.html Cycles:180 Average:50777.83 Median:39868.40 stddev:90500.84 (227.0%) stddev-sans-first:90676.19 02:25:56 INFO - PROCESS | 11549 | Values: 566.4 639.8 651.7 651.7 666.9 28768.0 29215.7 29319.9 36890.8 38265.6 39761.0 40428.0 40430.2 40471.2 40627.8 8305.4 8483.8 8500.5 8501.4 8504.6 8379.7 8500.4 8502.4 8503.7 8503.7 8459.4 8496.2 8506.2 8684.3 8707.9 8621.1 8692.5 8693.2 8696.8 8703.7 8649.9 8749.7 8758.8 8767.4 8772.5 39668.0 40196.6 40201.0 40240.8 40327.4 3385.5 3560.3 3584.6 3587.4 3693.4 30689.0 31166.2 31221.4 31293.4 31753.8 4173.3 4189.2 4222.6 4331.7 4361.1 279025.0 280093.0 280729.6 280904.0 281450.0 55816.0 56100.0 56330.2 56338.7 56420.7 55158.0 64328.0 65688.7 65803.0 66218.7 15728.4 15744.4 15779.4 15900.4 15917.8 11624.7 12038.3 12453.0 12624.6 12642.8 16990.9 17469.7 17520.5 17621.5 17757.4 5611.6 5922.2 5968.5 5996.9 6010.9 1033.9 1112.9 1130.6 1140.4 1150.8 29982.7 30058.0 31764.0 32170.7 32374.2 1139.4 1140.8 1176.4 1225.3 1235.9 17058.5 17108.2 17285.1 17372.5 17383.4 433183.0 440676.0 442833.0 444239.0 444473.0 55984.4 56602.4 56694.4 56738.4 56748.4 1321.6 1382.0 1408.7 1416.6 1418.6 27776.3 30736.5 31685.8 31967.4 32242.8 45773.8 46049.3 46193.3 46254.5 46276.3 282435.0 284249.0 285075.0 285766.0 286445.0 34966.3 35590.8 39464.2 40004.8 40258.2 43975.3 44201.7 44450.6 44981.3 45350.0 39192.8 39242.3 39975.8 40100.4 40845.4 38369.0 38780.6 38827.2 39032.0 40065.4 41806.6 41958.4 42481.4 43748.6 43836.0 34088.3 36104.4 36496.6 36649.6 37101.3 28579.1 28722.9 28994.3 29028.3 29076.0 02:25:56 INFO - PROCESS | 11549 | 02:25:56 INFO - PROCESS | 11549 | [#2] jquery.html Cycles:180 Average:29758.12 Median:23087.98 stddev:86760.70 (375.8%) stddev-sans-first:86976.08 02:25:56 INFO - PROCESS | 11549 | Values: 395.6 395.6 403.7 405.7 412.9 13131.3 14372.8 16705.7 17703.6 17736.5 16994.5 17500.7 17805.8 17829.7 18419.4 5507.1 5602.0 5659.6 5682.6 5699.3 5409.5 5542.7 5607.6 5611.6 5628.8 5551.4 5552.5 5560.2 5570.6 5623.6 5417.6 5555.0 5611.5 5616.4 5618.4 4857.0 4956.9 5028.5 5046.1 5047.2 19627.0 22553.3 22911.3 23011.3 23164.7 2260.6 2402.3 2557.8 2681.5 3004.5 13913.7 13977.6 14160.6 14195.4 14622.8 1949.3 1960.4 1966.0 2006.8 2052.4 74918.3 76468.0 76657.2 76957.8 77267.6 10271.8 10364.4 10610.5 10720.5 10751.1 14688.5 14695.3 14696.3 14769.9 14786.4 7898.9 8135.5 8213.6 8334.1 8341.2 7815.3 7817.2 7929.1 8017.1 8044.2 6576.9 6605.3 6608.7 6656.4 6695.0 1922.5 1939.7 1973.9 1980.4 2004.7 918.4 989.0 995.1 1070.0 1078.6 18937.8 19495.1 19705.4 19752.4 19793.3 1063.9 1064.9 1121.0 1144.3 1151.6 10767.7 11153.4 11189.7 11247.0 11298.4 507155.0 521559.0 525109.0 537090.0 544941.0 89886.0 97126.0 97972.5 98377.5 99760.5 1068.1 1119.7 1126.3 1156.0 1165.5 17095.5 17328.4 17330.4 17522.9 17609.6 38849.2 38872.8 39299.4 39752.2 40024.6 54362.0 54535.5 54616.0 54678.5 55694.7 7106.6 7393.2 8151.8 8696.7 8855.1 8395.9 10743.8 13502.3 13720.7 13885.7 10768.4 10947.6 11194.0 11267.5 11329.9 11456.8 11538.3 11571.9 11613.1 11639.7 11338.2 11403.6 11509.1 11653.1 11684.8 7694.2 7754.6 7818.0 7864.7 7877.8 11077.7 11107.9 11217.8 11247.1 11422.3 02:25:56 INFO - PROCESS | 11549 | 02:25:56 INFO - PROCESS | 11549 | [#3] mootools.html Cycles:180 Average:5667.96 Median:472.11 stddev:3208.13 (679.5%) stddev-sans-first:3199.77 02:25:56 INFO - PROCESS | 11549 | Values: 1227.8 1455.1 1502.4 1616.6 1783.9 8114.2 8421.6 8432.5 8439.8 8441.2 8209.9 8320.6 8331.8 8353.7 8364.4 2048.1 2298.5 2363.0 2379.5 2391.8 2380.3 2400.9 2404.0 2406.0 2407.2 2321.4 2358.1 2360.3 2360.6 2364.0 2026.7 2284.2 2340.6 2348.2 2349.1 2281.4 2291.0 2292.2 2304.6 2308.9 8304.3 8413.8 8427.3 8434.2 8443.5 5098.9 5241.6 5247.5 5257.1 5260.1 3252.5 3295.5 3318.8 3333.2 3359.7 1115.8 1132.0 1140.2 1161.5 1167.7 12003.9 12005.5 12056.1 12059.1 12079.2 4557.2 4680.6 4782.3 4829.7 4858.6 10076.4 10116.2 10119.6 10129.6 10146.7 4611.4 5315.7 5324.8 5356.2 5369.8 4323.9 4333.3 4628.7 4757.6 4796.2 3893.5 3932.8 3992.3 4006.0 4054.9 1292.1 1301.3 1311.1 1312.8 1332.6 800.7 855.9 893.0 957.7 989.8 6004.6 6052.4 6079.1 6113.5 6200.8 461.8 466.2 470.1 471.5 472.7 4180.6 4183.5 4197.3 4250.2 4261.7 10329.5 10794.8 10864.6 10865.2 10880.6 10598.7 10711.5 10725.8 10733.1 10744.2 7646.3 7965.9 7991.1 8062.5 8097.2 6032.5 6170.2 6171.4 6293.8 6316.2 9860.3 9876.1 9889.7 10013.5 10178.6 9971.2 10101.1 10192.3 10208.3 10367.3 6994.7 7177.4 7186.7 7566.1 7673.8 7522.5 8059.6 8144.5 8168.8 8170.0 7160.9 7245.6 7317.6 7419.6 7500.8 6931.9 7035.2 7067.4 7073.5 7132.1 6748.9 6813.6 6819.3 6822.3 6825.6 4971.3 5023.0 5067.9 5095.5 5125.5 5161.9 5219.4 5226.2 5241.5 5267.2 02:25:56 INFO - PROCESS | 11549 | 02:25:56 INFO - PROCESS | 11549 | [#4] prototype.html Cycles:180 Average:4953.34 Median:5661.82 stddev:1480.42 (26.1%) stddev-sans-first:1443.25 02:25:56 INFO - PROCESS | 11549 | Values: 325.6 338.1 339.7 340.8 345.5 5430.3 5500.4 5530.9 5668.2 5673.3 5616.7 5623.9 5630.0 5655.4 5674.0 4359.9 4380.6 4381.1 4381.4 4384.5 4165.2 4306.8 4319.8 4383.2 4401.9 4219.1 4238.1 4258.9 4267.7 4276.2 4093.3 4240.8 4245.9 4253.9 4267.4 3724.2 3747.2 3770.3 3773.2 3774.6 5381.7 5389.9 5426.3 5429.7 5442.5 4892.7 4899.4 4941.6 4992.2 5008.5 5883.0 5913.1 5919.0 5923.8 5928.8 4120.5 4132.9 4149.5 4153.7 4156.3 5947.9 6093.7 6109.7 6136.6 6152.9 4175.5 4239.2 4256.6 4257.5 4263.8 4264.1 4307.6 4321.9 4323.5 4324.2 4821.9 4958.7 4963.3 4967.2 4967.4 5645.5 5852.4 5910.8 5917.8 5943.5 1431.2 1433.1 1452.1 1478.5 1480.3 968.8 992.0 1000.5 1004.3 1009.4 5577.9 5648.2 5679.6 5682.8 5702.9 5971.1 6016.1 6021.5 6027.3 6039.9 5456.6 5670.3 5705.6 5741.9 5801.5 3222.8 3223.6 3243.7 3268.9 3269.3 6216.4 6271.9 6329.8 6396.0 6422.7 6166.5 6166.9 6170.8 6171.8 6180.3 6280.6 6320.9 6326.0 6351.9 6381.5 5894.2 6071.3 6085.7 6086.8 6089.9 5987.3 5994.6 5997.1 5997.7 6045.2 6082.8 6291.5 6298.6 6304.9 6377.2 4310.1 4347.8 4361.6 4371.5 4380.3 5861.7 6067.1 6070.7 6071.2 6072.1 5557.9 5848.5 5943.0 5943.4 5954.7 5900.2 5940.4 5941.4 5946.1 5952.2 5628.0 5842.8 5859.6 5863.0 5870.8 5978.3 5978.7 5991.6 6001.6 6032.6 5821.6 5824.5 5851.5 5852.2 5864.9 02:25:56 INFO - PROCESS | 11549 | 02:25:56 INFO - PROCESS | 11549 | [#5] yui.html Cycles:180 Average:14831.58 Median:48921.38 stddev:17531.38 (35.8%) stddev-sans-first:17548.57 02:25:56 INFO - PROCESS | 11549 | Values: 729.7 733.5 779.6 814.9 823.2 14678.0 15037.6 15061.6 15071.3 15105.7 14287.5 14397.8 14529.9 14552.9 14560.6 660.4 767.6 796.0 798.6 799.3 800.4 800.6 801.2 803.3 803.7 686.9 837.4 840.1 840.7 840.7 817.5 833.3 833.6 833.7 834.7 602.9 604.8 605.2 605.2 608.9 15041.6 15132.2 15154.5 15155.4 15234.1 13896.7 13946.9 14092.2 14338.9 14570.5 11609.5 11816.9 11834.8 11909.7 12004.5 3916.7 3925.6 3954.8 4016.8 4050.9 55055.4 55401.0 55814.7 57180.4 57583.0 10397.8 10621.5 10813.9 10835.9 10900.0 20233.3 20252.6 20254.9 20280.0 20307.8 7834.6 7884.2 8031.4 8195.0 8439.8 4641.7 4684.8 4782.9 4784.2 4817.0 3311.9 3418.8 3422.6 3429.6 3430.6 563.0 577.6 585.1 587.3 592.0 722.9 726.5 737.8 742.8 755.9 8623.5 8670.4 8769.1 8777.8 9019.3 620.9 631.1 654.5 743.7 762.3 4197.3 4208.5 4212.4 4275.3 4328.8 62040.7 62713.0 62808.0 64170.0 64199.4 55820.4 55902.0 56498.4 57128.4 57167.7 49639.0 50074.5 50775.2 50799.2 51993.7 8038.2 8118.1 8135.6 8405.7 8489.1 33873.3 33885.5 34108.0 34986.0 35377.1 42633.0 46423.0 47221.3 47523.8 48203.8 10437.3 10577.0 10727.5 10756.8 10817.4 11567.9 12097.7 12713.7 12731.4 12864.8 11617.4 11841.5 11884.1 11954.3 12309.3 11445.7 11466.6 11485.7 11487.9 11513.1 10982.2 11020.2 11112.8 11393.8 11420.2 9524.1 9615.7 9695.2 9974.0 10332.6 9247.6 9374.0 9497.4 9504.2 9590.8 02:25:56 INFO - PROCESS | 11549 | -------- Summary: end -------- 02:25:56 INFO - PROCESS | 11549 | 02:25:57 INFO - TEST-INFO | 11549: exit 0 02:25:57 INFO - TEST-OK | dromaeo_css | took 1112367ms 02:25:57 INFO - TEST-START | kraken 02:25:57 INFO - operating with platform_type : linux_ 02:25:57 INFO - Initialising browser for kraken test... 02:25:57 INFO - TEST-INFO | started process 11730 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXDIGMW/profile http://localhost:53826/getInfo.html) 02:26:01 INFO - PROCESS | 11730 | __metrics Screen width/height:1600/1200 02:26:01 INFO - PROCESS | 11730 | colorDepth:24 02:26:01 INFO - PROCESS | 11730 | Browser inner width/height: 1024/697 02:26:01 INFO - PROCESS | 11730 | __metrics 02:26:02 ERROR - PROCESS | 11730 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 02:26:03 INFO - TEST-INFO | 11730: exit 0 02:26:03 INFO - Browser initialized. 02:26:03 INFO - Running cycle 1/1 for kraken test... 02:26:03 INFO - TEST-INFO | started process 11812 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXDIGMW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:26:15 INFO - PROCESS | 11812 | RSS: Main: 152887296 02:26:15 INFO - PROCESS | 11812 | 02:26:17 INFO - PROCESS | 11812 | Cycle 1(1): loaded http://localhost:53826/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53826/tests/kraken/driver.html?testName=audio-beat-detection) 02:26:18 INFO - PROCESS | 11812 | RSS: Main: 208580608 02:26:18 INFO - PROCESS | 11812 | 02:26:21 INFO - PROCESS | 11812 | Cycle 1(1): loaded http://localhost:53826/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53826/tests/kraken/driver.html?testName=audio-dft) 02:26:21 INFO - PROCESS | 11812 | RSS: Main: 193847296 02:26:21 INFO - PROCESS | 11812 | 02:26:24 INFO - PROCESS | 11812 | Cycle 1(1): loaded http://localhost:53826/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53826/tests/kraken/driver.html?testName=audio-fft) 02:26:25 INFO - PROCESS | 11812 | RSS: Main: 264601600 02:26:25 INFO - PROCESS | 11812 | 02:26:27 INFO - PROCESS | 11812 | Cycle 1(1): loaded http://localhost:53826/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53826/tests/kraken/driver.html?testName=audio-oscillator) 02:26:27 INFO - PROCESS | 11812 | RSS: Main: 172924928 02:26:27 INFO - PROCESS | 11812 | 02:26:30 INFO - PROCESS | 11812 | Cycle 1(1): loaded http://localhost:53826/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53826/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:26:30 INFO - PROCESS | 11812 | RSS: Main: 176824320 02:26:30 INFO - PROCESS | 11812 | 02:26:33 INFO - PROCESS | 11812 | Cycle 1(1): loaded http://localhost:53826/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53826/tests/kraken/driver.html?testName=imaging-darkroom) 02:26:34 INFO - PROCESS | 11812 | RSS: Main: 213061632 02:26:34 INFO - PROCESS | 11812 | 02:26:37 INFO - PROCESS | 11812 | Cycle 1(1): loaded http://localhost:53826/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53826/tests/kraken/driver.html?testName=imaging-desaturate) 02:26:38 INFO - PROCESS | 11812 | RSS: Main: 213823488 02:26:38 INFO - PROCESS | 11812 | 02:26:41 INFO - PROCESS | 11812 | Cycle 1(1): loaded http://localhost:53826/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53826/tests/kraken/driver.html?testName=json-parse-financial) 02:26:41 INFO - PROCESS | 11812 | RSS: Main: 214446080 02:26:41 INFO - PROCESS | 11812 | 02:26:43 INFO - PROCESS | 11812 | Cycle 1(1): loaded http://localhost:53826/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53826/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:26:43 INFO - PROCESS | 11812 | RSS: Main: 203878400 02:26:43 INFO - PROCESS | 11812 | 02:26:45 INFO - PROCESS | 11812 | Cycle 1(1): loaded http://localhost:53826/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53826/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:26:46 INFO - PROCESS | 11812 | RSS: Main: 206741504 02:26:46 INFO - PROCESS | 11812 | 02:26:48 INFO - PROCESS | 11812 | Cycle 1(1): loaded http://localhost:53826/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53826/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:26:48 INFO - PROCESS | 11812 | RSS: Main: 220295168 02:26:48 INFO - PROCESS | 11812 | 02:26:51 INFO - PROCESS | 11812 | Cycle 1(1): loaded http://localhost:53826/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53826/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:26:51 INFO - PROCESS | 11812 | RSS: Main: 222363648 02:26:51 INFO - PROCESS | 11812 | 02:26:54 INFO - PROCESS | 11812 | Cycle 1(1): loaded http://localhost:53826/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53826/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:26:55 INFO - PROCESS | 11812 | RSS: Main: 216449024 02:26:55 INFO - PROCESS | 11812 | 02:26:57 INFO - PROCESS | 11812 | Cycle 1(1): loaded http://localhost:53826/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53826/tests/kraken/driver.html?testName=ai-astar) 02:26:57 INFO - PROCESS | 11812 | RSS: Main: 279404544 02:26:57 INFO - PROCESS | 11812 | 02:26:57 INFO - PROCESS | 11812 | __start_tp_report 02:26:57 INFO - PROCESS | 11812 | _x_x_mozilla_page_load 02:26:57 INFO - PROCESS | 11812 | _x_x_mozilla_page_load_details 02:26:57 INFO - PROCESS | 11812 | |i|pagename|runs| 02:26:57 INFO - PROCESS | 11812 | |0;ai-astar;108;111;104;108;109;110;99;109;109;109 02:26:57 INFO - PROCESS | 11812 | |1;audio-beat-detection;148;122;162;185;127;160;161;127;179;136 02:26:57 INFO - PROCESS | 11812 | |2;audio-dft;162;161;159;162;162;161;159;161;161;161 02:26:57 INFO - PROCESS | 11812 | |3;audio-fft;72;72;97;106;77;75;76;108;105;73 02:26:57 INFO - PROCESS | 11812 | |4;audio-oscillator;92;93;159;92;95;92;155;92;92;152 02:26:57 INFO - PROCESS | 11812 | |5;imaging-gaussian-blur;117;117;117;117;117;116;117;117;117;116 02:26:57 INFO - PROCESS | 11812 | |6;imaging-darkroom;146;145;145;146;145;145;145;146;145;145 02:26:57 INFO - PROCESS | 11812 | |7;imaging-desaturate;95;95;94;95;95;94;95;94;94;94 02:26:57 INFO - PROCESS | 11812 | |8;json-parse-financial;58;58;59;57;60;58;58;75;57;55 02:26:57 INFO - PROCESS | 11812 | |9;json-stringify-tinderbox;61;61;60;61;61;60;60;60;59;60 02:26:57 INFO - PROCESS | 11812 | |10;stanford-crypto-aes;82;75;75;75;76;76;85;76;80;77 02:26:57 INFO - PROCESS | 11812 | |11;stanford-crypto-ccm;128;133;122;126;126;129;122;121;153;124 02:26:57 INFO - PROCESS | 11812 | |12;stanford-crypto-pbkdf2;164;164;169;167;164;163;165;168;164;170 02:26:57 INFO - PROCESS | 11812 | |13;stanford-crypto-sha256-iterative;66;71;66;69;67;67;68;66;68;68 02:26:57 INFO - PROCESS | 11812 | __end_tp_report 02:26:57 INFO - PROCESS | 11812 | __start_cc_report 02:26:57 INFO - PROCESS | 11812 | _x_x_mozilla_cycle_collect,1618 02:26:57 INFO - PROCESS | 11812 | __end_cc_report 02:26:57 INFO - PROCESS | 11812 | __startTimestamp1460885217277__endTimestamp 02:26:57 INFO - PROCESS | 11812 | 02:26:57 INFO - PROCESS | 11812 | ------- Summary: start ------- 02:26:57 INFO - PROCESS | 11812 | Number of tests: 14 02:26:57 INFO - PROCESS | 11812 | 02:26:57 INFO - PROCESS | 11812 | [#0] ai-astar Cycles:10 Average:107.60 Median:109.00 stddev:3.53 (3.2%) stddev-sans-first:3.75 02:26:57 INFO - PROCESS | 11812 | Values: 108.0 111.0 104.0 108.0 109.0 110.0 99.0 109.0 109.0 109.0 02:26:57 INFO - PROCESS | 11812 | 02:26:57 INFO - PROCESS | 11812 | [#1] audio-beat-detection Cycles:10 Average:150.70 Median:160.50 stddev:22.28 (13.9%) stddev-sans-first:23.61 02:26:57 INFO - PROCESS | 11812 | Values: 148.0 122.0 162.0 185.0 127.0 160.0 161.0 127.0 179.0 136.0 02:26:57 INFO - PROCESS | 11812 | 02:26:57 INFO - PROCESS | 11812 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:1.10 (0.7%) stddev-sans-first:1.09 02:26:57 INFO - PROCESS | 11812 | Values: 162.0 161.0 159.0 162.0 162.0 161.0 159.0 161.0 161.0 161.0 02:26:57 INFO - PROCESS | 11812 | 02:26:57 INFO - PROCESS | 11812 | [#3] audio-fft Cycles:10 Average:86.10 Median:74.00 stddev:15.74 (21.3%) stddev-sans-first:15.84 02:26:57 INFO - PROCESS | 11812 | Values: 72.0 72.0 97.0 106.0 77.0 75.0 76.0 108.0 105.0 73.0 02:26:57 INFO - PROCESS | 11812 | 02:26:57 INFO - PROCESS | 11812 | [#4] audio-oscillator Cycles:10 Average:111.40 Median:92.00 stddev:30.38 (33.0%) stddev-sans-first:31.40 02:26:57 INFO - PROCESS | 11812 | Values: 92.0 93.0 159.0 92.0 95.0 92.0 155.0 92.0 92.0 152.0 02:26:57 INFO - PROCESS | 11812 | 02:26:57 INFO - PROCESS | 11812 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 02:26:57 INFO - PROCESS | 11812 | Values: 117.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 116.0 02:26:57 INFO - PROCESS | 11812 | 02:26:57 INFO - PROCESS | 11812 | [#6] imaging-darkroom Cycles:10 Average:145.30 Median:145.00 stddev:0.48 (0.3%) stddev-sans-first:0.44 02:26:57 INFO - PROCESS | 11812 | Values: 146.0 145.0 145.0 146.0 145.0 145.0 145.0 146.0 145.0 145.0 02:26:57 INFO - PROCESS | 11812 | 02:26:57 INFO - PROCESS | 11812 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:95.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 02:26:57 INFO - PROCESS | 11812 | Values: 95.0 95.0 94.0 95.0 95.0 94.0 95.0 94.0 94.0 94.0 02:26:57 INFO - PROCESS | 11812 | 02:26:57 INFO - PROCESS | 11812 | [#8] json-parse-financial Cycles:10 Average:59.50 Median:58.00 stddev:5.60 (9.7%) stddev-sans-first:5.92 02:26:57 INFO - PROCESS | 11812 | Values: 58.0 58.0 59.0 57.0 60.0 58.0 58.0 75.0 57.0 55.0 02:26:57 INFO - PROCESS | 11812 | 02:26:57 INFO - PROCESS | 11812 | [#9] json-stringify-tinderbox Cycles:10 Average:60.30 Median:60.50 stddev:0.67 (1.1%) stddev-sans-first:0.67 02:26:57 INFO - PROCESS | 11812 | Values: 61.0 61.0 60.0 61.0 61.0 60.0 60.0 60.0 59.0 60.0 02:26:57 INFO - PROCESS | 11812 | 02:26:57 INFO - PROCESS | 11812 | [#10] stanford-crypto-aes Cycles:10 Average:77.70 Median:76.50 stddev:3.47 (4.5%) stddev-sans-first:3.31 02:26:57 INFO - PROCESS | 11812 | Values: 82.0 75.0 75.0 75.0 76.0 76.0 85.0 76.0 80.0 77.0 02:26:57 INFO - PROCESS | 11812 | 02:26:57 INFO - PROCESS | 11812 | [#11] stanford-crypto-ccm Cycles:10 Average:128.40 Median:127.00 stddev:9.40 (7.4%) stddev-sans-first:9.96 02:26:57 INFO - PROCESS | 11812 | Values: 128.0 133.0 122.0 126.0 126.0 129.0 122.0 121.0 153.0 124.0 02:26:57 INFO - PROCESS | 11812 | 02:26:57 INFO - PROCESS | 11812 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.80 Median:166.00 stddev:2.49 (1.5%) stddev-sans-first:2.55 02:26:57 INFO - PROCESS | 11812 | Values: 164.0 164.0 169.0 167.0 164.0 163.0 165.0 168.0 164.0 170.0 02:26:57 INFO - PROCESS | 11812 | 02:26:57 INFO - PROCESS | 11812 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.60 Median:68.00 stddev:1.58 (2.3%) stddev-sans-first:1.56 02:26:57 INFO - PROCESS | 11812 | Values: 66.0 71.0 66.0 69.0 67.0 67.0 68.0 66.0 68.0 68.0 02:26:57 INFO - PROCESS | 11812 | -------- Summary: end -------- 02:26:57 INFO - PROCESS | 11812 | 02:26:58 INFO - TEST-INFO | 11812: exit 0 02:26:58 INFO - TEST-OK | kraken | took 60689ms 02:26:58 INFO - SUITE-END | took 1173s 02:26:58 INFO - Completed test suite (00:19:33) 02:26:58 INFO - javascript benchmark 02:26:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3043.923901902452, 3065.3562751822114, 3098.7211150996404, 3100.0234925998316, 3126.3434678717467, 5039.874003149923, 5160.277561141444, 5182.844514664562, 5192.766325515351, 5236.162214045753, 5277.102892508273, 5282.07563676357, 5292.2061690746405, 5306.522412982831, 5324.893502129955, 4670.556297151765, 4704.764761761915, 4725.5510726480925, 4737.099951009314, 4825.276208568707, 4767.11808315461, 4789.497102804207, 4802.495737947517, 4803.519648035203, 4835.323054772335, 4549.317602359656, 4623.190941585242, 4627.213373726475, 4718.433787945434, 4719.339292499053, 4669.392978912753, 4671.953280467186, 4705.694129881546, 4763.476017638057, 4788.3056956741075, 4645.465771436295, 4676.95323046772, 4681.859544213645, 4692.0381321828945, 4718.0, 4985.501449854985, 5136.075506408845, 5149.871253218699, 5159.097157997336, 5200.5059519345605, 5573.247611572427, 5583.553315734732, 5599.524040456566, 5645.661260324394, 5653.23681303027, 5575.135853942646, 5576.0, 5591.10542313228, 5607.495325420691, 5618.269624948731, 5057.645964782503, 5066.240063990431, 5208.0, 5222.216667499867, 5228.032813929397, 5702.6293290935955, 5709.800156994568, 5718.685472299064, 5748.367679555246, 5758.942410575841, 5482.095454250084, 5484.670919744828, 5488.890222195534, 5495.917561236584, 5499.422560631157, 5372.62391632582, 5539.556835453154, 5548.278723765965, 5591.161325801162, 5614.9719251403485, 5531.585131115183, 5532.5573954083575, 5548.5838562108, 5549.417311182348, 5578.693171875505, 5529.806456773994, 5540.9168862467095, 5544.944550554443, 5549.1676248563035, 5556.583256255797, 4125.97937010313, 4186.874393768192, 4227.7463352198965, 4273.508546517128, 4277.486701595766, 3765.3410653135593, 3782.829772660182, 3806.2197249563774, 3833.0225792422752, 3841.058940559525, 5311.973440132774, 5313.628046036818, 5315.867103322371, 5317.9202311965355, 5362.973185134049, 5396.514313711785, 5533.6403133796175, 5597.552195824324, 5617.634853734576, 5641.915371269434, 5269.156934890476, 5283.128283833202, 5288.286081379041, 5290.920636190383, 5317.867053323698, 4775.6657034007285, 4795.992841503254, 4799.616030717534, 4810.470848206694, 4841.515848415131, 5564.137558678412, 5725.427457254241, 5763.510101641407, 5829.387914268941, 5851.093080572518, 5627.099664053813, 5639.548836093185, 5642.6614403135945, 5643.0, 5646.0, 5579.13523403873, 5813.244278243801, 5828.446297601721, 5832.883342333214, 5835.533157347317, 5501.944980550144, 5502.394736579053, 5522.6134170607675, 5575.7490912909825, 5591.944080559142, 5526.530244929226, 5544.112941929272, 5545.584081194007, 5546.584006199632, 5547.1679248113105, 5298.523132917901, 5408.188771684278, 5437.4562543745305, 5456.890862182813, 5480.177973304037, 5490.890182196414, 5496.725163741877, 5498.340199176125, 5508.091164957737, 5539.169124631338, 5376.381716102698, 5397.973010134924, 5407.405185429679, 5408.864778380572, 5451.64564303319, 5337.359516858002, 5464.071107911744, 5464.508194262536, 5505.6696598204235, 5508.614396992332, 5212.713300768494, 5313.468653134656, 5350.30446042012, 5382.973085134549, 5408.675479471244], "value": 5137.460181458002, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [566.4420545762426, 639.8464368551549, 651.6676494987557, 651.7458191305391, 666.8966310221916, 28768.0, 29215.707842921536, 29319.853400732994, 36890.81554592223, 38265.617343826554, 39761.0, 40428.0, 40430.19139617213, 40471.190576188535, 40627.796861015726, 8305.418620696553, 8483.830323393528, 8500.489970601753, 8501.447405918627, 8504.617292221865, 8379.706710265142, 8500.44747091437, 8502.404831661786, 8503.659853605848, 8503.702370417037, 8459.4078414511, 8496.235338819504, 8506.191911768403, 8684.2618377438, 8707.869381959275, 8621.094785047573, 8692.478451292942, 8693.217610415093, 8696.782580435476, 8703.651853925836, 8649.870251946226, 8749.693760718344, 8758.824823503557, 8767.430117042435, 8772.517511536864, 39668.0, 40196.59803401987, 40201.0, 40240.79879600583, 40327.39508907369, 3385.542951701538, 3560.305740380627, 3584.6415358464205, 3587.443946188319, 3693.445983102529, 30689.0, 31166.22084447884, 31221.37557248842, 31293.374132517223, 31753.8412307937, 4173.31140361843, 4189.245935731567, 4222.5566315536735, 4331.6534677225745, 4361.127774445124, 279025.0, 280093.0, 280729.596352019, 280904.0, 281450.0, 55816.0, 56100.0, 56330.155047674314, 56338.718306408206, 56420.71789641026, 55158.0, 64328.0, 65688.67155664286, 65803.0, 66218.66890665516, 15728.449504267524, 15744.370225190863, 15779.447719329997, 15900.443484477988, 15917.761233581505, 11624.709382265342, 12038.337891416057, 12453.0, 12624.621261362174, 12642.810357844639, 16990.915045424696, 17469.7379539307, 17520.474385768448, 17621.47135585909, 17757.378491752726, 5611.607187496836, 5922.170896074553, 5968.492678122321, 5996.850078747979, 6010.939890601038, 1033.850091736694, 1112.8887111288807, 1130.6099395708468, 1140.3613976173203, 1150.7813515432042, 29982.700172998426, 30058.0, 31764.04707858768, 32170.678293217235, 32374.190645233586, 1139.367650953712, 1140.7889540435046, 1176.4294317256124, 1225.3199474291853, 1235.932023738703, 17058.48824535266, 17108.230129644195, 17285.13574321304, 17372.47882563525, 17383.391581294592, 433183.0, 440676.0, 442833.0, 444239.0, 444473.0, 55984.440155598735, 56602.43397565972, 56694.43305566974, 56738.43261567414, 56748.432515674314, 1321.5506727712432, 1381.9980514127178, 1408.7323408552547, 1416.6387571169287, 1418.6240646228757, 27776.305592359546, 30736.538951915292, 31685.84157079292, 31967.36065278635, 32242.83878580592, 45773.77113114413, 46049.30926036045, 46193.30710039285, 46254.537454625024, 46276.30585541152, 282435.0, 284249.0, 285075.0, 285766.0, 286445.0, 34966.30067398689, 35590.8220458896, 39464.210715786096, 40004.79997599994, 40258.19483610253, 43975.340369893835, 44201.65973035663, 44450.55549444464, 44981.32528012017, 45350.0, 39192.804035979636, 39242.290925089175, 39975.80012100037, 40100.3984940232, 40845.38731919083, 38369.0, 38780.6121938777, 38827.2234555313, 39032.0, 40065.39901901532, 41806.58193418027, 41958.370624440046, 42481.36277955895, 43748.56251437445, 43836.0, 34088.318233634694, 36104.42363897537, 36496.63503365039, 36649.63350366569, 37101.25797484089, 28579.142625721262, 28722.856385717936, 28994.27514312159, 29028.27429314284, 29076.0], "value": 19252.167997335582, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [395.5589517687779, 395.6261333040278, 403.7052951345517, 405.6916743275111, 412.90709590342175, 13131.277779722112, 14372.784408233885, 16705.74941375879, 17703.55741106473, 17736.46790596281, 16994.49016529503, 17500.737488937677, 17805.821941780578, 17829.73255401167, 18419.447416577492, 5507.146392309189, 5601.971990140064, 5659.6321239119325, 5682.6306290091015, 5699.2590963174725, 5409.459054094598, 5542.722863856811, 5607.607467477278, 5611.579131565129, 5628.802991895284, 5551.361593416768, 5552.5280351169995, 5560.2493663355335, 5570.637908535952, 5623.606347555673, 5417.64785288957, 5554.972225138848, 5611.494965453129, 5616.410276920926, 5618.381977982439, 4856.975715121437, 4956.925646115275, 5028.547430731252, 5046.09170349337, 5047.242913562958, 19627.0, 22553.323400298017, 22911.31266062021, 23011.309660710205, 23164.65253021206, 2260.604394231003, 2402.2793162051316, 2557.83374080686, 2681.5441374966304, 3004.459197344477, 13913.652158696012, 13977.58067257984, 14160.645983850487, 14195.432182712679, 14622.780658290134, 1949.3079956615481, 1960.4216756056996, 1966.0, 2006.809353111452, 2052.445839623308, 74918.25081749221, 76468.0, 76657.23342766556, 76957.845632315, 77267.61366193133, 10271.845922311171, 10364.378137311785, 10610.469476526143, 10720.517576709066, 10751.139908807276, 14688.485902993343, 14695.26523673812, 14696.26518674062, 14769.926150369394, 14786.408543658134, 7898.881516777253, 8135.471194372347, 8213.589320533949, 8334.083250842403, 8341.16588341161, 7815.3356964657505, 7817.179196184319, 7929.135030519555, 8017.078036025931, 8044.235797599219, 6576.934230657728, 6605.273419923805, 6608.669566521655, 6656.434203092695, 6695.0, 1922.4905400068992, 1939.7187407826068, 1973.9013049347761, 1980.386080315107, 2004.6592079346547, 918.3800934369274, 989.0, 995.0845222395413, 1069.9995504203594, 1078.6440474643348, 18937.810621893605, 19495.12271947766, 19705.408837734893, 19752.407427776903, 19793.30723424673, 1063.9148868090533, 1064.8562444070105, 1120.966371008871, 1144.250515912079, 1151.6084531259412, 10767.730806729738, 11153.442327883573, 11189.72025699364, 11247.0, 11298.37858917751, 507155.0, 521559.0, 525109.0, 537090.0, 544941.0, 89886.0, 97126.0, 97972.51013745028, 98377.50811245898, 99760.501197495, 1068.1081297116993, 1119.6920846767366, 1126.2622981946838, 1155.9884401156048, 1165.5454372794618, 17095.48713538596, 17328.39350622722, 17330.39343622967, 17522.91238543799, 17609.647807044043, 38849.22301553896, 38872.8338149856, 39299.41050884182, 39752.204955901296, 40024.59975400209, 54362.0, 54535.45464545462, 54616.0, 54678.453215467336, 55694.72152639211, 7106.609136497542, 7393.186749457663, 8151.755447336589, 8696.652133914826, 8855.114488551093, 8395.874061889199, 10743.818180000037, 13502.324883755577, 13720.725585488433, 13885.722285554435, 10768.3538987661, 10947.616833410792, 11194.0, 11267.549298028314, 11329.943350283196, 11456.828147577626, 11538.250013749079, 11571.884281157081, 11613.070954323464, 11639.6508104757, 11338.206325557132, 11403.600873969372, 11509.07927365792, 11653.126015548698, 11684.824727628922, 7694.192109828387, 7754.612269386395, 7818.0, 7864.72473463426, 7877.7636670899965, 11077.723056923642, 11107.944460277648, 11217.775644487228, 11247.100231981585, 11422.25755325901], "value": 9243.521427952895, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1227.7851376009196, 1455.1123814473174, 1502.384022550754, 1616.6362568422107, 1783.8840475369093, 8114.188581141882, 8421.621027053781, 8432.494050356983, 8439.831203375928, 8441.240288374045, 8209.917900821005, 8320.625571849267, 8331.791705207374, 8353.665853365857, 8364.414490985619, 2048.0886005727457, 2298.528801595669, 2362.9527409451803, 2379.4527258730504, 2391.772781585755, 2380.2502211803226, 2400.939976500593, 2403.975960240393, 2405.9639105413435, 2407.2296865003204, 2321.4080409495555, 2358.0921345282018, 2360.2565191964563, 2360.6459031145296, 2364.0425627620757, 2026.7466566679166, 2284.1662793080573, 2340.6372012338115, 2348.248560460653, 2349.083857295656, 2281.3726225288015, 2290.9885450572806, 2292.2435596253194, 2304.5621331946877, 2308.90764369425, 8304.252617264416, 8413.83172336556, 8427.32581393487, 8434.156584341577, 8443.535605541692, 5098.923516147261, 5241.606879484016, 5247.501487358733, 5257.053730328539, 5260.053190425722, 3252.5283833844196, 3295.505674148897, 3318.776419798741, 3333.233356328058, 3359.6640335966454, 1115.8047341715167, 1131.9773604527863, 1140.1847678909537, 1161.506359797083, 1167.6788883057143, 12003.879961200364, 12005.519779208822, 12056.095792815573, 12059.09556783236, 12079.154459187772, 4557.156925968707, 4680.555347242007, 4782.258749893772, 4829.6860704054125, 4858.58702010326, 10076.445795481171, 10116.190704743603, 10119.59521619127, 10129.645462408927, 10146.695599132037, 4611.377464042378, 5315.654482458705, 5324.840254792362, 5356.1697936819855, 5369.785208591691, 4323.913521729548, 4333.285007973649, 4628.652851036186, 4757.643176761757, 4796.160671882407, 3893.4938458000847, 3932.8426862925735, 3992.341263691458, 4006.0385507477995, 4054.9189016220103, 1292.1084451728277, 1301.323311877837, 1311.1280998136324, 1312.8293321868287, 1332.6335257803987, 800.6757263308253, 855.9186877246651, 892.9642814287486, 957.6507753593768, 989.8168838764851, 6004.609700369462, 6052.364501727343, 6079.088136779518, 6113.510919126459, 6200.782972596027, 461.8245066874566, 466.2074473395174, 470.1396444506545, 471.54260367443527, 472.6738550400213, 4180.644645205191, 4183.5398106208295, 4197.265478541243, 4250.171216612731, 4261.722988005769, 10329.483525823678, 10794.838077428845, 10864.565417383374, 10865.239433239756, 10880.564777408974, 10598.682039538826, 10711.517981690688, 10725.78548429027, 10733.141348692086, 10744.247902646895, 7646.273604007611, 7965.920340796633, 7991.120976692559, 8062.475939064059, 8097.2307630774985, 6032.517398608188, 6170.228721409824, 6171.382861713792, 6293.811185664437, 6316.210473690789, 9860.30977831545, 9876.061774131445, 9889.703308900744, 10013.549390277309, 10178.592856285963, 9971.152452041657, 10101.14140298083, 10192.337498062601, 10208.336458130494, 10367.27429079957, 6994.720211191496, 7177.3899218567, 7186.712531498891, 7566.092068951761, 7673.772196448765, 7522.511036782592, 8059.637316320663, 8144.511329320259, 8168.754937351889, 8170.0, 7160.892586611101, 7245.601491917995, 7317.5609463432365, 7419.554826710415, 7500.774976750707, 6931.89602155958, 7035.226125126334, 7067.399271061811, 7073.540219885691, 7132.108486439195, 6748.93251067483, 6813.625250611264, 6819.283975182733, 6822.283660215606, 6825.55633883796, 4971.328870602567, 5023.045621332081, 5067.87330316745, 5095.515925987025, 5125.461826508312, 5161.870953226049, 5219.373675158853, 5226.216067589892, 5241.528262456245, 5267.183586543939], "value": 4483.566649303866, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [325.6076427904377, 338.1191994853407, 339.6518568467321, 340.8312885121865, 345.5404312264688, 5430.348358197022, 5500.3949565547755, 5530.861728456785, 5668.206451096845, 5673.255651270162, 5616.663000219979, 5623.915641265374, 5630.042892708239, 5655.434456554342, 5674.0, 4359.891002724933, 4380.58384453478, 4381.07997320563, 4381.408509851161, 4384.539623339551, 4165.229432554987, 4306.784660766949, 4319.82720691172, 4383.211022016036, 4401.911961760763, 4219.07180420307, 4238.109996900655, 4258.87223383299, 4267.658587313008, 4276.18752437036, 4093.3246014407587, 4240.809163587631, 4245.87262382129, 4253.936190957138, 4267.445232119836, 3724.1806802503675, 3747.2318174774377, 3770.26479836432, 3773.2264885698364, 3774.622537746231, 5381.650192737459, 5389.946100538984, 5426.294581704353, 5429.67421954684, 5442.482964118402, 4892.730899800509, 4899.387576552931, 4941.604671626261, 4992.226204938241, 5008.524190201925, 5883.02930016551, 5913.05391137416, 5919.0, 5923.778583031363, 5928.814237152586, 4120.546739858613, 4132.91734165318, 4149.522804877448, 4153.709240353177, 4156.2726522858375, 5947.851303717398, 6093.664848433335, 6109.725062372248, 6136.631802091889, 6152.907706384408, 4175.457190565207, 4239.215745087169, 4256.638185754246, 4257.531671516131, 4263.8081286342185, 4264.0832221072, 4307.633851122627, 4321.870343889688, 4323.524412314643, 4324.221640104812, 4821.927671084936, 4958.7024778513405, 4963.329950456714, 4967.205247160509, 4967.3542439482635, 5645.548356131581, 5852.356240813507, 5910.763569457259, 5917.7572709730575, 5943.524518038546, 1431.155618185255, 1433.1114708880561, 1452.1432354910653, 1478.4529724001973, 1480.3116550803713, 968.7626531499827, 991.980160396788, 1000.5297510170209, 1004.2769206171545, 1009.3842755918884, 5577.860553486195, 5648.209250704905, 5679.574031947538, 5682.829515114553, 5702.914456283159, 5971.134185543159, 6016.127661489147, 6021.488173505301, 6027.276726792813, 6039.879202416015, 5456.645318054393, 5670.319561652628, 5705.62913410627, 5741.942580574141, 5801.53587712982, 3222.758293128025, 3223.597050368704, 3243.6918492743152, 3268.9182770430452, 3269.313444176702, 6216.445888527868, 6271.937280627227, 6329.810105696836, 6395.968020159962, 6422.710978005907, 6166.4758495527485, 6166.9383306167265, 6170.765846830652, 6171.783987560503, 6180.289266734383, 6280.623162610258, 6320.945692649907, 6325.968370158212, 6351.936480635227, 6381.521385896076, 5894.204282421818, 6071.2714474263375, 6085.665288409003, 6086.786962456293, 6089.908651370144, 5987.31145918225, 5994.580379373402, 5997.070454079625, 5997.6701281428195, 6045.183900173421, 6082.787102451393, 6291.528135389773, 6298.590591611531, 6304.873902521832, 6377.202849643794, 4310.116426132573, 4347.76087315188, 4361.6074553290355, 4371.469985505175, 4380.27725425314, 5861.706914654165, 6067.089936509559, 6070.666113363807, 6071.241094863142, 6072.056941778588, 5557.860638569003, 5848.473637372657, 5942.970285148546, 5943.405659434195, 5954.702264886651, 5900.203472531153, 5940.435658612425, 5941.405859414024, 5946.07835785454, 5952.166696662384, 5628.0, 5842.795502157574, 5859.572150292127, 5862.970685146547, 5870.765169393348, 5978.342382338026, 5978.701064946648, 5991.614737673201, 6001.5798894077, 6032.5521874748865, 5821.592488525763, 5824.475797178275, 5851.502622277154, 5852.239208902815, 5864.912026319524], "value": 4476.108857190253, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [729.686234918985, 733.5232099135561, 779.614091024942, 814.88998985137, 823.1603764160558, 14677.999999999987, 15037.62405939852, 15061.62345941352, 15071.321790519425, 15105.6978860423, 14287.499937502189, 14397.784033239484, 14529.854701452983, 14552.854471455283, 14560.635984100403, 660.408934004066, 767.57399643198, 795.9811441355075, 798.5807451088167, 799.276654627563, 800.4196957206037, 800.5596921693075, 801.210807354755, 803.3492870774692, 803.6544285957036, 686.8900975843866, 837.3803385494721, 840.0885039731899, 840.6721378662327, 840.7099550655045, 817.4768148385009, 833.2833762963846, 833.6498670558319, 833.7123692326168, 834.6661335465832, 602.9095635654643, 604.8336707405499, 605.2132228103447, 605.2464681471552, 608.85996220869, 15041.623959400993, 15132.167730774803, 15154.469593564172, 15155.393784248618, 15234.085954842745, 13896.652583685387, 13946.93026534871, 14092.154470731788, 14338.928305358511, 14570.490032848906, 11609.535618575246, 11816.940915295454, 11834.822477662841, 11909.702257443547, 12004.51981920731, 3916.686665066788, 3925.646691797752, 3954.8022598869943, 4016.7790771507557, 4050.878473645766, 55055.44944550583, 55401.0, 55814.720926395516, 57180.42819571793, 57583.0, 10397.84403233952, 10621.468926553642, 10813.891861081445, 10835.945820270848, 10900.0, 20233.291834785712, 20252.594948100956, 20254.898725506573, 20280.0, 20307.796922030888, 7834.608269586498, 7884.172161922916, 8031.437799353989, 8194.959025204955, 8439.789005274795, 4641.74470404131, 4684.81260749573, 4782.928256076161, 4784.186688263004, 4817.0, 3311.850966706504, 3418.8461519231696, 3422.57217847769, 3429.6227414984332, 3430.622631510532, 562.9774809007594, 577.6014549960514, 585.0814221671934, 587.2747157260779, 591.9940800592025, 722.9457790665721, 726.5313872552174, 737.848741008092, 742.8142964258827, 755.8715018446877, 8623.525706086226, 8670.393072484992, 8769.12308769118, 8777.780555486037, 9019.278457723367, 620.8634100497883, 631.1290419221446, 654.5418207254845, 743.7099531182843, 762.272030211147, 4197.345004810499, 4208.452901122834, 4212.368144778307, 4275.273203555403, 4328.788934222336, 62040.68979655163, 62713.0, 62808.0, 64170.0, 64199.35800641934, 55820.44179558234, 55902.0, 56498.43501564932, 57128.42871571231, 57167.71416142893, 49639.0, 50074.49925500698, 50775.23837142446, 50799.23801142986, 51993.7400312996, 8038.236367545074, 8118.114055493478, 8135.552544610104, 8405.747827565183, 8489.108643592333, 33873.32253354968, 33885.49171762475, 34108.0, 34986.0, 35377.1155721109, 42633.0, 46423.0, 47221.291680624134, 47523.76238118787, 48203.75898120487, 10437.32157409766, 10577.0, 10727.463626818784, 10756.784864302826, 10817.40504272241, 11567.88432115668, 12097.69755756078, 12713.745725085631, 12731.363431828557, 12864.807027894401, 11617.419129043683, 11841.526338946345, 11884.10869184832, 11954.342511161969, 12309.26144431337, 11445.713857153305, 11466.598669046543, 11485.712857178638, 11487.885121148682, 11513.078953683518, 10982.162475281362, 11020.173486988668, 11112.833307500232, 11393.772124557629, 11420.200585959235, 9524.14282714559, 9615.663451779154, 9695.224382049279, 9974.0, 10332.60727618935, 9247.630094796134, 9374.0, 9497.43015419077, 9504.204145969208, 9590.760230994001], "value": 6606.829881639552, "unit": "score"}], "name": "dromaeo_css", "value": 7035.112422278491, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 111.0, 104.0, 108.0, 109.0, 110.0, 99.0, 109.0, 109.0, 109.0], "value": 107.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 122.0, 162.0, 185.0, 127.0, 160.0, 161.0, 127.0, 179.0, 136.0], "value": 150.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 159.0, 162.0, 162.0, 161.0, 159.0, 161.0, 161.0, 161.0], "value": 160.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 72.0, 97.0, 106.0, 77.0, 75.0, 76.0, 108.0, 105.0, 73.0], "value": 86.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 93.0, 159.0, 92.0, 95.0, 92.0, 155.0, 92.0, 92.0, 152.0], "value": 111.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 116.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 145.0, 146.0, 145.0, 145.0, 145.0, 146.0, 145.0, 145.0], "value": 145.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 95.0, 95.0, 94.0, 95.0, 94.0, 94.0, 94.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 58.0, 59.0, 57.0, 60.0, 58.0, 58.0, 75.0, 57.0, 55.0], "value": 59.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 60.0, 61.0, 61.0, 60.0, 60.0, 60.0, 59.0, 60.0], "value": 60.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 75.0, 75.0, 75.0, 76.0, 76.0, 85.0, 76.0, 80.0, 77.0], "value": 77.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 133.0, 122.0, 126.0, 126.0, 129.0, 122.0, 121.0, 153.0, 124.0], "value": 128.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 169.0, 167.0, 164.0, 163.0, 165.0, 168.0, 164.0, 170.0], "value": 165.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 71.0, 66.0, 69.0, 67.0, 67.0, 68.0, 66.0, 68.0, 68.0], "value": 67.6, "unit": "score"}], "name": "kraken", "value": 1532.6, "alertThreshold": 2.0}]} 02:26:58 INFO - Return code: 0 02:26:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 02:26:58 ERROR - # TBPL SUCCESS # 02:26:58 INFO - Running post-action listener: _resource_record_post_action 02:26:58 INFO - Running post-run listener: _resource_record_post_run 02:26:59 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 12288; Write bytes: 536190976; Read time: 276; Write time: 536740 02:26:59 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 4096; Write bytes: 244244480; Read time: 160; Write time: 268424 02:26:59 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 8192; Write bytes: 291876864; Read time: 116; Write time: 268292 02:26:59 INFO - Running post-run listener: _upload_blobber_files 02:26:59 INFO - Blob upload gear active. 02:26:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:26:59 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 02:26:59 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'] 02:26:59 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 02:27:00 INFO - (blobuploader) - INFO - Open directory for files ... 02:27:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:27:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:27:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:27:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:27:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:27:00 INFO - (blobuploader) - INFO - Done attempting. 02:27:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:27:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:27:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:27:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:27:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:27:01 INFO - (blobuploader) - INFO - Done attempting. 02:27:01 INFO - (blobuploader) - INFO - Iteration through files over. 02:27:01 INFO - Return code: 0 02:27:01 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:27:01 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:27:01 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e25b0296673b28c722f67ec9d8d5309b3a3b10ab6ec44d7c55e20bf7c6e34f413b78f075fd0abaa9ef44f6f9c4968a74be6b8d4768da10b5db0b688465d6cde8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/09e22a45a38b93040dce7fd3ee3c2f3d484ef1f868817d1e5e2c41818c0eda6c2f24522f958933f00bfdfcf6903aeea53429c0dab389f8a0779322ca52ee97b5"} 02:27:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:27:01 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:27:01 INFO - Contents: 02:27:01 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e25b0296673b28c722f67ec9d8d5309b3a3b10ab6ec44d7c55e20bf7c6e34f413b78f075fd0abaa9ef44f6f9c4968a74be6b8d4768da10b5db0b688465d6cde8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/09e22a45a38b93040dce7fd3ee3c2f3d484ef1f868817d1e5e2c41818c0eda6c2f24522f958933f00bfdfcf6903aeea53429c0dab389f8a0779322ca52ee97b5"} 02:27:01 INFO - Running post-run listener: copy_logs_to_upload_dir 02:27:01 INFO - Copying logs to upload dir... 02:27:01 INFO - mkdir: /builds/slave/test/build/upload/logs 02:27:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.046113 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-04-17 02:27:01.747669) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-17 02:27:01.751582) ========= 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=03627c79f6bb3d1578c4a402000001ba-1460878634.716219-684682743 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/e25b0296673b28c722f67ec9d8d5309b3a3b10ab6ec44d7c55e20bf7c6e34f413b78f075fd0abaa9ef44f6f9c4968a74be6b8d4768da10b5db0b688465d6cde8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/09e22a45a38b93040dce7fd3ee3c2f3d484ef1f868817d1e5e2c41818c0eda6c2f24522f958933f00bfdfcf6903aeea53429c0dab389f8a0779322ca52ee97b5"} build_url:https://queue.taskcluster.net/v1/task/BOaYpnahT9OTWNv43IgMRw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011339 build_url: 'https://queue.taskcluster.net/v1/task/BOaYpnahT9OTWNv43IgMRw/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/e25b0296673b28c722f67ec9d8d5309b3a3b10ab6ec44d7c55e20bf7c6e34f413b78f075fd0abaa9ef44f6f9c4968a74be6b8d4768da10b5db0b688465d6cde8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/09e22a45a38b93040dce7fd3ee3c2f3d484ef1f868817d1e5e2c41818c0eda6c2f24522f958933f00bfdfcf6903aeea53429c0dab389f8a0779322ca52ee97b5"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-17 02:27:01.776224) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-17 02:27:01.776609) ========= 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=03627c79f6bb3d1578c4a402000001ba-1460878634.716219-684682743 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004466 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-17 02:27:01.858695) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-17 02:27:01.859000) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-17 02:27:01.859301) ========= ========= Total master_lag: 0.18 =========