builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-068 starttime: 1461349842.7 results: success (0) buildid: 20160422083248 builduid: 9f962c054afb47e89301c72130465769 revision: df4e550128b976a664216e57f78f80c36d78f275 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-22 11:30:42.705210) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-22 11:30:42.705657) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-22 11:30:42.705960) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-22 11:30:42.718533) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 11:30:42.718822) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1461349838.219084-1316521108 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-22 11:30:43-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 211M=0s 2016-04-22 11:30:43 (211 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.104347 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 11:30:42.835303) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 11:30:42.835692) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1461349838.219084-1316521108 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022008 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 11:30:42.886009) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 11:30:42.886409) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev df4e550128b976a664216e57f78f80c36d78f275 --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 df4e550128b976a664216e57f78f80c36d78f275 --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=97facb8ba2ac28944cc45e6b000001d4-1461349838.219084-1316521108 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-22 11:30:43,220 truncating revision to first 12 chars 2016-04-22 11:30:43,220 Setting DEBUG logging. 2016-04-22 11:30:43,220 attempt 1/10 2016-04-22 11:30:43,220 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/df4e550128b9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-22 11:30:43,847 unpacking tar archive at: fx-team-df4e550128b9/testing/mozharness/ program finished with exit code 0 elapsedTime=0.914201 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 11:30:43.813840) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-22 11:30:43.814166) ========= script_repo_revision: df4e550128b976a664216e57f78f80c36d78f275 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-22 11:30:43.814557) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-22 11:30:43.814851) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-22 11:30:43.823443) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-04-22 11:30:43.823759) ========= /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=97facb8ba2ac28944cc45e6b000001d4-1461349838.219084-1316521108 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:30:44 INFO - MultiFileLogger online at 20160422 11:30:44 in /builds/slave/test 11:30:44 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 11:30:44 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:30:44 INFO - {'append_to_log': False, 11:30:44 INFO - 'base_work_dir': '/builds/slave/test', 11:30:44 INFO - 'blob_upload_branch': 'Fx-Team', 11:30:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:30:44 INFO - 'branch': 'Fx-Team', 11:30:44 INFO - 'buildbot_json_path': 'buildprops.json', 11:30:44 INFO - 'config_files': ('talos/linux_config.py',), 11:30:44 INFO - 'default_actions': ('clobber', 11:30:44 INFO - 'read-buildbot-config', 11:30:44 INFO - 'download-and-extract', 11:30:44 INFO - 'populate-webroot', 11:30:44 INFO - 'create-virtualenv', 11:30:44 INFO - 'install', 11:30:44 INFO - 'run-tests'), 11:30:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:30:44 INFO - 'download_minidump_stackwalk': True, 11:30:44 INFO - 'download_symbols': 'ondemand', 11:30:44 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:30:44 INFO - 'tooltool.py': '/tools/tooltool.py', 11:30:44 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:30:44 INFO - '/tools/misc-python/virtualenv.py')}, 11:30:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:30:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:30:44 INFO - 'installer_path': 'installer.exe', 11:30:44 INFO - 'log_level': 'info', 11:30:44 INFO - 'log_name': 'talos', 11:30:44 INFO - 'log_to_console': True, 11:30:44 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:30:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:30:44 INFO - 'opt_config_files': (), 11:30:44 INFO - 'pip_index': False, 11:30:44 INFO - 'sps_profile': False, 11:30:44 INFO - 'sps_profile_interval': 0, 11:30:44 INFO - 'suite': 'dromaeojs', 11:30:44 INFO - 'system_bits': '32', 11:30:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:30:44 INFO - 'title': 'talos-linux64-ix-068', 11:30:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:30:44 INFO - 'use_talos_json': True, 11:30:44 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:30:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:30:44 INFO - 'work_dir': 'build'} 11:30:44 INFO - ##### 11:30:44 INFO - ##### Running clobber step. 11:30:44 INFO - ##### 11:30:44 INFO - Running pre-action listener: _resource_record_pre_action 11:30:44 INFO - Running main action method: clobber 11:30:44 INFO - rmtree: /builds/slave/test/build 11:30:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:30:45 INFO - Running post-action listener: _resource_record_post_action 11:30:45 INFO - ##### 11:30:45 INFO - ##### Running read-buildbot-config step. 11:30:45 INFO - ##### 11:30:45 INFO - Running pre-action listener: _resource_record_pre_action 11:30:45 INFO - Running main action method: read_buildbot_config 11:30:45 INFO - Using buildbot properties: 11:30:45 INFO - { 11:30:45 INFO - "project": "", 11:30:45 INFO - "product": "firefox", 11:30:45 INFO - "script_repo_revision": "production", 11:30:45 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 11:30:45 INFO - "repository": "", 11:30:45 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 11:30:45 INFO - "buildid": "20160422083248", 11:30:45 INFO - "pgo_build": "True", 11:30:45 INFO - "basedir": "/builds/slave/test", 11:30:45 INFO - "buildnumber": 1110, 11:30:45 INFO - "slavename": "talos-linux64-ix-068", 11:30:45 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:30:45 INFO - "platform": "ubuntu64_hw", 11:30:45 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 11:30:45 INFO - "branch": "fx-team", 11:30:45 INFO - "repo_path": "integration/fx-team", 11:30:45 INFO - "revision": "df4e550128b976a664216e57f78f80c36d78f275", 11:30:45 INFO - "stage_platform": "linux64-pgo", 11:30:45 INFO - "builduid": "9f962c054afb47e89301c72130465769", 11:30:45 INFO - "slavebuilddir": "test" 11:30:45 INFO - } 11:30:45 INFO - Found installer url https://queue.taskcluster.net/v1/task/Zx-wswNnS1qxZsl05YdR2Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 11:30:45 INFO - Running post-action listener: _resource_record_post_action 11:30:45 INFO - ##### 11:30:45 INFO - ##### Running download-and-extract step. 11:30:45 INFO - ##### 11:30:45 INFO - Running pre-action listener: _resource_record_pre_action 11:30:45 INFO - Running main action method: download_and_extract 11:30:45 INFO - mkdir: /builds/slave/test/build/tests 11:30:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:30:45 INFO - https://queue.taskcluster.net/v1/task/Zx-wswNnS1qxZsl05YdR2Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 11:30:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zx-wswNnS1qxZsl05YdR2Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 11:30:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zx-wswNnS1qxZsl05YdR2Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 11:30:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zx-wswNnS1qxZsl05YdR2Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 11:30:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zx-wswNnS1qxZsl05YdR2Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 11:30:45 INFO - Downloaded 1361 bytes. 11:30:45 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 11:30:45 INFO - Using the following test package requirements: 11:30:45 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 11:30:45 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:30:45 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:30:45 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:30:45 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:30:45 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:30:45 INFO - u'jsshell-linux-x86_64.zip'], 11:30:45 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:30:45 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:30:45 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 11:30:45 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:30:45 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:30:45 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:30:45 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:30:45 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:30:45 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:30:45 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:30:45 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:30:45 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:30:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:30:45 INFO - https://queue.taskcluster.net/v1/task/Zx-wswNnS1qxZsl05YdR2Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:30:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zx-wswNnS1qxZsl05YdR2Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 11:30:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zx-wswNnS1qxZsl05YdR2Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 11:30:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zx-wswNnS1qxZsl05YdR2Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 11:30:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zx-wswNnS1qxZsl05YdR2Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:30:47 INFO - Downloaded 23857749 bytes. 11:30:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:30:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 11:30:48 INFO - Return code: 0 11:30:48 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11:30:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:30:48 INFO - https://queue.taskcluster.net/v1/task/Zx-wswNnS1qxZsl05YdR2Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:30:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zx-wswNnS1qxZsl05YdR2Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 11:30:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zx-wswNnS1qxZsl05YdR2Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 11:30:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zx-wswNnS1qxZsl05YdR2Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 11:30:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zx-wswNnS1qxZsl05YdR2Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:30:49 INFO - Downloaded 23857749 bytes. 11:30:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:30:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 11:30:51 INFO - Return code: 0 11:30:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:30:51 INFO - https://queue.taskcluster.net/v1/task/Zx-wswNnS1qxZsl05YdR2Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:30:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zx-wswNnS1qxZsl05YdR2Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 11:30:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zx-wswNnS1qxZsl05YdR2Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 11:30:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zx-wswNnS1qxZsl05YdR2Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 11:30:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zx-wswNnS1qxZsl05YdR2Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:30:52 INFO - Downloaded 10840145 bytes. 11:30:52 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:30:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 11:30:52 INFO - Return code: 0 11:30:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:30:52 INFO - https://queue.taskcluster.net/v1/task/Zx-wswNnS1qxZsl05YdR2Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:30:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zx-wswNnS1qxZsl05YdR2Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 11:30:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zx-wswNnS1qxZsl05YdR2Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 11:30:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zx-wswNnS1qxZsl05YdR2Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 11:30:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zx-wswNnS1qxZsl05YdR2Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 11:30:53 INFO - Downloaded 58365529 bytes. 11:30:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Zx-wswNnS1qxZsl05YdR2Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 11:30:53 INFO - mkdir: /builds/slave/test/properties 11:30:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:30:53 INFO - Writing to file /builds/slave/test/properties/build_url 11:30:53 INFO - Contents: 11:30:53 INFO - build_url:https://queue.taskcluster.net/v1/task/Zx-wswNnS1qxZsl05YdR2Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 11:30:54 INFO - Running post-action listener: _resource_record_post_action 11:30:54 INFO - Running post-action listener: set_extra_try_arguments 11:30:54 INFO - ##### 11:30:54 INFO - ##### Running populate-webroot step. 11:30:54 INFO - ##### 11:30:54 INFO - Running pre-action listener: _resource_record_pre_action 11:30:54 INFO - Running main action method: populate_webroot 11:30:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:30:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:30:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:30:54 INFO - '--tppagecycles', 11:30:54 INFO - '7'], 11:30:54 INFO - 'tests': ['tsvgm']}}, 11:30:54 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:30:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:30:54 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:30:54 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:30:54 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:30:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:30:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:30:54 INFO - 'talos_options': ['--disable-e10s'], 11:30:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:30:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:30:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:30:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:30:54 INFO - 'talos_options': ['--disable-e10s'], 11:30:54 INFO - 'tests': ['damp', 'tps']}, 11:30:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:30:54 INFO - 'tests': ['damp', 'tps']}, 11:30:54 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:30:54 INFO - 'tests': ['dromaeo_dom']}, 11:30:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:30:54 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:30:54 INFO - 'tests': ['a11yr', 11:30:54 INFO - 'ts_paint', 11:30:54 INFO - 'tpaint', 11:30:54 INFO - 'sessionrestore', 11:30:54 INFO - 'sessionrestore_no_auto_restore', 11:30:54 INFO - 'tabpaint']}, 11:30:54 INFO - 'other-e10s': {'tests': ['a11yr', 11:30:54 INFO - 'ts_paint', 11:30:54 INFO - 'tpaint', 11:30:54 INFO - 'sessionrestore', 11:30:54 INFO - 'sessionrestore_no_auto_restore', 11:30:54 INFO - 'tabpaint']}, 11:30:54 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:30:54 INFO - 'ts_paint', 11:30:54 INFO - 'tpaint', 11:30:54 INFO - 'sessionrestore', 11:30:54 INFO - 'sessionrestore_no_auto_restore', 11:30:54 INFO - 'tabpaint']}, 11:30:54 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:30:54 INFO - 'ts_paint', 11:30:54 INFO - 'tpaint', 11:30:54 INFO - 'sessionrestore', 11:30:54 INFO - 'sessionrestore_no_auto_restore', 11:30:54 INFO - 'tabpaint']}, 11:30:54 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:30:54 INFO - 'tests': ['a11yr', 11:30:54 INFO - 'ts_paint', 11:30:54 INFO - 'tpaint', 11:30:54 INFO - 'sessionrestore', 11:30:54 INFO - 'sessionrestore_no_auto_restore', 11:30:54 INFO - 'tabpaint']}, 11:30:54 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:30:54 INFO - 'tests': ['a11yr', 11:30:54 INFO - 'ts_paint', 11:30:54 INFO - 'tpaint', 11:30:54 INFO - 'sessionrestore', 11:30:54 INFO - 'sessionrestore_no_auto_restore', 11:30:54 INFO - 'tabpaint']}, 11:30:54 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:30:54 INFO - 'tests': ['tsvgx', 11:30:54 INFO - 'tsvgr_opacity', 11:30:54 INFO - 'tart', 11:30:54 INFO - 'tscrollx', 11:30:54 INFO - 'cart']}, 11:30:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:30:54 INFO - 'tsvgr_opacity', 11:30:54 INFO - 'tart', 11:30:54 INFO - 'tscrollx', 11:30:54 INFO - 'cart']}, 11:30:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:30:54 INFO - 'talos_options': ['--disable-e10s'], 11:30:54 INFO - 'tests': ['tp5o']}, 11:30:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:30:54 INFO - 'tests': ['tp5o']}, 11:30:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:30:54 INFO - 'talos_options': ['--disable-e10s', 11:30:54 INFO - '--xperf_path', 11:30:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:30:54 INFO - 'tests': ['tp5n']}, 11:30:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:30:54 INFO - 'talos_options': ['--xperf_path', 11:30:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:30:54 INFO - 'tests': ['tp5n']}}, 11:30:54 INFO - 'talos.zip': {'path': '', 11:30:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:30:54 INFO - Running post-action listener: _resource_record_post_action 11:30:54 INFO - ##### 11:30:54 INFO - ##### Running create-virtualenv step. 11:30:54 INFO - ##### 11:30:54 INFO - Running pre-action listener: _resource_record_pre_action 11:30:54 INFO - Running main action method: create_virtualenv 11:30:54 INFO - Creating virtualenv /builds/slave/test/build/venv 11:30:54 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:30:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:30:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:30:54 INFO - Using real prefix '/usr' 11:30:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:30:55 INFO - Installing distribute.............................................................................................................................................................................................done. 11:30:57 INFO - Installing pip.................done. 11:30:57 INFO - Return code: 0 11:30:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:30: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')]} 11:30:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:30:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:30: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')]} 11:30:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:30:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:30:57 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 0x7f3ed2e68f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfb79a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1046810>, '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 0x1047710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1047ba0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1461349838.219084-1316521108', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:30:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:30:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:30:57 INFO - Using env: {'DISPLAY': ':0', 11:30:57 INFO - 'HOME': '/home/cltbld', 11:30:57 INFO - 'LANG': 'en_US.UTF-8', 11:30:57 INFO - 'LANGUAGE': 'en_US:en', 11:30:57 INFO - 'LOGNAME': 'cltbld', 11:30:57 INFO - 'MAIL': '/var/mail/cltbld', 11:30:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:30:57 INFO - 'MOZ_NO_REMOTE': '1', 11:30:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:30:57 INFO - 'NO_EM_RESTART': '1', 11:30:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:30:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:30:57 INFO - 'PWD': '/builds/slave/test', 11:30:57 INFO - 'SHELL': '/bin/bash', 11:30:57 INFO - 'SHLVL': '1', 11:30:57 INFO - 'TERM': 'linux', 11:30:57 INFO - 'TMOUT': '86400', 11:30:57 INFO - 'USER': 'cltbld', 11:30:57 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1461349838.219084-1316521108', 11:30:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:30:57 INFO - '_': '/tools/buildbot/bin/python'} 11:30:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:30:57 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 11:30:57 INFO - Cleaning up... 11:30:57 INFO - Return code: 0 11:30:57 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 11:30: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')]} 11:30:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:30:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:30: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')]} 11:30:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:30:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:30:57 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 0x7f3ed2e68f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfb79a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1046810>, '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 0x1047710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1047ba0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1461349838.219084-1316521108', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:30:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 11:30:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 11:30:57 INFO - Using env: {'DISPLAY': ':0', 11:30:57 INFO - 'HOME': '/home/cltbld', 11:30:57 INFO - 'LANG': 'en_US.UTF-8', 11:30:57 INFO - 'LANGUAGE': 'en_US:en', 11:30:57 INFO - 'LOGNAME': 'cltbld', 11:30:57 INFO - 'MAIL': '/var/mail/cltbld', 11:30:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:30:57 INFO - 'MOZ_NO_REMOTE': '1', 11:30:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:30:57 INFO - 'NO_EM_RESTART': '1', 11:30:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:30:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:30:57 INFO - 'PWD': '/builds/slave/test', 11:30:57 INFO - 'SHELL': '/bin/bash', 11:30:57 INFO - 'SHLVL': '1', 11:30:57 INFO - 'TERM': 'linux', 11:30:57 INFO - 'TMOUT': '86400', 11:30:57 INFO - 'USER': 'cltbld', 11:30:57 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1461349838.219084-1316521108', 11:30:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:30:57 INFO - '_': '/tools/buildbot/bin/python'} 11:30:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:30:57 INFO - Downloading/unpacking psutil>=0.7.1 11:30:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:30:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:30:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:30:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:30:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:30:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:30:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:30:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:30:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:30:59 INFO - Installing collected packages: psutil 11:30:59 INFO - Running setup.py install for psutil 11:30:59 INFO - building 'psutil._psutil_linux' extension 11:30:59 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 11:30:59 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 11:30:59 INFO - building 'psutil._psutil_posix' extension 11:30:59 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 11:31:00 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 11:31:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:31:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:31:00 INFO - Successfully installed psutil 11:31:00 INFO - Cleaning up... 11:31:00 INFO - Return code: 0 11:31:00 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 11:31:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:31:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:31:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:31:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:31:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:31:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:31:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f3ed2e68f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfb79a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1046810>, '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 0x1047710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1047ba0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1461349838.219084-1316521108', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:31:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 11:31:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 11:31:00 INFO - Using env: {'DISPLAY': ':0', 11:31:00 INFO - 'HOME': '/home/cltbld', 11:31:00 INFO - 'LANG': 'en_US.UTF-8', 11:31:00 INFO - 'LANGUAGE': 'en_US:en', 11:31:00 INFO - 'LOGNAME': 'cltbld', 11:31:00 INFO - 'MAIL': '/var/mail/cltbld', 11:31:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:31:00 INFO - 'MOZ_NO_REMOTE': '1', 11:31:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:31:00 INFO - 'NO_EM_RESTART': '1', 11:31:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:31:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:31:00 INFO - 'PWD': '/builds/slave/test', 11:31:00 INFO - 'SHELL': '/bin/bash', 11:31:00 INFO - 'SHLVL': '1', 11:31:00 INFO - 'TERM': 'linux', 11:31:00 INFO - 'TMOUT': '86400', 11:31:00 INFO - 'USER': 'cltbld', 11:31:00 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1461349838.219084-1316521108', 11:31:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:31:00 INFO - '_': '/tools/buildbot/bin/python'} 11:31:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:31:00 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:31:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:31:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:31:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:31:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:31:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:31:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:31:02 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:31:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:31:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 11:31:02 INFO - Installing collected packages: mozsystemmonitor 11:31:02 INFO - Running setup.py install for mozsystemmonitor 11:31:02 INFO - Successfully installed mozsystemmonitor 11:31:02 INFO - Cleaning up... 11:31:02 INFO - Return code: 0 11:31:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:31:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:31:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:31:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:31:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:31:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:31:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:31:02 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 0x7f3ed2e68f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfb79a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1046810>, '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 0x1047710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1047ba0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1461349838.219084-1316521108', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:31:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:31:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:31:02 INFO - Using env: {'DISPLAY': ':0', 11:31:02 INFO - 'HOME': '/home/cltbld', 11:31:02 INFO - 'LANG': 'en_US.UTF-8', 11:31:02 INFO - 'LANGUAGE': 'en_US:en', 11:31:02 INFO - 'LOGNAME': 'cltbld', 11:31:02 INFO - 'MAIL': '/var/mail/cltbld', 11:31:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:31:02 INFO - 'MOZ_NO_REMOTE': '1', 11:31:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:31:02 INFO - 'NO_EM_RESTART': '1', 11:31:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:31:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:31:02 INFO - 'PWD': '/builds/slave/test', 11:31:02 INFO - 'SHELL': '/bin/bash', 11:31:02 INFO - 'SHLVL': '1', 11:31:02 INFO - 'TERM': 'linux', 11:31:02 INFO - 'TMOUT': '86400', 11:31:02 INFO - 'USER': 'cltbld', 11:31:02 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1461349838.219084-1316521108', 11:31:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:31:02 INFO - '_': '/tools/buildbot/bin/python'} 11:31:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:31:02 INFO - Downloading/unpacking blobuploader==1.2.4 11:31:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:31:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:31:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:31:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:31:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:31:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:31:04 INFO - Downloading blobuploader-1.2.4.tar.gz 11:31:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:31:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:31:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:31:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:31:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:31:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:31:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:31:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:31:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:31:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:31:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:31:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:31:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:31:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:31:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:31:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:31:05 INFO - Downloading docopt-0.6.1.tar.gz 11:31:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:31:05 INFO - Installing collected packages: blobuploader, requests, docopt 11:31:05 INFO - Running setup.py install for blobuploader 11:31:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:31:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:31:05 INFO - Running setup.py install for requests 11:31:05 INFO - Running setup.py install for docopt 11:31:05 INFO - Successfully installed blobuploader requests docopt 11:31:05 INFO - Cleaning up... 11:31:06 INFO - Return code: 0 11:31:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:31:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:31:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:31:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:31:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:31:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:31:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:31:06 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 0x7f3ed2e68f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfb79a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1046810>, '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 0x1047710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1047ba0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1461349838.219084-1316521108', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:31:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:31:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:31:06 INFO - Using env: {'DISPLAY': ':0', 11:31:06 INFO - 'HOME': '/home/cltbld', 11:31:06 INFO - 'LANG': 'en_US.UTF-8', 11:31:06 INFO - 'LANGUAGE': 'en_US:en', 11:31:06 INFO - 'LOGNAME': 'cltbld', 11:31:06 INFO - 'MAIL': '/var/mail/cltbld', 11:31:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:31:06 INFO - 'MOZ_NO_REMOTE': '1', 11:31:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:31:06 INFO - 'NO_EM_RESTART': '1', 11:31:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:31:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:31:06 INFO - 'PWD': '/builds/slave/test', 11:31:06 INFO - 'SHELL': '/bin/bash', 11:31:06 INFO - 'SHLVL': '1', 11:31:06 INFO - 'TERM': 'linux', 11:31:06 INFO - 'TMOUT': '86400', 11:31:06 INFO - 'USER': 'cltbld', 11:31:06 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1461349838.219084-1316521108', 11:31:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:31:06 INFO - '_': '/tools/buildbot/bin/python'} 11:31:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:31:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:31:06 INFO - Running setup.py (path:/tmp/pip-41o1F_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:31:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:31:06 INFO - Running setup.py (path:/tmp/pip-dYiEDZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:31:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:31:06 INFO - Running setup.py (path:/tmp/pip-4iLoXh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:31:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:31:06 INFO - Running setup.py (path:/tmp/pip-d4EdNo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:31:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:31:06 INFO - Running setup.py (path:/tmp/pip-0Qpd_8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:31:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:31:06 INFO - Running setup.py (path:/tmp/pip-DDIgKz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:31:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:31:06 INFO - Running setup.py (path:/tmp/pip-ak53WO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:31:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:31:06 INFO - Running setup.py (path:/tmp/pip-j_4ETq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:31:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:31:06 INFO - Running setup.py (path:/tmp/pip-WtZlNK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:31:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:31:06 INFO - Running setup.py (path:/tmp/pip-kK6Y2N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:31:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:31:06 INFO - Running setup.py (path:/tmp/pip-LwTy5i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:31:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:31:07 INFO - Running setup.py (path:/tmp/pip-1Imi0y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:31:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:31:07 INFO - Running setup.py (path:/tmp/pip-Y5xWpu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:31:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:31:07 INFO - Running setup.py (path:/tmp/pip-oiK1B5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:31:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:31:07 INFO - Running setup.py (path:/tmp/pip-qrrj9H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:31:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:31:07 INFO - Running setup.py (path:/tmp/pip-XWXiom-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:31:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:31:07 INFO - Running setup.py (path:/tmp/pip-e30k0a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:31:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:31:07 INFO - Running setup.py install for manifestparser 11:31:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:31:07 INFO - Running setup.py install for mozcrash 11:31:07 INFO - Running setup.py install for mozdebug 11:31:07 INFO - Running setup.py install for mozdevice 11:31:07 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:31:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:31:07 INFO - Running setup.py install for mozfile 11:31:07 INFO - Running setup.py install for mozhttpd 11:31:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:31:08 INFO - Running setup.py install for mozinfo 11:31:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:31:08 INFO - Running setup.py install for mozInstall 11:31:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:31:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:31:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:31:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:31:08 INFO - Running setup.py install for mozleak 11:31:08 INFO - Running setup.py install for mozlog 11:31:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:31:08 INFO - Running setup.py install for moznetwork 11:31:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:31:08 INFO - Running setup.py install for mozprocess 11:31:08 INFO - Running setup.py install for mozprofile 11:31:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:31:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:31:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:31:08 INFO - Running setup.py install for mozrunner 11:31:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:31:08 INFO - Running setup.py install for mozscreenshot 11:31:09 INFO - Running setup.py install for moztest 11:31:09 INFO - Running setup.py install for mozversion 11:31:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:31:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:31:09 INFO - Cleaning up... 11:31:09 INFO - Return code: 0 11:31:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:31:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:31:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:31:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:31:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:31:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:31:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:31:09 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 0x7f3ed2e68f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfb79a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1046810>, '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 0x1047710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1047ba0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1461349838.219084-1316521108', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:31:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:31:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:31:09 INFO - Using env: {'DISPLAY': ':0', 11:31:09 INFO - 'HOME': '/home/cltbld', 11:31:09 INFO - 'LANG': 'en_US.UTF-8', 11:31:09 INFO - 'LANGUAGE': 'en_US:en', 11:31:09 INFO - 'LOGNAME': 'cltbld', 11:31:09 INFO - 'MAIL': '/var/mail/cltbld', 11:31:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:31:09 INFO - 'MOZ_NO_REMOTE': '1', 11:31:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:31:09 INFO - 'NO_EM_RESTART': '1', 11:31:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:31:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:31:09 INFO - 'PWD': '/builds/slave/test', 11:31:09 INFO - 'SHELL': '/bin/bash', 11:31:09 INFO - 'SHLVL': '1', 11:31:09 INFO - 'TERM': 'linux', 11:31:09 INFO - 'TMOUT': '86400', 11:31:09 INFO - 'USER': 'cltbld', 11:31:09 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1461349838.219084-1316521108', 11:31:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:31:09 INFO - '_': '/tools/buildbot/bin/python'} 11:31:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:31:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:31:09 INFO - Running setup.py (path:/tmp/pip-S48ikI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:31:09 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 11:31:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:31:09 INFO - Running setup.py (path:/tmp/pip-WYJGpq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:31:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:31:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:31:09 INFO - Running setup.py (path:/tmp/pip-k3BDl1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:31:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:31:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:31:09 INFO - Running setup.py (path:/tmp/pip-1C4Rd7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:31:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:31:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:31:09 INFO - Running setup.py (path:/tmp/pip-cGrOVt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:31:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 11:31:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:31:09 INFO - Running setup.py (path:/tmp/pip-lf15GI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:31:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 11:31:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:31:09 INFO - Running setup.py (path:/tmp/pip-mnMNMm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:31:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 11:31:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:31:09 INFO - Running setup.py (path:/tmp/pip-cD3rDf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:31:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:31:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:31:10 INFO - Running setup.py (path:/tmp/pip-Rg9eYE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:31:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 11:31:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:31:10 INFO - Running setup.py (path:/tmp/pip-08Q7in-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:31:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:31:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:31:10 INFO - Running setup.py (path:/tmp/pip-XZSAfa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:31:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 11:31:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:31:10 INFO - Running setup.py (path:/tmp/pip-5RqBuI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:31:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 11:31:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:31:10 INFO - Running setup.py (path:/tmp/pip-juLxzY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:31:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 11:31:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:31:10 INFO - Running setup.py (path:/tmp/pip-ee_tc_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:31:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 11:31:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:31:10 INFO - Running setup.py (path:/tmp/pip-1OVvLC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:31:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 11:31:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:31:10 INFO - Running setup.py (path:/tmp/pip-C196hV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:31:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 11:31:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:31:10 INFO - Running setup.py (path:/tmp/pip-2JzlvH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:31:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 11:31:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:31:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:31:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:31:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:31:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:31:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:31:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:31:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:31:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:31:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:31:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:31:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:31:12 INFO - Downloading blessings-1.6.tar.gz 11:31:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:31:12 INFO - Installing collected packages: blessings 11:31:12 INFO - Running setup.py install for blessings 11:31:12 INFO - Successfully installed blessings 11:31:12 INFO - Cleaning up... 11:31:12 INFO - Return code: 0 11:31:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:31:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:31:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:31:13 INFO - Reading from file tmpfile_stdout 11:31:13 INFO - Current package versions: 11:31:13 INFO - argparse == 1.2.1 11:31:13 INFO - blessings == 1.6 11:31:13 INFO - blobuploader == 1.2.4 11:31:13 INFO - docopt == 0.6.1 11:31:13 INFO - manifestparser == 1.1 11:31:13 INFO - mozInstall == 1.12 11:31:13 INFO - mozcrash == 0.17 11:31:13 INFO - mozdebug == 0.1 11:31:13 INFO - mozdevice == 0.48 11:31:13 INFO - mozfile == 1.2 11:31:13 INFO - mozhttpd == 0.7 11:31:13 INFO - mozinfo == 0.9 11:31:13 INFO - mozleak == 0.1 11:31:13 INFO - mozlog == 3.1 11:31:13 INFO - moznetwork == 0.27 11:31:13 INFO - mozprocess == 0.22 11:31:13 INFO - mozprofile == 0.28 11:31:13 INFO - mozrunner == 6.11 11:31:13 INFO - mozscreenshot == 0.1 11:31:13 INFO - mozsystemmonitor == 0.0 11:31:13 INFO - moztest == 0.7 11:31:13 INFO - mozversion == 1.4 11:31:13 INFO - psutil == 3.1.1 11:31:13 INFO - requests == 1.2.3 11:31:13 INFO - wsgiref == 0.1.2 11:31:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:31:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:31:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:31:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:31:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:31:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:31:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:31:13 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 0x7f3ed2e68f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfb79a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1046810>, '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 0x1047710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1047ba0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1461349838.219084-1316521108', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:31:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 11:31:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:31:13 INFO - Using env: {'DISPLAY': ':0', 11:31:13 INFO - 'HOME': '/home/cltbld', 11:31:13 INFO - 'LANG': 'en_US.UTF-8', 11:31:13 INFO - 'LANGUAGE': 'en_US:en', 11:31:13 INFO - 'LOGNAME': 'cltbld', 11:31:13 INFO - 'MAIL': '/var/mail/cltbld', 11:31:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:31:13 INFO - 'MOZ_NO_REMOTE': '1', 11:31:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:31:13 INFO - 'NO_EM_RESTART': '1', 11:31:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:31:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:31:13 INFO - 'PWD': '/builds/slave/test', 11:31:13 INFO - 'SHELL': '/bin/bash', 11:31:13 INFO - 'SHLVL': '1', 11:31:13 INFO - 'TERM': 'linux', 11:31:13 INFO - 'TMOUT': '86400', 11:31:13 INFO - 'USER': 'cltbld', 11:31:13 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1461349838.219084-1316521108', 11:31:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:31:13 INFO - '_': '/tools/buildbot/bin/python'} 11:31:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:31:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:31:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 11:31:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 11:31:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:31:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 11:31:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 11:31:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 11:31:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 11:31:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 11:31:13 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:31:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:31:13 INFO - Cleaning up... 11:31:13 INFO - Return code: 0 11:31:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:31:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:31:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:31:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:31:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:31:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:31:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:31:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3ed2e68f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfb79a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1046810>, '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 0x1047710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1047ba0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1461349838.219084-1316521108', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:31:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:31:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:31:13 INFO - Using env: {'DISPLAY': ':0', 11:31:13 INFO - 'HOME': '/home/cltbld', 11:31:13 INFO - 'LANG': 'en_US.UTF-8', 11:31:13 INFO - 'LANGUAGE': 'en_US:en', 11:31:13 INFO - 'LOGNAME': 'cltbld', 11:31:13 INFO - 'MAIL': '/var/mail/cltbld', 11:31:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:31:13 INFO - 'MOZ_NO_REMOTE': '1', 11:31:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:31:13 INFO - 'NO_EM_RESTART': '1', 11:31:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:31:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:31:13 INFO - 'PWD': '/builds/slave/test', 11:31:13 INFO - 'SHELL': '/bin/bash', 11:31:13 INFO - 'SHLVL': '1', 11:31:13 INFO - 'TERM': 'linux', 11:31:13 INFO - 'TMOUT': '86400', 11:31:13 INFO - 'USER': 'cltbld', 11:31:13 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1461349838.219084-1316521108', 11:31:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:31:13 INFO - '_': '/tools/buildbot/bin/python'} 11:31:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:31:13 INFO - Downloading/unpacking jsonschema 11:31:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:31:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:31:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:31:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:31:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:31:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:31:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:31:15 INFO - Downloading/unpacking functools32 (from jsonschema) 11:31:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:31:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:31:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:31:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:31:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:31:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:31:15 INFO - Downloading functools32-3.2.3-2.tar.gz 11:31:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:31:15 INFO - warning: no files found matching '*.txt' 11:31:15 INFO - no previously-included directories found matching 'build' 11:31:15 INFO - no previously-included directories found matching 'dist' 11:31:15 INFO - no previously-included directories found matching '.git*' 11:31:15 INFO - Installing collected packages: jsonschema, functools32 11:31:15 INFO - Running setup.py install for functools32 11:31:15 INFO - warning: no files found matching '*.txt' 11:31:15 INFO - no previously-included directories found matching 'build' 11:31:15 INFO - no previously-included directories found matching 'dist' 11:31:15 INFO - no previously-included directories found matching '.git*' 11:31:15 INFO - Successfully installed jsonschema functools32 11:31:15 INFO - Cleaning up... 11:31:15 INFO - Return code: 0 11:31:15 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:31: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')]} 11:31:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:31:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:31: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')]} 11:31:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:31:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:31:15 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 0x7f3ed2e68f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfb79a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1046810>, '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 0x1047710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1047ba0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1461349838.219084-1316521108', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:31:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 11:31:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 11:31:15 INFO - Using env: {'DISPLAY': ':0', 11:31:15 INFO - 'HOME': '/home/cltbld', 11:31:15 INFO - 'LANG': 'en_US.UTF-8', 11:31:15 INFO - 'LANGUAGE': 'en_US:en', 11:31:15 INFO - 'LOGNAME': 'cltbld', 11:31:15 INFO - 'MAIL': '/var/mail/cltbld', 11:31:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:31:15 INFO - 'MOZ_NO_REMOTE': '1', 11:31:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:31:15 INFO - 'NO_EM_RESTART': '1', 11:31:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:31:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:31:15 INFO - 'PWD': '/builds/slave/test', 11:31:15 INFO - 'SHELL': '/bin/bash', 11:31:15 INFO - 'SHLVL': '1', 11:31:15 INFO - 'TERM': 'linux', 11:31:15 INFO - 'TMOUT': '86400', 11:31:15 INFO - 'USER': 'cltbld', 11:31:15 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1461349838.219084-1316521108', 11:31:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:31:15 INFO - '_': '/tools/buildbot/bin/python'} 11:31:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:31:16 INFO - Downloading/unpacking flake8 11:31:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:31:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:31:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:31:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:31:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:31:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:31:17 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:31:17 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:31:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:31:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:31:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:31:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:31:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:31:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:31:18 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:31:18 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:31:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:31:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:31:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:31:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:31:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:31:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:31:18 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:31:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:31:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:31:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:31:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:31:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:31:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:31:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:31:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:31:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:31:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:31:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:31:18 INFO - no previously-included directories found matching 'docs/_build' 11:31:18 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:31:18 INFO - Running setup.py install for pep8 11:31:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:31:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:31:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:31:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:31:18 INFO - no previously-included directories found matching 'docs/_build' 11:31:18 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:31:18 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:31:18 INFO - Cleaning up... 11:31:18 INFO - Return code: 0 11:31:18 INFO - Running post-action listener: _resource_record_post_action 11:31:18 INFO - Running post-action listener: _start_resource_monitoring 11:31:18 INFO - Starting resource monitoring. 11:31:18 INFO - ##### 11:31:18 INFO - ##### Running install step. 11:31:18 INFO - ##### 11:31:18 INFO - Running pre-action listener: _resource_record_pre_action 11:31:18 INFO - Running main action method: install 11:31:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:31:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:31:19 INFO - Reading from file tmpfile_stdout 11:31:19 INFO - Detecting whether we're running mozinstall >=1.0... 11:31:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:31:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:31:19 INFO - Reading from file tmpfile_stdout 11:31:19 INFO - Output received: 11:31:19 INFO - Usage: mozinstall [options] installer 11:31:19 INFO - Options: 11:31:19 INFO - -h, --help show this help message and exit 11:31:19 INFO - -d DEST, --destination=DEST 11:31:19 INFO - Directory to install application into. [default: 11:31:19 INFO - "/builds/slave/test"] 11:31:19 INFO - --app=APP Application being installed. [default: firefox] 11:31:19 INFO - mkdir: /builds/slave/test/build/application 11:31:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:31:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 11:31:35 INFO - Reading from file tmpfile_stdout 11:31:35 INFO - Output received: 11:31:35 INFO - /builds/slave/test/build/application/firefox/firefox 11:31:35 INFO - Running post-action listener: _resource_record_post_action 11:31:35 INFO - ##### 11:31:35 INFO - ##### Running run-tests step. 11:31:35 INFO - ##### 11:31:35 INFO - Running pre-action listener: _resource_record_pre_action 11:31:35 INFO - Running main action method: run_tests 11:31:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:31:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:31:35 INFO - Python 2.7.3 11:31:35 INFO - Return code: 0 11:31:35 INFO - grabbing minidump binary from tooltool 11:31: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')]} 11:31:35 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 0x1046810>, '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 0x1047710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1047ba0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:31:35 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 11:31:35 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 11:31:35 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:31:35 INFO - Return code: 0 11:31:35 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:31:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:31:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:31:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:31:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:31:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:31:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:31:36 INFO - Return code: 0 11:31:36 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/Zx-wswNnS1qxZsl05YdR2Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 11:31:36 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/Zx-wswNnS1qxZsl05YdR2Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-068 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 11:31:36 INFO - Using env: {'DISPLAY': ':0', 11:31:36 INFO - 'HOME': '/home/cltbld', 11:31:36 INFO - 'LANG': 'en_US.UTF-8', 11:31:36 INFO - 'LANGUAGE': 'en_US:en', 11:31:36 INFO - 'LOGNAME': 'cltbld', 11:31:36 INFO - 'MAIL': '/var/mail/cltbld', 11:31:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:31:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:31:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:31:36 INFO - 'MOZ_NO_REMOTE': '1', 11:31:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:31:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:31:36 INFO - 'NO_EM_RESTART': '1', 11:31:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:31:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:31:36 INFO - 'PWD': '/builds/slave/test', 11:31:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:31:36 INFO - 'SHELL': '/bin/bash', 11:31:36 INFO - 'SHLVL': '1', 11:31:36 INFO - 'TERM': 'linux', 11:31:36 INFO - 'TMOUT': '86400', 11:31:36 INFO - 'USER': 'cltbld', 11:31:36 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1461349838.219084-1316521108', 11:31:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:31:36 INFO - '_': '/tools/buildbot/bin/python'} 11:31:36 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/Zx-wswNnS1qxZsl05YdR2Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 11:31:37 INFO - mozversion application_buildid: 20160422083248 11:31:37 INFO - mozversion application_changeset: df4e550128b976a664216e57f78f80c36d78f275 11:31:37 INFO - mozversion application_display_name: Nightly 11:31:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:31:37 INFO - mozversion application_name: Firefox 11:31:37 INFO - mozversion application_remotingname: firefox 11:31:37 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:31:37 INFO - mozversion application_vendor: Mozilla 11:31:37 INFO - mozversion application_version: 48.0a1 11:31:37 INFO - mozversion platform_buildid: 20160422083248 11:31:37 INFO - mozversion platform_changeset: df4e550128b976a664216e57f78f80c36d78f275 11:31:37 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:31:37 INFO - mozversion platform_version: 48.0a1 11:31:37 INFO - using testdate: 1461349897 11:31:37 INFO - actual date: 1461349897 11:31:37 INFO - starting webserver on 'localhost:46509' 11:31:37 INFO - SUITE-START | Running 2 tests 11:31:37 INFO - TEST-START | dromaeo_css 11:31:37 INFO - operating with platform_type : linux_ 11:31:37 INFO - Initialising browser for dromaeo_css test... 11:31:37 INFO - TEST-INFO | started process 928 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLuFJyj/profile http://localhost:46509/getInfo.html) 11:31:41 INFO - PROCESS | 928 | __metrics Screen width/height:1600/1200 11:31:41 INFO - PROCESS | 928 | colorDepth:24 11:31:41 INFO - PROCESS | 928 | Browser inner width/height: 1024/697 11:31:41 INFO - PROCESS | 928 | __metrics 11:31:42 ERROR - PROCESS | 928 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 11:31:43 INFO - TEST-INFO | 928: exit 0 11:31:43 INFO - Browser initialized. 11:31:43 INFO - Running cycle 1/1 for dromaeo_css test... 11:31:43 INFO - TEST-INFO | started process 1012 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLuFJyj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:31:54 INFO - PROCESS | 1012 | RSS: Main: 153354240 11:31:54 INFO - PROCESS | 1012 | 11:32:45 INFO - PROCESS | 1012 | 1461349965666 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 11:34:53 INFO - PROCESS | 1012 | Cycle 1(1): loaded http://localhost:46509/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46509/tests/dromaeo/cssquery-ext.html) 11:34:54 INFO - PROCESS | 1012 | RSS: Main: 251080704 11:34:54 INFO - PROCESS | 1012 | 11:37:56 INFO - PROCESS | 1012 | Cycle 1(1): loaded http://localhost:46509/tests/dromaeo/cssquery-ext.html (next: http://localhost:46509/tests/dromaeo/cssquery-jquery.html) 11:37:57 INFO - PROCESS | 1012 | RSS: Main: 237789184 11:37:57 INFO - PROCESS | 1012 | 11:40:59 INFO - PROCESS | 1012 | Cycle 1(1): loaded http://localhost:46509/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46509/tests/dromaeo/cssquery-mootools.html) 11:41:00 INFO - PROCESS | 1012 | RSS: Main: 233803776 11:41:00 INFO - PROCESS | 1012 | 11:44:02 INFO - PROCESS | 1012 | Cycle 1(1): loaded http://localhost:46509/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46509/tests/dromaeo/cssquery-prototype.html) 11:44:02 INFO - PROCESS | 1012 | RSS: Main: 229548032 11:44:02 INFO - PROCESS | 1012 | 11:47:05 INFO - PROCESS | 1012 | Cycle 1(1): loaded http://localhost:46509/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46509/tests/dromaeo/cssquery-yui.html) 11:47:05 INFO - PROCESS | 1012 | RSS: Main: 208527360 11:47:05 INFO - PROCESS | 1012 | 11:50:08 INFO - PROCESS | 1012 | Cycle 1(1): loaded http://localhost:46509/tests/dromaeo/cssquery-yui.html (next: http://localhost:46509/tests/dromaeo/cssquery-dojo.html) 11:50:08 INFO - PROCESS | 1012 | RSS: Main: 276516864 11:50:08 INFO - PROCESS | 1012 | 11:50:08 INFO - PROCESS | 1012 | __start_tp_report 11:50:08 INFO - PROCESS | 1012 | _x_x_mozilla_page_load 11:50:08 INFO - PROCESS | 1012 | _x_x_mozilla_page_load_details 11:50:08 INFO - PROCESS | 1012 | |i|pagename|runs| 11:50:08 INFO - PROCESS | 1012 | |0;dojo.html;3017.1551965449676;3068.509038553832;3096.071178646407;3101.705337992891;3137.639171495278;5054.570361519275;5087.186050231963;5126.154184559543;5134.537891589756;5181.818636347729;5149.40781810092;5205.947940520594;5245.31810864588;5251.133562962106;5259.289995850559;4710.269908164231;4726.527347265281;4731.384919960417;4756.120117778205;4769.284607308914;4673.065386922612;4694.3662605548325;4711.128441238382;4749.6200303975775;4788.616910647157;4677.087967846272;4710.0108977115015;4736;4759.904801903977;4774.069056533977;4637.675362724611;4679.508651591602;4682.882927926795;4683.367745354368;4686.789094490722;4629.166749985001;4649.349091127245;4649.697769644996;4652.023075154221;4656.813727450932;4994.325766021577;5020.171671674206;5029.119904016819;5031.018951304497;5061.392632884041;5424.240606315119;5466.972665136649;5473.890522189574;5479.068558345091;5523.7790488380415;5309.495597918191;5500.917486237709;5510.531604813596;5511.173324001432;5515.448455154493;5168;5185.896282074337;5187.170052791535;5201.5838732901275;5223.059849227137;5636.2391077204875;5661.320641523043;5662.66024038559;5665.348484924204;5706.42935706426;5305.4164041955355;5423.186522021729;5424.159255315432;5444.292242008513;5513.173024046345;5377.4084850666395;5393.865153371197;5396.676199428047;5402.702851343214;5438.129899216186;5380.3274590676165;5381.892362152735;5385.272988146628;5387.542058925035;5413.83758487246;5200;5366.946330536723;5389;5420.864478387993;5443.646162999393;4187.937180942288;4199.538050814469;4201.411802347674;4206.621404073587;4242.639375653042;3770.2647983643474;3792.905177370533;3793.639604237593;3813.6758375537834;3828.8659896903473;5060.7722652480725;5070.822521211814;5152.046871328741;5166.095933211673;5177.249298851645;5415.025295446779;5420.810271640474;5429.212764149176;5436.592255580847;5438.945610543844;5107.489251074863;5126.5898728101665;5127.923081153711;5146.639735218499;5165.328507294103;4637.582617564368;4702.388689470347;4742;4788.7366194859615;4798.160321943646;5565.220869078333;5594.916076258859;5609.102543593087;5614.242077319591;5614.6631202128;5342.465753424626;5453.903073791966;5461.098918678374;5469.644473109235;5476.2333273342565;5647.322321321468;5666.575006874418;5679.971600141973;5720.713964301852;5735.311762588516;5390.757415916371;5429.891402172014;5433.347998240237;5437.673739575638;5439.456054394687;5257.342832145981;5397.379301380392;5498.945010550004;5529.861753456195;5579;5279.604029697711;5312.28284181646;5352.384475785335;5371.973140134274;5399.43305952885;5275.208718692227;5313.468653134656;5343.145096784496;5347.839564813062;5382.461753824743;5159.793608255778;5260.9736951315;5267.394249661184;5275.762590683352;5358.196270559291;5300.946990530199;5302.867428314323;5316.574674026146;5316.734163291897;5360.946390536044;5218.947810521846;5222.582193424441;5225.451327610546;5226.242194881797;5274.7098909560345 11:50:08 INFO - PROCESS | 1012 | |1;ext.html;597.8296185587109;627.6736097229443;633.9334369891161;644.3588629313833;662.8873091574435;30828.229294267654;37827.62172378275;38915.22169556607;39002.414963775496;39050.60949390505;40783;41423.79288103555;41471.17057658853;41486.37770433446;41562.37656435156;7854.921450785505;8601.655933762657;8790.560471976407;8796.25231855293;9946.35348702332;10165.644202452915;10309.793804123912;10322.071013608775;10328.741781455486;10339.069483746462;10267.178625709963;10388.37669739818;10389.220808439359;10390.324628899098;10394.220433467483;10267.127294179967;10317.84523232152;10323;10334.069933705927;10343.069123778858;10210.9489452553;10700.250982431233;10701.83947240792;10703.304285221435;10708.196885233561;40976.180476390604;41793.79103104495;41801.58198418007;41812.163756725;41869.37195942033;3646.6353364663587;3695.9076023099637;3734.7899679946595;4124.608162224584;4359.6026062193405;32134.839325803223;32346.514802277983;32523.6747632523;33458.1635459113;33470;4310.245707001262;4378.5183629800695;4383.452068491439;4386;4397.098594788061;309097;310717;310912.99999999773;311577;311650;34885.476717849255;35621.82189089038;35664.10839729028;58171.70914145402;58449.70775146097;34078.31843363119;34148;34166.82916585401;34189;34224.31551368959;14667.853321466862;14796.408143674347;14812.111273323635;14814.25928703582;14824.851751482347;11780.116491263017;12792.36038198105;12953.676158095934;12968.935155324163;12979.805302920464;8233.259006689306;8250.422470427013;8261.091279959199;8319.251267385964;8323.417360784808;3197.2166819128997;3217.6943190396873;3243.870245190213;3252.6584708605255;3266.8856590019236;1088.374184843718;1188.1860925266221;1213.1811027556364;1227.3556382899048;1242.5961562492225;32717;32990.8350458251;33048.33903321968;33162.83418582891;33807.66192338094;1094.3269889018197;1179.9941000294943;1202.2546021466746;1236.3014896583402;1236.5177580743518;16683.83316166847;16769.664606707796;16950;17109.401170958958;17119.65760684779;434454;442790;442979;444315;445056;53648.39054828361;55451.16823247654;55479.72260138673;55484.72257638686;55559;1235.197121870791;1431.434583339575;1436.8778653814543;1447.609145530722;1488.0402140619456;28389.574156388084;29736.553951690308;29925.251868703457;30046.248843778205;30487.54268685927;47899;48861.75569122132;49033;49048;49332;324749;327062;328541;329637;330481;24947;25132.62301065449;27921.58117628278;28860;29309;45422;45463;45910.31134533051;46462.76768616135;46524.30213546732;38098;38722.419163712;38811;38824.80587597157;39410.40884386794;37385;38302.61697383102;38759.418608721455;39117.608823911396;39624.207515850096;39424.605753943244;39966.600333996284;40359.59640403558;40624.39063413992;40763.592364077165;31705;34172.14569635779;34736.30527389488;34815.65184348124;35105.47341789824;26922;26991.730082698923;27232.183034508995;27318;27413.115835557255 11:50:08 INFO - PROCESS | 1012 | |2;jquery.html;396.944427780111;400.5113761211321;401.3097472347561;410.06096040068246;411.8496748686728;14132.929335353334;17146.314147434103;17952.55118622035;18175.727364089533;18191.818081819194;15070.84929150711;17634.470965871045;18256.269749210016;18327.725084123747;19014.71477927832;5467.753951072192;5604.187392828037;5614.214010038598;5614.747336369853;5637.887242255152;4104.199681062194;5603.579731520132;5940.168376427304;6260.342664020281;6260.467860231885;6187.938120618781;6194.597351172182;6200.441960223579;6219.973704338779;6235.438810507054;5042.697438153704;5344.518993290622;5354.973225133849;5358.866028349284;5361.919571206435;5141.74291285438;5170.896582068338;5181.585473162176;5189.766460509286;5192.7403629818355;20615.175392984263;20649.380518584465;20684.482887927923;21068.20920221783;21070.578588428147;2220.85564438311;2309.5034567568055;2387.4508862961616;2417.5164967006494;2857.39994601134;9660.951695241549;9774.804503909952;10004.799904001879;10075.798484030278;10111.848322275171;1897.6868816645238;1916.597514521952;1952.9815717135184;2022.2416593777334;2024.44327809852;78548;83085.16914830774;83244.58377708134;84164.57917710372;84572;10474.590844105745;10539.473026348653;10742.462876856282;10905.291156074829;11028.28316159447;15412.537623871078;15486.5354039379;15561.299741511659;15591.61020974462;15597.766033509506;7853.175416581291;8036.598170091472;8084.555349455719;8155.79610509742;8312.381599796045;6856.451483881277;7215.927840721631;7837.059552853694;7871.173526779606;8022.438429310009;4373.2565463871215;4394.868153955386;4514.277715565559;4531.546845315442;4647.697899636512;1926.8747531410413;1932.6231384879814;1951.9414417567496;1953.2870502266856;1969.960600788005;975.8389865672085;979.8971108033696;1021.3913086888033;1026.5431882812077;1066.0512144191675;17523.70378814525;17610.38363657266;19152.80847191538;19260.422187334403;19289.228430862888;1055.7413433708791;1057.7249915021996;1068.9732756681144;1074.1192222377576;1107.2194103157256;10083.647072352433;10150.289479736348;10680.04027957611;10826.729331766612;10848.132149428027;493012;495138;500787;509643;515702;95594.5220273908;96712;97176;97216.51391742995;97474;1070.3203465799274;1077.224398433127;1077.7682798198425;1079.9946000270106;1082.2316155529504;17063.91468042652;17304.394346197823;17394;17612.207450664493;17688.64622707513;31888.043358699277;32745.836270818494;37869.81065094657;39044;39661.20677586374;46055.53944460512;47462.76268618635;51441;52874.73562632162;53750.462495374544;8415.579221039046;8475.152484751476;8488.193621605938;8597.656093756179;8788.42875213109;9536.618535258513;13389.531366402129;13392.330383480981;13985.930070349583;14393;11974.341411222467;12233.143679942319;12235.204711693712;12392.472984845788;12520.812187817372;11733.941330293294;11931.821022684493;11931.82102268484;11959.282443053444;12375.938120309342;12195;12270.693232668898;12409.255444673348;12562.937185314015;12743.80884286755;8374.330053595819;8388;8396.37027222973;8467.745967620982;8907.688230911886;11945.343006134399;11989.460474278852;12107.51569937228;12124.75750485003;12215.38923053826 11:50:08 INFO - PROCESS | 1012 | |3;mootools.html;1372.897032722546;1555.3545278709332;1583.0185285123225;1710.5980094677748;1862.3202531076154;7968.880466792995;8309.293710034653;8314.127016663255;8323.54220517872;8331.875021874677;8075.5962201889815;8232.46488978216;8235.464694794835;8241.958790206041;8245.546494942775;1913.9617207655838;2194.7585765565773;2256.176495579114;2267.85258958168;2284.166279308049;2318.6753854460303;2337.6259798432257;2337.6610391493223;2338.4037070546988;2339.2163625185585;2237.19460994042;2266.739324977624;2268.8411811173223;2269.4439862233694;2269.807066399358;1952.4728323352685;2176.7170267865154;2234.4078819112947;2239.261043855524;2239.473723674935;2171.229213629155;2183.683365911934;2184.421128400975;2190.375742913262;2212.314182603398;8029.638666259974;8134.75595732129;8148.144444833267;8156.796080097985;8169.346452283803;4798.256270278112;4948.505149485059;4963.999999999964;4986.925196122061;5000.649954503187;3138.5135304027913;3187.1872672468603;3214.4214041472524;3223.5487031815564;3255.544223808669;1055.1189756553288;1065.9200559958035;1071.0735214039878;1084.4631907205905;1084.7559299157626;10975.560977560888;10984.340939543654;10988.670339889815;10992.560297588087;11004.064654504376;4272.508661503967;4281.764502952367;4462.397576327219;4467.262901621261;4469.061497085583;9612.231021518262;9614;9614.9038509614;9622.326437149472;9636.373635713657;4502.16709908668;5042.3444952156715;5055.747212639353;5076.568491678248;5084;4535.4103966484145;4617.238155704338;4625.791839367236;4640.095181439654;4643.094596553639;3679.1537946272506;3730.7015438764834;3789.3558095123894;3830.540335159743;3833.2525157594;1252.599168266146;1254.7553227120625;1257.7673130470891;1262.8610852806185;1281.3785314122642;997.5211898288862;1009.3086235928413;1018.6943916824923;1021.99489002556;1032.8605638238741;5771.7114144293455;5778.595498315078;5780.439281394;5800.767969281182;5950.851228719317;432.1141659597812;434.59148400503426;435.41654183394405;1018.6027449294781;1019.1642852860583;3739;3803.7827895073865;3808.295465338921;3831.8887522618684;3859.2474467479133;9764.902350976541;10069.899301006895;10103.09072183507;10128.594856205817;10213.540390682438;9683.176929960891;9999.100080992746;10001.24990625706;10049.849252261076;10086.041826026516;7536.660850261642;7657;7673.194314596887;7746.30283274508;7795.571243581544;5634.8027819027775;5867.501262392744;5888.587798854039;5893.116032595145;5963.612365196248;9426.905730942877;9445.574949127169;9554.904450955679;9575.712728618153;9584.329096963425;9085.409448385833;9139.862902056608;9367.5784589695;9444.574994125418;9472.336936414385;6821.965890170517;7022.719091236293;7042.753503627553;7280.1991780903;7493.475456717977;7503.737369192052;7875.803104922194;8101.918980810116;8119.959400202961;8145.348372130097;7266.636668166676;7332.266773322625;7421.369183619453;7473.663685134074;7475.4019678426685;7057.153915623758;7429.294217049372;7451.366633835968;7506.474546781891;7551.282628150537;6486.870262594816;6516.6415847128865;6546.967265163644;6552.08270842092;6553.082568440517;4922.680025798311;4929.901401971869;4937.654364194472;5049.84850454487;5119.923201151912;4919.3604831371695;4929.112759703145;4944.554990050912;5018.598512118949;5094.5669618082875 11:50:08 INFO - PROCESS | 1012 | |4;prototype.html;296.9302213979714;300.9127353067611;302.5189947982707;311.594926595426;312.1867535071139;5701.258836351274;5731.971340143304;5756.107803290492;5778.0466223073145;5783.306003279612;5625.634333768302;5626.240457538231;5629.549636029118;5648.503146666137;5656.1798539211895;4155.4597902272735;4262.041040765818;4274.465691788527;4283.079137985333;4289.978550107261;3960;4312.719673221246;4354.325079612665;4370.8033138508845;4389.31965545341;4301.204277208711;4320.092780516095;4325.762083085429;4328.870133895988;4334.956650433487;4086.7752273624938;4170.270202714512;4309.181255561464;4327.697061205717;4330.285502892019;3759.6240375962457;3781.092537790938;3807.2385522895534;3809.3904975203836;3834.386498160281;5466.426025267369;5499.862503437406;5510.889782204334;5513.862153446155;5530.5022547970875;4819.325294458778;5015.3480047593575;5031.899362012776;5038.571721403685;5038.984406237534;5957.523398128139;6006.669633170174;6008.549358798107;6025.3372129065765;6030.698465076729;4220.07158425146;4223.873283801491;4225.91548169038;4230.027093768451;4239.173361194568;5875.559333049996;6243.43809057187;6281.7173227204885;6303.36966303366;6314.684265786692;4168.812403441852;4169.478815148106;4179.871434712611;4188.895277618084;4192.350185721218;4222.704410691222;4223.472065991751;4229.111886503869;4234.640055595247;4239.1521695660995;4833.492483289274;4898.657094003457;4936.580390666762;4948.426818054591;4967.751612419364;6006.219191505076;6018.879622407528;6030.547708921848;6046.667433291212;6063.333033366326;1507.2840400809528;1529.4493982166634;1530.3725472556198;1532.716447457224;1534.0872181052257;945.3666043750703;976.799756050008;980.4411485453223;986.6891929042472;997.2769741937037;5680.14797780328;5713.74288157034;5728.112142617901;5772.307323121252;5774.162746401832;6114;6176.69116544171;6192.752289908353;6209.6895155242055;6214.751409943642;5630.662160270397;5780.768769249183;5793.986052440806;5808.186853840466;5810.970945145247;3305.7355411567496;3314.453115235959;3314.502824576333;3320.4355259605927;3327.450970589874;6241;6387.393197646216;6403;6404;6415.807525774234;6052.757889684363;6156.753729850845;6266.780662676875;6306.3378345274;6357.268914074848;6361.491080713625;6400.295967443578;6403.4877209824035;6411.519136064814;6423.357664233539;5987.670678112746;6164.599301045418;6169.84575385601;6179.536534759821;6202;6108.694565271808;6114.969425152845;6121.571489995657;6123.4488895999575;6127.142200091902;6388.36116388376;6390.968045159744;6400.775972840928;6401.487880969605;6412.679366031586;3970.50368703912;4034.293998550301;4041.2321658884716;4059.65492933104;4071.877843664695;6140.692965351804;6167.444929956326;6188;6202.72087756043;6224.097505861715;5892.440218179266;5976.3127240366175;6017.157597936205;6022.608530445507;6044.727987240497;5945.34601193877;6009.188759517409;6016.42843929826;6018.969905150446;6030.728617212324;5880.558958078076;5921.549220441019;5923.940760592512;5934.376890426615;5957.063954214811;5804.94195058044;6096.908546371897;6098.268207814913;6124.5406594506485;6131.938680613137;5965.254343207099;5972;5996.910046349395;6006.489448396936;6008.279006519246 11:50:08 INFO - PROCESS | 1012 | |5;yui.html;762.386279045369;841.9242268195862;864.9783755406111;873.8776571280019;876.1501343696616;14300.07049541779;14750.483733069344;14916.40334386626;14961.700765984673;15004.774928376055;13660.590182294522;13730.734428819233;13733.176009439416;13740.106893051945;13748.106373085742;691.3673988300699;807.6688557691348;820.626614890225;838.7609531283586;844.9704260350888;826.3926014379426;838.2455789789177;843.2958479669484;843.3084870406269;844.105248436659;875.5709702245886;879.4679219072465;881.1364862434817;881.9769067881259;884.2881480408269;735.3308489274762;868.3574155125193;877.4559772940786;885.4952676974127;886.813769108488;656.5896314803248;656.701200953565;656.9605823650548;657.0702456024719;657.7599176300664;14076.788848167285;14156.150630962175;14158.29208539569;14176.362063707054;14181.716365672628;14243.572692819233;14250.572482825532;14362.928185359006;14444.855551444456;14525.854741452662;11824.645260642195;11855.407229638484;11913.642590722293;12010.339431331273;12144.453499592451;3883.708721845873;3933.940990885139;3953.1303113315025;3953.2884080865433;4027.234825383168;54635.726821365635;54791.45208547903;55336.16995745067;56868.71565642145;57376;11126.833097503544;11317.320960742381;11451.312921224753;11498.25261358009;11569.42152892352;20683.379498615064;20692.58614827695;20730.06714697842;20738.792612073685;20746.48133796667;8439;8462.703805366782;8592.699255526151;8807.779805504913;8899.421537600036;4717.9292310615365;4790.688605240648;4821.156297647897;4838.516148385133;4862.124817532807;3333.6999670029813;3350.564426624523;3405.8126803025575;3406.2506248625264;3410.35203311375;567.3220501500667;570.4124751505956;572.644960124717;583.6060659055121;584.9151872978395;678.9355011273921;686.8317262270775;696.7213114754139;730.0436428278972;772.3010675338827;9082.36423450352;9091.499967501852;9325.487098209664;9642.42145471274;9735.318527702993;682.2358957967009;720.542455540725;731.2066407947436;746.1084004614542;757.6174032113747;4366.345048242725;4511.917139886469;4571.2000399929875;4605.585497305258;4606.654500912445;52099;53339;53490.73254633702;53579.73210133924;66666;45674.543254567696;46322.768386157855;46766.76616616963;47203.999999999316;47230.05539889183;47347;48090.27864582034;48547.75726121347;48984.02031959341;49648.25527617089;9100.317476189444;9230.676926307548;9259.907400925904;9364.110409511359;9530.85703714431;31777.841110795223;32310.515342270355;32343.676563234065;32397.35205295928;32672.34182941475;39506.40740388954;40400.79799600983;42746.57253427426;46016.30975535436;47165.29252061153;12501.187422817487;12533.435995380047;12586.18189817659;12765.425555849823;12844.871551284368;12900.677483062624;13015.934920325337;13849.653758656113;14007.649808754863;14446.133232006114;13663.521776737767;13745.931270343584;13753.449862005407;13814.723705526034;14092.577222683336;13428.597142085753;13482.93258533701;13565.118267312988;13637.386317615532;14369.64075898111;13447.327633618475;13478.79781803254;14226.786598201243;14251.64370890736;14255.358508866919;10920.563177472812;11335.773284534429;11369.886301136883;11453.484593193492;11784.292942423483;11320.679757257745;11467.770644587228;11543.61476622777;11724.355160466257;11729.882701172879 11:50:08 INFO - PROCESS | 1012 | __end_tp_report 11:50:08 INFO - PROCESS | 1012 | __start_cc_report 11:50:08 INFO - PROCESS | 1012 | _x_x_mozilla_cycle_collect,838 11:50:08 INFO - PROCESS | 1012 | __end_cc_report 11:50:08 INFO - PROCESS | 1012 | __startTimestamp1461351008664__endTimestamp 11:50:08 INFO - PROCESS | 1012 | 11:50:08 INFO - PROCESS | 1012 | ------- Summary: start ------- 11:50:08 INFO - PROCESS | 1012 | Number of tests: 6 11:50:08 INFO - PROCESS | 1012 | 11:50:08 INFO - PROCESS | 1012 | [#0] dojo.html Cycles:165 Average:5087.20 Median:5260.97 stddev:545.79 (10.4%) stddev-sans-first:522.75 11:50:08 INFO - PROCESS | 1012 | Values: 3017.2 3068.5 3096.1 3101.7 3137.6 5054.6 5087.2 5126.2 5134.5 5181.8 5149.4 5205.9 5245.3 5251.1 5259.3 4710.3 4726.5 4731.4 4756.1 4769.3 4673.1 4694.4 4711.1 4749.6 4788.6 4677.1 4710.0 4736.0 4759.9 4774.1 4637.7 4679.5 4682.9 4683.4 4686.8 4629.2 4649.3 4649.7 4652.0 4656.8 4994.3 5020.2 5029.1 5031.0 5061.4 5424.2 5467.0 5473.9 5479.1 5523.8 5309.5 5500.9 5510.5 5511.2 5515.4 5168.0 5185.9 5187.2 5201.6 5223.1 5636.2 5661.3 5662.7 5665.3 5706.4 5305.4 5423.2 5424.2 5444.3 5513.2 5377.4 5393.9 5396.7 5402.7 5438.1 5380.3 5381.9 5385.3 5387.5 5413.8 5200.0 5366.9 5389.0 5420.9 5443.6 4187.9 4199.5 4201.4 4206.6 4242.6 3770.3 3792.9 3793.6 3813.7 3828.9 5060.8 5070.8 5152.0 5166.1 5177.2 5415.0 5420.8 5429.2 5436.6 5438.9 5107.5 5126.6 5127.9 5146.6 5165.3 4637.6 4702.4 4742.0 4788.7 4798.2 5565.2 5594.9 5609.1 5614.2 5614.7 5342.5 5453.9 5461.1 5469.6 5476.2 5647.3 5666.6 5680.0 5720.7 5735.3 5390.8 5429.9 5433.3 5437.7 5439.5 5257.3 5397.4 5498.9 5529.9 5579.0 5279.6 5312.3 5352.4 5372.0 5399.4 5275.2 5313.5 5343.1 5347.8 5382.5 5159.8 5261.0 5267.4 5275.8 5358.2 5300.9 5302.9 5316.6 5316.7 5360.9 5218.9 5222.6 5225.5 5226.2 5274.7 11:50:08 INFO - PROCESS | 1012 | 11:50:08 INFO - PROCESS | 1012 | [#1] ext.html Cycles:180 Average:51399.09 Median:33638.83 stddev:96257.65 (286.2%) stddev-sans-first:96452.11 11:50:08 INFO - PROCESS | 1012 | Values: 597.8 627.7 633.9 644.4 662.9 30828.2 37827.6 38915.2 39002.4 39050.6 40783.0 41423.8 41471.2 41486.4 41562.4 7854.9 8601.7 8790.6 8796.3 9946.4 10165.6 10309.8 10322.1 10328.7 10339.1 10267.2 10388.4 10389.2 10390.3 10394.2 10267.1 10317.8 10323.0 10334.1 10343.1 10210.9 10700.3 10701.8 10703.3 10708.2 40976.2 41793.8 41801.6 41812.2 41869.4 3646.6 3695.9 3734.8 4124.6 4359.6 32134.8 32346.5 32523.7 33458.2 33470.0 4310.2 4378.5 4383.5 4386.0 4397.1 309097.0 310717.0 310913.0 311577.0 311650.0 34885.5 35621.8 35664.1 58171.7 58449.7 34078.3 34148.0 34166.8 34189.0 34224.3 14667.9 14796.4 14812.1 14814.3 14824.9 11780.1 12792.4 12953.7 12968.9 12979.8 8233.3 8250.4 8261.1 8319.3 8323.4 3197.2 3217.7 3243.9 3252.7 3266.9 1088.4 1188.2 1213.2 1227.4 1242.6 32717.0 32990.8 33048.3 33162.8 33807.7 1094.3 1180.0 1202.3 1236.3 1236.5 16683.8 16769.7 16950.0 17109.4 17119.7 434454.0 442790.0 442979.0 444315.0 445056.0 53648.4 55451.2 55479.7 55484.7 55559.0 1235.2 1431.4 1436.9 1447.6 1488.0 28389.6 29736.6 29925.3 30046.2 30487.5 47899.0 48861.8 49033.0 49048.0 49332.0 324749.0 327062.0 328541.0 329637.0 330481.0 24947.0 25132.6 27921.6 28860.0 29309.0 45422.0 45463.0 45910.3 46462.8 46524.3 38098.0 38722.4 38811.0 38824.8 39410.4 37385.0 38302.6 38759.4 39117.6 39624.2 39424.6 39966.6 40359.6 40624.4 40763.6 31705.0 34172.1 34736.3 34815.7 35105.5 26922.0 26991.7 27232.2 27318.0 27413.1 11:50:08 INFO - PROCESS | 1012 | 11:50:08 INFO - PROCESS | 1012 | [#2] jquery.html Cycles:180 Average:28999.64 Median:2265.18 stddev:82934.83 (3661.3%) stddev-sans-first:83139.68 11:50:08 INFO - PROCESS | 1012 | Values: 396.9 400.5 401.3 410.1 411.8 14132.9 17146.3 17952.6 18175.7 18191.8 15070.8 17634.5 18256.3 18327.7 19014.7 5467.8 5604.2 5614.2 5614.7 5637.9 4104.2 5603.6 5940.2 6260.3 6260.5 6187.9 6194.6 6200.4 6220.0 6235.4 5042.7 5344.5 5355.0 5358.9 5361.9 5141.7 5170.9 5181.6 5189.8 5192.7 20615.2 20649.4 20684.5 21068.2 21070.6 2220.9 2309.5 2387.5 2417.5 2857.4 9661.0 9774.8 10004.8 10075.8 10111.8 1897.7 1916.6 1953.0 2022.2 2024.4 78548.0 83085.2 83244.6 84164.6 84572.0 10474.6 10539.5 10742.5 10905.3 11028.3 15412.5 15486.5 15561.3 15591.6 15597.8 7853.2 8036.6 8084.6 8155.8 8312.4 6856.5 7215.9 7837.1 7871.2 8022.4 4373.3 4394.9 4514.3 4531.5 4647.7 1926.9 1932.6 1951.9 1953.3 1970.0 975.8 979.9 1021.4 1026.5 1066.1 17523.7 17610.4 19152.8 19260.4 19289.2 1055.7 1057.7 1069.0 1074.1 1107.2 10083.6 10150.3 10680.0 10826.7 10848.1 493012.0 495138.0 500787.0 509643.0 515702.0 95594.5 96712.0 97176.0 97216.5 97474.0 1070.3 1077.2 1077.8 1080.0 1082.2 17063.9 17304.4 17394.0 17612.2 17688.6 31888.0 32745.8 37869.8 39044.0 39661.2 46055.5 47462.8 51441.0 52874.7 53750.5 8415.6 8475.2 8488.2 8597.7 8788.4 9536.6 13389.5 13392.3 13985.9 14393.0 11974.3 12233.1 12235.2 12392.5 12520.8 11733.9 11931.8 11931.8 11959.3 12375.9 12195.0 12270.7 12409.3 12562.9 12743.8 8374.3 8388.0 8396.4 8467.7 8907.7 11945.3 11989.5 12107.5 12124.8 12215.4 11:50:08 INFO - PROCESS | 1012 | 11:50:08 INFO - PROCESS | 1012 | [#3] mootools.html Cycles:180 Average:5450.28 Median:4929.51 stddev:3019.64 (61.3%) stddev-sans-first:3012.56 11:50:08 INFO - PROCESS | 1012 | Values: 1372.9 1555.4 1583.0 1710.6 1862.3 7968.9 8309.3 8314.1 8323.5 8331.9 8075.6 8232.5 8235.5 8242.0 8245.5 1914.0 2194.8 2256.2 2267.9 2284.2 2318.7 2337.6 2337.7 2338.4 2339.2 2237.2 2266.7 2268.8 2269.4 2269.8 1952.5 2176.7 2234.4 2239.3 2239.5 2171.2 2183.7 2184.4 2190.4 2212.3 8029.6 8134.8 8148.1 8156.8 8169.3 4798.3 4948.5 4964.0 4986.9 5000.6 3138.5 3187.2 3214.4 3223.5 3255.5 1055.1 1065.9 1071.1 1084.5 1084.8 10975.6 10984.3 10988.7 10992.6 11004.1 4272.5 4281.8 4462.4 4467.3 4469.1 9612.2 9614.0 9614.9 9622.3 9636.4 4502.2 5042.3 5055.7 5076.6 5084.0 4535.4 4617.2 4625.8 4640.1 4643.1 3679.2 3730.7 3789.4 3830.5 3833.3 1252.6 1254.8 1257.8 1262.9 1281.4 997.5 1009.3 1018.7 1022.0 1032.9 5771.7 5778.6 5780.4 5800.8 5950.9 432.1 434.6 435.4 1018.6 1019.2 3739.0 3803.8 3808.3 3831.9 3859.2 9764.9 10069.9 10103.1 10128.6 10213.5 9683.2 9999.1 10001.2 10049.8 10086.0 7536.7 7657.0 7673.2 7746.3 7795.6 5634.8 5867.5 5888.6 5893.1 5963.6 9426.9 9445.6 9554.9 9575.7 9584.3 9085.4 9139.9 9367.6 9444.6 9472.3 6822.0 7022.7 7042.8 7280.2 7493.5 7503.7 7875.8 8101.9 8120.0 8145.3 7266.6 7332.3 7421.4 7473.7 7475.4 7057.2 7429.3 7451.4 7506.5 7551.3 6486.9 6516.6 6547.0 6552.1 6553.1 4922.7 4929.9 4937.7 5049.8 5119.9 4919.4 4929.1 4944.6 5018.6 5094.6 11:50:08 INFO - PROCESS | 1012 | 11:50:08 INFO - PROCESS | 1012 | [#4] prototype.html Cycles:180 Average:5005.99 Median:5782.04 stddev:1523.23 (26.3%) stddev-sans-first:1485.93 11:50:08 INFO - PROCESS | 1012 | Values: 296.9 300.9 302.5 311.6 312.2 5701.3 5732.0 5756.1 5778.0 5783.3 5625.6 5626.2 5629.5 5648.5 5656.2 4155.5 4262.0 4274.5 4283.1 4290.0 3960.0 4312.7 4354.3 4370.8 4389.3 4301.2 4320.1 4325.8 4328.9 4335.0 4086.8 4170.3 4309.2 4327.7 4330.3 3759.6 3781.1 3807.2 3809.4 3834.4 5466.4 5499.9 5510.9 5513.9 5530.5 4819.3 5015.3 5031.9 5038.6 5039.0 5957.5 6006.7 6008.5 6025.3 6030.7 4220.1 4223.9 4225.9 4230.0 4239.2 5875.6 6243.4 6281.7 6303.4 6314.7 4168.8 4169.5 4179.9 4188.9 4192.4 4222.7 4223.5 4229.1 4234.6 4239.2 4833.5 4898.7 4936.6 4948.4 4967.8 6006.2 6018.9 6030.5 6046.7 6063.3 1507.3 1529.4 1530.4 1532.7 1534.1 945.4 976.8 980.4 986.7 997.3 5680.1 5713.7 5728.1 5772.3 5774.2 6114.0 6176.7 6192.8 6209.7 6214.8 5630.7 5780.8 5794.0 5808.2 5811.0 3305.7 3314.5 3314.5 3320.4 3327.5 6241.0 6387.4 6403.0 6404.0 6415.8 6052.8 6156.8 6266.8 6306.3 6357.3 6361.5 6400.3 6403.5 6411.5 6423.4 5987.7 6164.6 6169.8 6179.5 6202.0 6108.7 6115.0 6121.6 6123.4 6127.1 6388.4 6391.0 6400.8 6401.5 6412.7 3970.5 4034.3 4041.2 4059.7 4071.9 6140.7 6167.4 6188.0 6202.7 6224.1 5892.4 5976.3 6017.2 6022.6 6044.7 5945.3 6009.2 6016.4 6019.0 6030.7 5880.6 5921.5 5923.9 5934.4 5957.1 5804.9 6096.9 6098.3 6124.5 6131.9 5965.3 5972.0 5996.9 6006.5 6008.3 11:50:08 INFO - PROCESS | 1012 | 11:50:08 INFO - PROCESS | 1012 | [#5] yui.html Cycles:180 Average:14580.18 Median:25122.87 stddev:15924.78 (63.4%) stddev-sans-first:15935.64 11:50:08 INFO - PROCESS | 1012 | Values: 762.4 841.9 865.0 873.9 876.2 14300.1 14750.5 14916.4 14961.7 15004.8 13660.6 13730.7 13733.2 13740.1 13748.1 691.4 807.7 820.6 838.8 845.0 826.4 838.2 843.3 843.3 844.1 875.6 879.5 881.1 882.0 884.3 735.3 868.4 877.5 885.5 886.8 656.6 656.7 657.0 657.1 657.8 14076.8 14156.2 14158.3 14176.4 14181.7 14243.6 14250.6 14362.9 14444.9 14525.9 11824.6 11855.4 11913.6 12010.3 12144.5 3883.7 3933.9 3953.1 3953.3 4027.2 54635.7 54791.5 55336.2 56868.7 57376.0 11126.8 11317.3 11451.3 11498.3 11569.4 20683.4 20692.6 20730.1 20738.8 20746.5 8439.0 8462.7 8592.7 8807.8 8899.4 4717.9 4790.7 4821.2 4838.5 4862.1 3333.7 3350.6 3405.8 3406.3 3410.4 567.3 570.4 572.6 583.6 584.9 678.9 686.8 696.7 730.0 772.3 9082.4 9091.5 9325.5 9642.4 9735.3 682.2 720.5 731.2 746.1 757.6 4366.3 4511.9 4571.2 4605.6 4606.7 52099.0 53339.0 53490.7 53579.7 66666.0 45674.5 46322.8 46766.8 47204.0 47230.1 47347.0 48090.3 48547.8 48984.0 49648.3 9100.3 9230.7 9259.9 9364.1 9530.9 31777.8 32310.5 32343.7 32397.4 32672.3 39506.4 40400.8 42746.6 46016.3 47165.3 12501.2 12533.4 12586.2 12765.4 12844.9 12900.7 13015.9 13849.7 14007.6 14446.1 13663.5 13745.9 13753.4 13814.7 14092.6 13428.6 13482.9 13565.1 13637.4 14369.6 13447.3 13478.8 14226.8 14251.6 14255.4 10920.6 11335.8 11369.9 11453.5 11784.3 11320.7 11467.8 11543.6 11724.4 11729.9 11:50:08 INFO - PROCESS | 1012 | -------- Summary: end -------- 11:50:08 INFO - PROCESS | 1012 | 11:50:09 INFO - TEST-INFO | 1012: exit 0 11:50:09 INFO - TEST-OK | dromaeo_css | took 1112312ms 11:50:09 INFO - TEST-START | kraken 11:50:09 INFO - operating with platform_type : linux_ 11:50:09 INFO - Initialising browser for kraken test... 11:50:09 INFO - TEST-INFO | started process 1279 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0qATVt/profile http://localhost:46509/getInfo.html) 11:50:13 INFO - PROCESS | 1279 | __metrics Screen width/height:1600/1200 11:50:13 INFO - PROCESS | 1279 | colorDepth:24 11:50:13 INFO - PROCESS | 1279 | Browser inner width/height: 1024/697 11:50:13 INFO - PROCESS | 1279 | __metrics 11:50:14 ERROR - PROCESS | 1279 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 11:50:15 INFO - TEST-INFO | 1279: exit 0 11:50:15 INFO - Browser initialized. 11:50:15 INFO - Running cycle 1/1 for kraken test... 11:50:15 INFO - TEST-INFO | started process 1361 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0qATVt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:50:26 INFO - PROCESS | 1361 | RSS: Main: 153833472 11:50:26 INFO - PROCESS | 1361 | 11:50:29 INFO - PROCESS | 1361 | Cycle 1(1): loaded http://localhost:46509/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46509/tests/kraken/driver.html?testName=audio-beat-detection) 11:50:30 INFO - PROCESS | 1361 | RSS: Main: 209219584 11:50:30 INFO - PROCESS | 1361 | 11:50:32 INFO - PROCESS | 1361 | Cycle 1(1): loaded http://localhost:46509/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46509/tests/kraken/driver.html?testName=audio-dft) 11:50:33 INFO - PROCESS | 1361 | RSS: Main: 194220032 11:50:33 INFO - PROCESS | 1361 | 11:50:36 INFO - PROCESS | 1361 | Cycle 1(1): loaded http://localhost:46509/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46509/tests/kraken/driver.html?testName=audio-fft) 11:50:37 INFO - PROCESS | 1361 | RSS: Main: 265408512 11:50:37 INFO - PROCESS | 1361 | 11:50:39 INFO - PROCESS | 1361 | Cycle 1(1): loaded http://localhost:46509/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46509/tests/kraken/driver.html?testName=audio-oscillator) 11:50:39 INFO - PROCESS | 1361 | RSS: Main: 173342720 11:50:39 INFO - PROCESS | 1361 | 11:50:42 INFO - PROCESS | 1361 | Cycle 1(1): loaded http://localhost:46509/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46509/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:50:42 INFO - PROCESS | 1361 | RSS: Main: 177893376 11:50:42 INFO - PROCESS | 1361 | 11:50:45 INFO - PROCESS | 1361 | Cycle 1(1): loaded http://localhost:46509/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46509/tests/kraken/driver.html?testName=imaging-darkroom) 11:50:46 INFO - PROCESS | 1361 | RSS: Main: 214360064 11:50:46 INFO - PROCESS | 1361 | 11:50:49 INFO - PROCESS | 1361 | Cycle 1(1): loaded http://localhost:46509/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46509/tests/kraken/driver.html?testName=imaging-desaturate) 11:50:50 INFO - PROCESS | 1361 | RSS: Main: 214540288 11:50:50 INFO - PROCESS | 1361 | 11:50:52 INFO - PROCESS | 1361 | Cycle 1(1): loaded http://localhost:46509/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46509/tests/kraken/driver.html?testName=json-parse-financial) 11:50:53 INFO - PROCESS | 1361 | RSS: Main: 214224896 11:50:53 INFO - PROCESS | 1361 | 11:50:55 INFO - PROCESS | 1361 | Cycle 1(1): loaded http://localhost:46509/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46509/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:50:55 INFO - PROCESS | 1361 | RSS: Main: 201101312 11:50:55 INFO - PROCESS | 1361 | 11:50:57 INFO - PROCESS | 1361 | Cycle 1(1): loaded http://localhost:46509/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46509/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:50:58 INFO - PROCESS | 1361 | RSS: Main: 203984896 11:50:58 INFO - PROCESS | 1361 | 11:50:59 INFO - PROCESS | 1361 | Cycle 1(1): loaded http://localhost:46509/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46509/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:51:00 INFO - PROCESS | 1361 | RSS: Main: 214691840 11:51:00 INFO - PROCESS | 1361 | 11:51:03 INFO - PROCESS | 1361 | Cycle 1(1): loaded http://localhost:46509/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46509/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:51:03 INFO - PROCESS | 1361 | RSS: Main: 223485952 11:51:03 INFO - PROCESS | 1361 | 11:51:06 INFO - PROCESS | 1361 | Cycle 1(1): loaded http://localhost:46509/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46509/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:51:07 INFO - PROCESS | 1361 | RSS: Main: 221458432 11:51:07 INFO - PROCESS | 1361 | 11:51:08 INFO - PROCESS | 1361 | Cycle 1(1): loaded http://localhost:46509/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46509/tests/kraken/driver.html?testName=ai-astar) 11:51:09 INFO - PROCESS | 1361 | RSS: Main: 284909568 11:51:09 INFO - PROCESS | 1361 | 11:51:09 INFO - PROCESS | 1361 | __start_tp_report 11:51:09 INFO - PROCESS | 1361 | _x_x_mozilla_page_load 11:51:09 INFO - PROCESS | 1361 | _x_x_mozilla_page_load_details 11:51:09 INFO - PROCESS | 1361 | |i|pagename|runs| 11:51:09 INFO - PROCESS | 1361 | |0;ai-astar;112;113;108;112;112;113;104;114;114;112 11:51:09 INFO - PROCESS | 1361 | |1;audio-beat-detection;155;127;158;179;129;160;165;126;200;124 11:51:09 INFO - PROCESS | 1361 | |2;audio-dft;162;162;162;161;160;161;163;161;160;162 11:51:09 INFO - PROCESS | 1361 | |3;audio-fft;73;76;134;112;74;73;74;128;101;76 11:51:09 INFO - PROCESS | 1361 | |4;audio-oscillator;94;92;154;92;93;92;141;93;92;153 11:51:09 INFO - PROCESS | 1361 | |5;imaging-gaussian-blur;116;117;116;117;116;117;118;117;116;117 11:51:09 INFO - PROCESS | 1361 | |6;imaging-darkroom;146;146;146;147;145;145;145;146;145;145 11:51:09 INFO - PROCESS | 1361 | |7;imaging-desaturate;95;94;95;95;95;94;94;95;94;94 11:51:09 INFO - PROCESS | 1361 | |8;json-parse-financial;56;57;56;55;57;56;58;76;55;53 11:51:09 INFO - PROCESS | 1361 | |9;json-stringify-tinderbox;61;61;61;60;61;61;61;61;61;62 11:51:09 INFO - PROCESS | 1361 | |10;stanford-crypto-aes;76;76;77;76;76;76;76;78;77;80 11:51:09 INFO - PROCESS | 1361 | |11;stanford-crypto-ccm;125;130;131;124;124;131;133;131;167;125 11:51:09 INFO - PROCESS | 1361 | |12;stanford-crypto-pbkdf2;168;168;166;173;166;167;170;163;161;168 11:51:09 INFO - PROCESS | 1361 | |13;stanford-crypto-sha256-iterative;68;68;69;69;67;66;68;68;68;67 11:51:09 INFO - PROCESS | 1361 | __end_tp_report 11:51:09 INFO - PROCESS | 1361 | __start_cc_report 11:51:09 INFO - PROCESS | 1361 | _x_x_mozilla_cycle_collect,1618 11:51:09 INFO - PROCESS | 1361 | __end_cc_report 11:51:09 INFO - PROCESS | 1361 | __startTimestamp1461351069198__endTimestamp 11:51:09 INFO - PROCESS | 1361 | 11:51:09 INFO - PROCESS | 1361 | ------- Summary: start ------- 11:51:09 INFO - PROCESS | 1361 | Number of tests: 14 11:51:09 INFO - PROCESS | 1361 | 11:51:09 INFO - PROCESS | 1361 | [#0] ai-astar Cycles:10 Average:111.40 Median:112.50 stddev:3.10 (2.8%) stddev-sans-first:3.28 11:51:09 INFO - PROCESS | 1361 | Values: 112.0 113.0 108.0 112.0 112.0 113.0 104.0 114.0 114.0 112.0 11:51:09 INFO - PROCESS | 1361 | 11:51:09 INFO - PROCESS | 1361 | [#1] audio-beat-detection Cycles:10 Average:152.30 Median:159.00 stddev:25.66 (16.1%) stddev-sans-first:27.19 11:51:09 INFO - PROCESS | 1361 | Values: 155.0 127.0 158.0 179.0 129.0 160.0 165.0 126.0 200.0 124.0 11:51:09 INFO - PROCESS | 1361 | 11:51:09 INFO - PROCESS | 1361 | [#2] audio-dft Cycles:10 Average:161.40 Median:162.00 stddev:0.97 (0.6%) stddev-sans-first:1.00 11:51:09 INFO - PROCESS | 1361 | Values: 162.0 162.0 162.0 161.0 160.0 161.0 163.0 161.0 160.0 162.0 11:51:09 INFO - PROCESS | 1361 | 11:51:09 INFO - PROCESS | 1361 | [#3] audio-fft Cycles:10 Average:92.10 Median:73.50 stddev:24.55 (33.4%) stddev-sans-first:25.04 11:51:09 INFO - PROCESS | 1361 | Values: 73.0 76.0 134.0 112.0 74.0 73.0 74.0 128.0 101.0 76.0 11:51:09 INFO - PROCESS | 1361 | 11:51:09 INFO - PROCESS | 1361 | [#4] audio-oscillator Cycles:10 Average:109.60 Median:92.00 stddev:27.64 (30.0%) stddev-sans-first:28.73 11:51:09 INFO - PROCESS | 1361 | Values: 94.0 92.0 154.0 92.0 93.0 92.0 141.0 93.0 92.0 153.0 11:51:09 INFO - PROCESS | 1361 | 11:51:09 INFO - PROCESS | 1361 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.67 11:51:09 INFO - PROCESS | 1361 | Values: 116.0 117.0 116.0 117.0 116.0 117.0 118.0 117.0 116.0 117.0 11:51:09 INFO - PROCESS | 1361 | 11:51:09 INFO - PROCESS | 1361 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 11:51:09 INFO - PROCESS | 1361 | Values: 146.0 146.0 146.0 147.0 145.0 145.0 145.0 146.0 145.0 145.0 11:51:09 INFO - PROCESS | 1361 | 11:51:09 INFO - PROCESS | 1361 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:95.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 11:51:09 INFO - PROCESS | 1361 | Values: 95.0 94.0 95.0 95.0 95.0 94.0 94.0 95.0 94.0 94.0 11:51:09 INFO - PROCESS | 1361 | 11:51:09 INFO - PROCESS | 1361 | [#8] json-parse-financial Cycles:10 Average:57.90 Median:56.50 stddev:6.51 (11.5%) stddev-sans-first:6.86 11:51:09 INFO - PROCESS | 1361 | Values: 56.0 57.0 56.0 55.0 57.0 56.0 58.0 76.0 55.0 53.0 11:51:09 INFO - PROCESS | 1361 | 11:51:09 INFO - PROCESS | 1361 | [#9] json-stringify-tinderbox Cycles:10 Average:61.00 Median:61.00 stddev:0.47 (0.8%) stddev-sans-first:0.50 11:51:09 INFO - PROCESS | 1361 | Values: 61.0 61.0 61.0 60.0 61.0 61.0 61.0 61.0 61.0 62.0 11:51:09 INFO - PROCESS | 1361 | 11:51:09 INFO - PROCESS | 1361 | [#10] stanford-crypto-aes Cycles:10 Average:76.80 Median:76.50 stddev:1.32 (1.7%) stddev-sans-first:1.36 11:51:09 INFO - PROCESS | 1361 | Values: 76.0 76.0 77.0 76.0 76.0 76.0 76.0 78.0 77.0 80.0 11:51:09 INFO - PROCESS | 1361 | 11:51:09 INFO - PROCESS | 1361 | [#11] stanford-crypto-ccm Cycles:10 Average:132.10 Median:131.00 stddev:12.73 (9.7%) stddev-sans-first:13.24 11:51:09 INFO - PROCESS | 1361 | Values: 125.0 130.0 131.0 124.0 124.0 131.0 133.0 131.0 167.0 125.0 11:51:09 INFO - PROCESS | 1361 | 11:51:09 INFO - PROCESS | 1361 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.00 Median:168.00 stddev:3.37 (2.0%) stddev-sans-first:3.55 11:51:09 INFO - PROCESS | 1361 | Values: 168.0 168.0 166.0 173.0 166.0 167.0 170.0 163.0 161.0 168.0 11:51:09 INFO - PROCESS | 1361 | 11:51:09 INFO - PROCESS | 1361 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.80 Median:68.00 stddev:0.92 (1.4%) stddev-sans-first:0.97 11:51:09 INFO - PROCESS | 1361 | Values: 68.0 68.0 69.0 69.0 67.0 66.0 68.0 68.0 68.0 67.0 11:51:09 INFO - PROCESS | 1361 | -------- Summary: end -------- 11:51:09 INFO - PROCESS | 1361 | 11:51:10 INFO - TEST-INFO | 1361: exit 0 11:51:10 INFO - TEST-OK | kraken | took 60777ms 11:51:10 INFO - SUITE-END | took 1173s 11:51:10 INFO - Completed test suite (00:19:33) 11:51:10 INFO - javascript benchmark 11:51:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3017.1551965449676, 3068.509038553832, 3096.071178646407, 3101.705337992891, 3137.639171495278, 5054.570361519275, 5087.186050231963, 5126.154184559543, 5134.537891589756, 5181.818636347729, 5149.40781810092, 5205.947940520594, 5245.31810864588, 5251.133562962106, 5259.289995850559, 4710.269908164231, 4726.527347265281, 4731.384919960417, 4756.120117778205, 4769.284607308914, 4673.065386922612, 4694.3662605548325, 4711.128441238382, 4749.6200303975775, 4788.616910647157, 4677.087967846272, 4710.0108977115015, 4736.0, 4759.904801903977, 4774.069056533977, 4637.675362724611, 4679.508651591602, 4682.882927926795, 4683.367745354368, 4686.789094490722, 4629.166749985001, 4649.349091127245, 4649.697769644996, 4652.023075154221, 4656.813727450932, 4994.325766021577, 5020.171671674206, 5029.119904016819, 5031.018951304497, 5061.392632884041, 5424.240606315119, 5466.972665136649, 5473.890522189574, 5479.068558345091, 5523.7790488380415, 5309.495597918191, 5500.917486237709, 5510.531604813596, 5511.173324001432, 5515.448455154493, 5168.0, 5185.896282074337, 5187.170052791535, 5201.5838732901275, 5223.059849227137, 5636.2391077204875, 5661.320641523043, 5662.66024038559, 5665.348484924204, 5706.42935706426, 5305.4164041955355, 5423.186522021729, 5424.159255315432, 5444.292242008513, 5513.173024046345, 5377.4084850666395, 5393.865153371197, 5396.676199428047, 5402.702851343214, 5438.129899216186, 5380.3274590676165, 5381.892362152735, 5385.272988146628, 5387.542058925035, 5413.83758487246, 5200.0, 5366.946330536723, 5389.0, 5420.864478387993, 5443.646162999393, 4187.937180942288, 4199.538050814469, 4201.411802347674, 4206.621404073587, 4242.639375653042, 3770.2647983643474, 3792.905177370533, 3793.639604237593, 3813.6758375537834, 3828.8659896903473, 5060.7722652480725, 5070.822521211814, 5152.046871328741, 5166.095933211673, 5177.249298851645, 5415.025295446779, 5420.810271640474, 5429.212764149176, 5436.592255580847, 5438.945610543844, 5107.489251074863, 5126.5898728101665, 5127.923081153711, 5146.639735218499, 5165.328507294103, 4637.582617564368, 4702.388689470347, 4742.0, 4788.7366194859615, 4798.160321943646, 5565.220869078333, 5594.916076258859, 5609.102543593087, 5614.242077319591, 5614.6631202128, 5342.465753424626, 5453.903073791966, 5461.098918678374, 5469.644473109235, 5476.2333273342565, 5647.322321321468, 5666.575006874418, 5679.971600141973, 5720.713964301852, 5735.311762588516, 5390.757415916371, 5429.891402172014, 5433.347998240237, 5437.673739575638, 5439.456054394687, 5257.342832145981, 5397.379301380392, 5498.945010550004, 5529.861753456195, 5579.0, 5279.604029697711, 5312.28284181646, 5352.384475785335, 5371.973140134274, 5399.43305952885, 5275.208718692227, 5313.468653134656, 5343.145096784496, 5347.839564813062, 5382.461753824743, 5159.793608255778, 5260.9736951315, 5267.394249661184, 5275.762590683352, 5358.196270559291, 5300.946990530199, 5302.867428314323, 5316.574674026146, 5316.734163291897, 5360.946390536044, 5218.947810521846, 5222.582193424441, 5225.451327610546, 5226.242194881797, 5274.7098909560345], "value": 5052.801562693066, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [597.8296185587109, 627.6736097229443, 633.9334369891161, 644.3588629313833, 662.8873091574435, 30828.229294267654, 37827.62172378275, 38915.22169556607, 39002.414963775496, 39050.60949390505, 40783.0, 41423.79288103555, 41471.17057658853, 41486.37770433446, 41562.37656435156, 7854.921450785505, 8601.655933762657, 8790.560471976407, 8796.25231855293, 9946.35348702332, 10165.644202452915, 10309.793804123912, 10322.071013608775, 10328.741781455486, 10339.069483746462, 10267.178625709963, 10388.37669739818, 10389.220808439359, 10390.324628899098, 10394.220433467483, 10267.127294179967, 10317.84523232152, 10323.0, 10334.069933705927, 10343.069123778858, 10210.9489452553, 10700.250982431233, 10701.83947240792, 10703.304285221435, 10708.196885233561, 40976.180476390604, 41793.79103104495, 41801.58198418007, 41812.163756725, 41869.37195942033, 3646.6353364663587, 3695.9076023099637, 3734.7899679946595, 4124.608162224584, 4359.6026062193405, 32134.839325803223, 32346.514802277983, 32523.6747632523, 33458.1635459113, 33470.0, 4310.245707001262, 4378.5183629800695, 4383.452068491439, 4386.0, 4397.098594788061, 309097.0, 310717.0, 310912.99999999773, 311577.0, 311650.0, 34885.476717849255, 35621.82189089038, 35664.10839729028, 58171.70914145402, 58449.70775146097, 34078.31843363119, 34148.0, 34166.82916585401, 34189.0, 34224.31551368959, 14667.853321466862, 14796.408143674347, 14812.111273323635, 14814.25928703582, 14824.851751482347, 11780.116491263017, 12792.36038198105, 12953.676158095934, 12968.935155324163, 12979.805302920464, 8233.259006689306, 8250.422470427013, 8261.091279959199, 8319.251267385964, 8323.417360784808, 3197.2166819128997, 3217.6943190396873, 3243.870245190213, 3252.6584708605255, 3266.8856590019236, 1088.374184843718, 1188.1860925266221, 1213.1811027556364, 1227.3556382899048, 1242.5961562492225, 32717.0, 32990.8350458251, 33048.33903321968, 33162.83418582891, 33807.66192338094, 1094.3269889018197, 1179.9941000294943, 1202.2546021466746, 1236.3014896583402, 1236.5177580743518, 16683.83316166847, 16769.664606707796, 16950.0, 17109.401170958958, 17119.65760684779, 434454.0, 442790.0, 442979.0, 444315.0, 445056.0, 53648.39054828361, 55451.16823247654, 55479.72260138673, 55484.72257638686, 55559.0, 1235.197121870791, 1431.434583339575, 1436.8778653814543, 1447.609145530722, 1488.0402140619456, 28389.574156388084, 29736.553951690308, 29925.251868703457, 30046.248843778205, 30487.54268685927, 47899.0, 48861.75569122132, 49033.0, 49048.0, 49332.0, 324749.0, 327062.0, 328541.0, 329637.0, 330481.0, 24947.0, 25132.62301065449, 27921.58117628278, 28860.0, 29309.0, 45422.0, 45463.0, 45910.31134533051, 46462.76768616135, 46524.30213546732, 38098.0, 38722.419163712, 38811.0, 38824.80587597157, 39410.40884386794, 37385.0, 38302.61697383102, 38759.418608721455, 39117.608823911396, 39624.207515850096, 39424.605753943244, 39966.600333996284, 40359.59640403558, 40624.39063413992, 40763.592364077165, 31705.0, 34172.14569635779, 34736.30527389488, 34815.65184348124, 35105.47341789824, 26922.0, 26991.730082698923, 27232.183034508995, 27318.0, 27413.115835557255], "value": 18601.712096873962, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [396.944427780111, 400.5113761211321, 401.3097472347561, 410.06096040068246, 411.8496748686728, 14132.929335353334, 17146.314147434103, 17952.55118622035, 18175.727364089533, 18191.818081819194, 15070.84929150711, 17634.470965871045, 18256.269749210016, 18327.725084123747, 19014.71477927832, 5467.753951072192, 5604.187392828037, 5614.214010038598, 5614.747336369853, 5637.887242255152, 4104.199681062194, 5603.579731520132, 5940.168376427304, 6260.342664020281, 6260.467860231885, 6187.938120618781, 6194.597351172182, 6200.441960223579, 6219.973704338779, 6235.438810507054, 5042.697438153704, 5344.518993290622, 5354.973225133849, 5358.866028349284, 5361.919571206435, 5141.74291285438, 5170.896582068338, 5181.585473162176, 5189.766460509286, 5192.7403629818355, 20615.175392984263, 20649.380518584465, 20684.482887927923, 21068.20920221783, 21070.578588428147, 2220.85564438311, 2309.5034567568055, 2387.4508862961616, 2417.5164967006494, 2857.39994601134, 9660.951695241549, 9774.804503909952, 10004.799904001879, 10075.798484030278, 10111.848322275171, 1897.6868816645238, 1916.597514521952, 1952.9815717135184, 2022.2416593777334, 2024.44327809852, 78548.0, 83085.16914830774, 83244.58377708134, 84164.57917710372, 84572.0, 10474.590844105745, 10539.473026348653, 10742.462876856282, 10905.291156074829, 11028.28316159447, 15412.537623871078, 15486.5354039379, 15561.299741511659, 15591.61020974462, 15597.766033509506, 7853.175416581291, 8036.598170091472, 8084.555349455719, 8155.79610509742, 8312.381599796045, 6856.451483881277, 7215.927840721631, 7837.059552853694, 7871.173526779606, 8022.438429310009, 4373.2565463871215, 4394.868153955386, 4514.277715565559, 4531.546845315442, 4647.697899636512, 1926.8747531410413, 1932.6231384879814, 1951.9414417567496, 1953.2870502266856, 1969.960600788005, 975.8389865672085, 979.8971108033696, 1021.3913086888033, 1026.5431882812077, 1066.0512144191675, 17523.70378814525, 17610.38363657266, 19152.80847191538, 19260.422187334403, 19289.228430862888, 1055.7413433708791, 1057.7249915021996, 1068.9732756681144, 1074.1192222377576, 1107.2194103157256, 10083.647072352433, 10150.289479736348, 10680.04027957611, 10826.729331766612, 10848.132149428027, 493012.0, 495138.0, 500787.0, 509643.0, 515702.0, 95594.5220273908, 96712.0, 97176.0, 97216.51391742995, 97474.0, 1070.3203465799274, 1077.224398433127, 1077.7682798198425, 1079.9946000270106, 1082.2316155529504, 17063.91468042652, 17304.394346197823, 17394.0, 17612.207450664493, 17688.64622707513, 31888.043358699277, 32745.836270818494, 37869.81065094657, 39044.0, 39661.20677586374, 46055.53944460512, 47462.76268618635, 51441.0, 52874.73562632162, 53750.462495374544, 8415.579221039046, 8475.152484751476, 8488.193621605938, 8597.656093756179, 8788.42875213109, 9536.618535258513, 13389.531366402129, 13392.330383480981, 13985.930070349583, 14393.0, 11974.341411222467, 12233.143679942319, 12235.204711693712, 12392.472984845788, 12520.812187817372, 11733.941330293294, 11931.821022684493, 11931.82102268484, 11959.282443053444, 12375.938120309342, 12195.0, 12270.693232668898, 12409.255444673348, 12562.937185314015, 12743.80884286755, 8374.330053595819, 8388.0, 8396.37027222973, 8467.745967620982, 8907.688230911886, 11945.343006134399, 11989.460474278852, 12107.51569937228, 12124.75750485003, 12215.38923053826], "value": 9113.143683047514, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1372.897032722546, 1555.3545278709332, 1583.0185285123225, 1710.5980094677748, 1862.3202531076154, 7968.880466792995, 8309.293710034653, 8314.127016663255, 8323.54220517872, 8331.875021874677, 8075.5962201889815, 8232.46488978216, 8235.464694794835, 8241.958790206041, 8245.546494942775, 1913.9617207655838, 2194.7585765565773, 2256.176495579114, 2267.85258958168, 2284.166279308049, 2318.6753854460303, 2337.6259798432257, 2337.6610391493223, 2338.4037070546988, 2339.2163625185585, 2237.19460994042, 2266.739324977624, 2268.8411811173223, 2269.4439862233694, 2269.807066399358, 1952.4728323352685, 2176.7170267865154, 2234.4078819112947, 2239.261043855524, 2239.473723674935, 2171.229213629155, 2183.683365911934, 2184.421128400975, 2190.375742913262, 2212.314182603398, 8029.638666259974, 8134.75595732129, 8148.144444833267, 8156.796080097985, 8169.346452283803, 4798.256270278112, 4948.505149485059, 4963.999999999964, 4986.925196122061, 5000.649954503187, 3138.5135304027913, 3187.1872672468603, 3214.4214041472524, 3223.5487031815564, 3255.544223808669, 1055.1189756553288, 1065.9200559958035, 1071.0735214039878, 1084.4631907205905, 1084.7559299157626, 10975.560977560888, 10984.340939543654, 10988.670339889815, 10992.560297588087, 11004.064654504376, 4272.508661503967, 4281.764502952367, 4462.397576327219, 4467.262901621261, 4469.061497085583, 9612.231021518262, 9614.0, 9614.9038509614, 9622.326437149472, 9636.373635713657, 4502.16709908668, 5042.3444952156715, 5055.747212639353, 5076.568491678248, 5084.0, 4535.4103966484145, 4617.238155704338, 4625.791839367236, 4640.095181439654, 4643.094596553639, 3679.1537946272506, 3730.7015438764834, 3789.3558095123894, 3830.540335159743, 3833.2525157594, 1252.599168266146, 1254.7553227120625, 1257.7673130470891, 1262.8610852806185, 1281.3785314122642, 997.5211898288862, 1009.3086235928413, 1018.6943916824923, 1021.99489002556, 1032.8605638238741, 5771.7114144293455, 5778.595498315078, 5780.439281394, 5800.767969281182, 5950.851228719317, 432.1141659597812, 434.59148400503426, 435.41654183394405, 1018.6027449294781, 1019.1642852860583, 3739.0, 3803.7827895073865, 3808.295465338921, 3831.8887522618684, 3859.2474467479133, 9764.902350976541, 10069.899301006895, 10103.09072183507, 10128.594856205817, 10213.540390682438, 9683.176929960891, 9999.100080992746, 10001.24990625706, 10049.849252261076, 10086.041826026516, 7536.660850261642, 7657.0, 7673.194314596887, 7746.30283274508, 7795.571243581544, 5634.8027819027775, 5867.501262392744, 5888.587798854039, 5893.116032595145, 5963.612365196248, 9426.905730942877, 9445.574949127169, 9554.904450955679, 9575.712728618153, 9584.329096963425, 9085.409448385833, 9139.862902056608, 9367.5784589695, 9444.574994125418, 9472.336936414385, 6821.965890170517, 7022.719091236293, 7042.753503627553, 7280.1991780903, 7493.475456717977, 7503.737369192052, 7875.803104922194, 8101.918980810116, 8119.959400202961, 8145.348372130097, 7266.636668166676, 7332.266773322625, 7421.369183619453, 7473.663685134074, 7475.4019678426685, 7057.153915623758, 7429.294217049372, 7451.366633835968, 7506.474546781891, 7551.282628150537, 6486.870262594816, 6516.6415847128865, 6546.967265163644, 6552.08270842092, 6553.082568440517, 4922.680025798311, 4929.901401971869, 4937.654364194472, 5049.84850454487, 5119.923201151912, 4919.3604831371695, 4929.112759703145, 4944.554990050912, 5018.598512118949, 5094.5669618082875], "value": 4382.284703465709, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [296.9302213979714, 300.9127353067611, 302.5189947982707, 311.594926595426, 312.1867535071139, 5701.258836351274, 5731.971340143304, 5756.107803290492, 5778.0466223073145, 5783.306003279612, 5625.634333768302, 5626.240457538231, 5629.549636029118, 5648.503146666137, 5656.1798539211895, 4155.4597902272735, 4262.041040765818, 4274.465691788527, 4283.079137985333, 4289.978550107261, 3960.0, 4312.719673221246, 4354.325079612665, 4370.8033138508845, 4389.31965545341, 4301.204277208711, 4320.092780516095, 4325.762083085429, 4328.870133895988, 4334.956650433487, 4086.7752273624938, 4170.270202714512, 4309.181255561464, 4327.697061205717, 4330.285502892019, 3759.6240375962457, 3781.092537790938, 3807.2385522895534, 3809.3904975203836, 3834.386498160281, 5466.426025267369, 5499.862503437406, 5510.889782204334, 5513.862153446155, 5530.5022547970875, 4819.325294458778, 5015.3480047593575, 5031.899362012776, 5038.571721403685, 5038.984406237534, 5957.523398128139, 6006.669633170174, 6008.549358798107, 6025.3372129065765, 6030.698465076729, 4220.07158425146, 4223.873283801491, 4225.91548169038, 4230.027093768451, 4239.173361194568, 5875.559333049996, 6243.43809057187, 6281.7173227204885, 6303.36966303366, 6314.684265786692, 4168.812403441852, 4169.478815148106, 4179.871434712611, 4188.895277618084, 4192.350185721218, 4222.704410691222, 4223.472065991751, 4229.111886503869, 4234.640055595247, 4239.1521695660995, 4833.492483289274, 4898.657094003457, 4936.580390666762, 4948.426818054591, 4967.751612419364, 6006.219191505076, 6018.879622407528, 6030.547708921848, 6046.667433291212, 6063.333033366326, 1507.2840400809528, 1529.4493982166634, 1530.3725472556198, 1532.716447457224, 1534.0872181052257, 945.3666043750703, 976.799756050008, 980.4411485453223, 986.6891929042472, 997.2769741937037, 5680.14797780328, 5713.74288157034, 5728.112142617901, 5772.307323121252, 5774.162746401832, 6114.0, 6176.69116544171, 6192.752289908353, 6209.6895155242055, 6214.751409943642, 5630.662160270397, 5780.768769249183, 5793.986052440806, 5808.186853840466, 5810.970945145247, 3305.7355411567496, 3314.453115235959, 3314.502824576333, 3320.4355259605927, 3327.450970589874, 6241.0, 6387.393197646216, 6403.0, 6404.0, 6415.807525774234, 6052.757889684363, 6156.753729850845, 6266.780662676875, 6306.3378345274, 6357.268914074848, 6361.491080713625, 6400.295967443578, 6403.4877209824035, 6411.519136064814, 6423.357664233539, 5987.670678112746, 6164.599301045418, 6169.84575385601, 6179.536534759821, 6202.0, 6108.694565271808, 6114.969425152845, 6121.571489995657, 6123.4488895999575, 6127.142200091902, 6388.36116388376, 6390.968045159744, 6400.775972840928, 6401.487880969605, 6412.679366031586, 3970.50368703912, 4034.293998550301, 4041.2321658884716, 4059.65492933104, 4071.877843664695, 6140.692965351804, 6167.444929956326, 6188.0, 6202.72087756043, 6224.097505861715, 5892.440218179266, 5976.3127240366175, 6017.157597936205, 6022.608530445507, 6044.727987240497, 5945.34601193877, 6009.188759517409, 6016.42843929826, 6018.969905150446, 6030.728617212324, 5880.558958078076, 5921.549220441019, 5923.940760592512, 5934.376890426615, 5957.063954214811, 5804.94195058044, 6096.908546371897, 6098.268207814913, 6124.5406594506485, 6131.938680613137, 5965.254343207099, 5972.0, 5996.910046349395, 6006.489448396936, 6008.279006519246], "value": 4504.286169372147, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [762.386279045369, 841.9242268195862, 864.9783755406111, 873.8776571280019, 876.1501343696616, 14300.07049541779, 14750.483733069344, 14916.40334386626, 14961.700765984673, 15004.774928376055, 13660.590182294522, 13730.734428819233, 13733.176009439416, 13740.106893051945, 13748.106373085742, 691.3673988300699, 807.6688557691348, 820.626614890225, 838.7609531283586, 844.9704260350888, 826.3926014379426, 838.2455789789177, 843.2958479669484, 843.3084870406269, 844.105248436659, 875.5709702245886, 879.4679219072465, 881.1364862434817, 881.9769067881259, 884.2881480408269, 735.3308489274762, 868.3574155125193, 877.4559772940786, 885.4952676974127, 886.813769108488, 656.5896314803248, 656.701200953565, 656.9605823650548, 657.0702456024719, 657.7599176300664, 14076.788848167285, 14156.150630962175, 14158.29208539569, 14176.362063707054, 14181.716365672628, 14243.572692819233, 14250.572482825532, 14362.928185359006, 14444.855551444456, 14525.854741452662, 11824.645260642195, 11855.407229638484, 11913.642590722293, 12010.339431331273, 12144.453499592451, 3883.708721845873, 3933.940990885139, 3953.1303113315025, 3953.2884080865433, 4027.234825383168, 54635.726821365635, 54791.45208547903, 55336.16995745067, 56868.71565642145, 57376.0, 11126.833097503544, 11317.320960742381, 11451.312921224753, 11498.25261358009, 11569.42152892352, 20683.379498615064, 20692.58614827695, 20730.06714697842, 20738.792612073685, 20746.48133796667, 8439.0, 8462.703805366782, 8592.699255526151, 8807.779805504913, 8899.421537600036, 4717.9292310615365, 4790.688605240648, 4821.156297647897, 4838.516148385133, 4862.124817532807, 3333.6999670029813, 3350.564426624523, 3405.8126803025575, 3406.2506248625264, 3410.35203311375, 567.3220501500667, 570.4124751505956, 572.644960124717, 583.6060659055121, 584.9151872978395, 678.9355011273921, 686.8317262270775, 696.7213114754139, 730.0436428278972, 772.3010675338827, 9082.36423450352, 9091.499967501852, 9325.487098209664, 9642.42145471274, 9735.318527702993, 682.2358957967009, 720.542455540725, 731.2066407947436, 746.1084004614542, 757.6174032113747, 4366.345048242725, 4511.917139886469, 4571.2000399929875, 4605.585497305258, 4606.654500912445, 52099.0, 53339.0, 53490.73254633702, 53579.73210133924, 66666.0, 45674.543254567696, 46322.768386157855, 46766.76616616963, 47203.999999999316, 47230.05539889183, 47347.0, 48090.27864582034, 48547.75726121347, 48984.02031959341, 49648.25527617089, 9100.317476189444, 9230.676926307548, 9259.907400925904, 9364.110409511359, 9530.85703714431, 31777.841110795223, 32310.515342270355, 32343.676563234065, 32397.35205295928, 32672.34182941475, 39506.40740388954, 40400.79799600983, 42746.57253427426, 46016.30975535436, 47165.29252061153, 12501.187422817487, 12533.435995380047, 12586.18189817659, 12765.425555849823, 12844.871551284368, 12900.677483062624, 13015.934920325337, 13849.653758656113, 14007.649808754863, 14446.133232006114, 13663.521776737767, 13745.931270343584, 13753.449862005407, 13814.723705526034, 14092.577222683336, 13428.597142085753, 13482.93258533701, 13565.118267312988, 13637.386317615532, 14369.64075898111, 13447.327633618475, 13478.79781803254, 14226.786598201243, 14251.64370890736, 14255.358508866919, 10920.563177472812, 11335.773284534429, 11369.886301136883, 11453.484593193492, 11784.292942423483, 11320.679757257745, 11467.770644587228, 11543.61476622777, 11724.355160466257, 11729.882701172879], "value": 6856.806114015895, "unit": "score"}], "name": "dromaeo_css", "value": 6982.979097539833, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 113.0, 108.0, 112.0, 112.0, 113.0, 104.0, 114.0, 114.0, 112.0], "value": 111.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 127.0, 158.0, 179.0, 129.0, 160.0, 165.0, 126.0, 200.0, 124.0], "value": 152.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 161.0, 160.0, 161.0, 163.0, 161.0, 160.0, 162.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 76.0, 134.0, 112.0, 74.0, 73.0, 74.0, 128.0, 101.0, 76.0], "value": 92.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 92.0, 154.0, 92.0, 93.0, 92.0, 141.0, 93.0, 92.0, 153.0], "value": 109.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 117.0, 116.0, 117.0, 118.0, 117.0, 116.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 147.0, 145.0, 145.0, 145.0, 146.0, 145.0, 145.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 95.0, 94.0, 94.0, 95.0, 94.0, 94.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 57.0, 56.0, 55.0, 57.0, 56.0, 58.0, 76.0, 55.0, 53.0], "value": 57.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 61.0, 60.0, 61.0, 61.0, 61.0, 61.0, 61.0, 62.0], "value": 61.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 77.0, 76.0, 76.0, 76.0, 76.0, 78.0, 77.0, 80.0], "value": 76.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 130.0, 131.0, 124.0, 124.0, 131.0, 133.0, 131.0, 167.0, 125.0], "value": 132.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 168.0, 166.0, 173.0, 166.0, 167.0, 170.0, 163.0, 161.0, 168.0], "value": 167.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 69.0, 69.0, 67.0, 66.0, 68.0, 68.0, 68.0, 67.0], "value": 67.8, "unit": "score"}], "name": "kraken", "value": 1546.2, "alertThreshold": 2.0}]} 11:51:10 INFO - Return code: 0 11:51:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 11:51:10 ERROR - # TBPL SUCCESS # 11:51:10 INFO - Running post-action listener: _resource_record_post_action 11:51:10 INFO - Running post-run listener: _resource_record_post_run 11:51:11 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 535392256; Read time: 12; Write time: 659404 11:51:11 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 0; Write bytes: 244797440; Read time: 0; Write time: 441656 11:51:11 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 290594816; Read time: 12; Write time: 217748 11:51:11 INFO - Running post-run listener: _upload_blobber_files 11:51:11 INFO - Blob upload gear active. 11:51:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:51:11 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 11:51:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:51:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:51:11 INFO - (blobuploader) - INFO - Open directory for files ... 11:51:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:51:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:51:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:51:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:51:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:51:12 INFO - (blobuploader) - INFO - Done attempting. 11:51:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:51:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:51:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:51:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:51:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:51:13 INFO - (blobuploader) - INFO - Done attempting. 11:51:13 INFO - (blobuploader) - INFO - Iteration through files over. 11:51:13 INFO - Return code: 0 11:51:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:51:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:51:13 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f4f5bd08e440971ae618a85709ce7b22f399f1cdcf6c067d591038efe8ddf605d7b19c994632c65f7543272ef0c1b78a17a80d76d89742e6636ff278e6f1e0b4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/20a795758a549203338f6c9658f49cd8622f9c2fd5e0cb45d05a055eb30e078f8e8022ec12ca58fcf9e2736bc52588685cc5106888550e0d38837d84ba362743"} 11:51:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:51:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:51:13 INFO - Contents: 11:51:13 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f4f5bd08e440971ae618a85709ce7b22f399f1cdcf6c067d591038efe8ddf605d7b19c994632c65f7543272ef0c1b78a17a80d76d89742e6636ff278e6f1e0b4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/20a795758a549203338f6c9658f49cd8622f9c2fd5e0cb45d05a055eb30e078f8e8022ec12ca58fcf9e2736bc52588685cc5106888550e0d38837d84ba362743"} 11:51:13 INFO - Running post-run listener: copy_logs_to_upload_dir 11:51:13 INFO - Copying logs to upload dir... 11:51:13 INFO - mkdir: /builds/slave/test/build/upload/logs 11:51:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1229.657958 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-04-22 11:51:13.479933) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-22 11:51:13.483139) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1461349838.219084-1316521108 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/f4f5bd08e440971ae618a85709ce7b22f399f1cdcf6c067d591038efe8ddf605d7b19c994632c65f7543272ef0c1b78a17a80d76d89742e6636ff278e6f1e0b4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/20a795758a549203338f6c9658f49cd8622f9c2fd5e0cb45d05a055eb30e078f8e8022ec12ca58fcf9e2736bc52588685cc5106888550e0d38837d84ba362743"} build_url:https://queue.taskcluster.net/v1/task/Zx-wswNnS1qxZsl05YdR2Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011304 build_url: 'https://queue.taskcluster.net/v1/task/Zx-wswNnS1qxZsl05YdR2Q/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/f4f5bd08e440971ae618a85709ce7b22f399f1cdcf6c067d591038efe8ddf605d7b19c994632c65f7543272ef0c1b78a17a80d76d89742e6636ff278e6f1e0b4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/20a795758a549203338f6c9658f49cd8622f9c2fd5e0cb45d05a055eb30e078f8e8022ec12ca58fcf9e2736bc52588685cc5106888550e0d38837d84ba362743"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-22 11:51:13.507342) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 11:51:13.507648) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1461349838.219084-1316521108 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004421 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 11:51:13.589715) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-22 11:51:13.590065) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-22 11:51:13.590368) ========= ========= Total master_lag: 0.14 =========