builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-012 starttime: 1461065833.56 results: success (0) buildid: 20160419032946 builduid: 888dd407cf58424d8f5448d914a222f8 revision: 29d7a174bdb4f63cb198b639d62a80fc6ea02dc6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-19 04:37:13.560115) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-19 04:37:13.561831) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-19 04:37:13.562137) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-19 04:37:13.579526) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 04:37:13.579914) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1461065172.603670-1984451590 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-19 04:37:14-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 213M=0s 2016-04-19 04:37:14 (213 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.118851 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 04:37:13.711899) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 04:37:13.712222) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1461065172.603670-1984451590 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017697 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 04:37:13.762629) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 04:37:13.762963) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 29d7a174bdb4f63cb198b639d62a80fc6ea02dc6 --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 29d7a174bdb4f63cb198b639d62a80fc6ea02dc6 --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=2c5dd2b0a310ecf02fd87158000001b4-1461065172.603670-1984451590 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-19 04:37:14,515 truncating revision to first 12 chars 2016-04-19 04:37:14,515 Setting DEBUG logging. 2016-04-19 04:37:14,515 attempt 1/10 2016-04-19 04:37:14,515 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/29d7a174bdb4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-19 04:37:14,796 unpacking tar archive at: fx-team-29d7a174bdb4/testing/mozharness/ program finished with exit code 0 elapsedTime=0.615809 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 04:37:14.391446) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-19 04:37:14.391754) ========= script_repo_revision: 29d7a174bdb4f63cb198b639d62a80fc6ea02dc6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-19 04:37:14.392159) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-19 04:37:14.392428) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-19 04:37:14.400199) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-04-19 04:37:14.400574) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=2c5dd2b0a310ecf02fd87158000001b4-1461065172.603670-1984451590 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:37:15 INFO - MultiFileLogger online at 20160419 04:37:15 in /builds/slave/test 04:37:15 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 04:37:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:37:15 INFO - {'append_to_log': False, 04:37:15 INFO - 'base_work_dir': '/builds/slave/test', 04:37:15 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 04:37:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:37:15 INFO - 'branch': 'Fx-Team-Non-PGO', 04:37:15 INFO - 'buildbot_json_path': 'buildprops.json', 04:37:15 INFO - 'config_files': ('talos/linux_config.py',), 04:37:15 INFO - 'default_actions': ('clobber', 04:37:15 INFO - 'read-buildbot-config', 04:37:15 INFO - 'download-and-extract', 04:37:15 INFO - 'populate-webroot', 04:37:15 INFO - 'create-virtualenv', 04:37:15 INFO - 'install', 04:37:15 INFO - 'run-tests'), 04:37:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:37:15 INFO - 'download_minidump_stackwalk': True, 04:37:15 INFO - 'download_symbols': 'ondemand', 04:37:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:37:15 INFO - 'tooltool.py': '/tools/tooltool.py', 04:37:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:37:15 INFO - '/tools/misc-python/virtualenv.py')}, 04:37:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:37:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:37:15 INFO - 'installer_path': 'installer.exe', 04:37:15 INFO - 'log_level': 'info', 04:37:15 INFO - 'log_name': 'talos', 04:37:15 INFO - 'log_to_console': True, 04:37:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:37:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:37:15 INFO - 'opt_config_files': (), 04:37:15 INFO - 'pip_index': False, 04:37:15 INFO - 'sps_profile': False, 04:37:15 INFO - 'sps_profile_interval': 0, 04:37:15 INFO - 'suite': 'dromaeojs', 04:37:15 INFO - 'system_bits': '32', 04:37:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:37:15 INFO - 'title': 'talos-linux64-ix-012', 04:37:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:37:15 INFO - 'use_talos_json': True, 04:37:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:37:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:37:15 INFO - 'work_dir': 'build'} 04:37:15 INFO - ##### 04:37:15 INFO - ##### Running clobber step. 04:37:15 INFO - ##### 04:37:15 INFO - Running pre-action listener: _resource_record_pre_action 04:37:15 INFO - Running main action method: clobber 04:37:15 INFO - rmtree: /builds/slave/test/build 04:37:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:37:16 INFO - Running post-action listener: _resource_record_post_action 04:37:16 INFO - ##### 04:37:16 INFO - ##### Running read-buildbot-config step. 04:37:16 INFO - ##### 04:37:16 INFO - Running pre-action listener: _resource_record_pre_action 04:37:16 INFO - Running main action method: read_buildbot_config 04:37:16 INFO - Using buildbot properties: 04:37:16 INFO - { 04:37:16 INFO - "project": "", 04:37:16 INFO - "product": "firefox", 04:37:16 INFO - "script_repo_revision": "production", 04:37:16 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 04:37:16 INFO - "repository": "", 04:37:16 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 04:37:16 INFO - "buildid": "20160419032946", 04:37:16 INFO - "pgo_build": "False", 04:37:16 INFO - "basedir": "/builds/slave/test", 04:37:16 INFO - "buildnumber": 1664, 04:37:16 INFO - "slavename": "talos-linux64-ix-012", 04:37:16 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 04:37:16 INFO - "platform": "ubuntu64_hw", 04:37:16 INFO - "scheduler": "tests-fx-team-linux64-talos", 04:37:16 INFO - "branch": "fx-team", 04:37:16 INFO - "repo_path": "integration/fx-team", 04:37:16 INFO - "revision": "29d7a174bdb4f63cb198b639d62a80fc6ea02dc6", 04:37:16 INFO - "stage_platform": "linux64", 04:37:16 INFO - "builduid": "888dd407cf58424d8f5448d914a222f8", 04:37:16 INFO - "slavebuilddir": "test" 04:37:16 INFO - } 04:37:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/emcTFQvoSFWyMwkGeum6Nw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 04:37:16 INFO - Running post-action listener: _resource_record_post_action 04:37:16 INFO - ##### 04:37:16 INFO - ##### Running download-and-extract step. 04:37:16 INFO - ##### 04:37:16 INFO - Running pre-action listener: _resource_record_pre_action 04:37:16 INFO - Running main action method: download_and_extract 04:37:16 INFO - mkdir: /builds/slave/test/build/tests 04:37:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:37:16 INFO - https://queue.taskcluster.net/v1/task/emcTFQvoSFWyMwkGeum6Nw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:37:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/emcTFQvoSFWyMwkGeum6Nw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 04:37:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/emcTFQvoSFWyMwkGeum6Nw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 04:37:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/emcTFQvoSFWyMwkGeum6Nw/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 04:37:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/emcTFQvoSFWyMwkGeum6Nw/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 04:37:27 INFO - Downloaded 1361 bytes. 04:37:27 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 04:37:27 INFO - Using the following test package requirements: 04:37:27 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 04:37:27 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:37:27 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:37:27 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:37:27 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:37:27 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:37:27 INFO - u'jsshell-linux-x86_64.zip'], 04:37:27 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:37:27 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:37:27 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 04:37:27 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:37:27 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:37:27 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:37:27 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:37:27 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:37:27 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:37:27 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:37:27 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:37:27 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:37:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:37:27 INFO - https://queue.taskcluster.net/v1/task/emcTFQvoSFWyMwkGeum6Nw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:37:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/emcTFQvoSFWyMwkGeum6Nw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:37:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/emcTFQvoSFWyMwkGeum6Nw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:37:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/emcTFQvoSFWyMwkGeum6Nw/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 04:37:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/emcTFQvoSFWyMwkGeum6Nw/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 04:37:42 INFO - Downloaded 22211033 bytes. 04:37:42 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'] 04:37:42 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 04:37:43 INFO - Return code: 0 04:37:43 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 04:37:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:37:43 INFO - https://queue.taskcluster.net/v1/task/emcTFQvoSFWyMwkGeum6Nw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:37:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/emcTFQvoSFWyMwkGeum6Nw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:37:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/emcTFQvoSFWyMwkGeum6Nw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:37:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/emcTFQvoSFWyMwkGeum6Nw/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 04:37:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/emcTFQvoSFWyMwkGeum6Nw/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 04:37:45 INFO - Downloaded 22211033 bytes. 04:37:45 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'] 04:37:45 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 04:37:46 INFO - Return code: 0 04:37:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:37:46 INFO - https://queue.taskcluster.net/v1/task/emcTFQvoSFWyMwkGeum6Nw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:37:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/emcTFQvoSFWyMwkGeum6Nw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 04:37:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/emcTFQvoSFWyMwkGeum6Nw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 04:37:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/emcTFQvoSFWyMwkGeum6Nw/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 04:37:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/emcTFQvoSFWyMwkGeum6Nw/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 04:37:48 INFO - Downloaded 10845952 bytes. 04:37:48 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'] 04:37:48 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 04:37:48 INFO - Return code: 0 04:37: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')]} 04:37:48 INFO - https://queue.taskcluster.net/v1/task/emcTFQvoSFWyMwkGeum6Nw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:37:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/emcTFQvoSFWyMwkGeum6Nw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:37:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/emcTFQvoSFWyMwkGeum6Nw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:37:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/emcTFQvoSFWyMwkGeum6Nw/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 04:37:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/emcTFQvoSFWyMwkGeum6Nw/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 04:37:52 INFO - Downloaded 54449573 bytes. 04:37:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/emcTFQvoSFWyMwkGeum6Nw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:37:52 INFO - mkdir: /builds/slave/test/properties 04:37:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:37:52 INFO - Writing to file /builds/slave/test/properties/build_url 04:37:52 INFO - Contents: 04:37:52 INFO - build_url:https://queue.taskcluster.net/v1/task/emcTFQvoSFWyMwkGeum6Nw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:37:53 INFO - Running post-action listener: _resource_record_post_action 04:37:53 INFO - Running post-action listener: set_extra_try_arguments 04:37:53 INFO - ##### 04:37:53 INFO - ##### Running populate-webroot step. 04:37:53 INFO - ##### 04:37:53 INFO - Running pre-action listener: _resource_record_pre_action 04:37:53 INFO - Running main action method: populate_webroot 04:37:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:37:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:37:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:37:53 INFO - '--tppagecycles', 04:37:53 INFO - '7'], 04:37:53 INFO - 'tests': ['tsvgm']}}, 04:37:53 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:37:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:37:53 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:37:53 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:37:53 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:37:53 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:37:53 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:37:53 INFO - 'talos_options': ['--disable-e10s'], 04:37:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:37:53 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:37:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:37:53 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:37:53 INFO - 'talos_options': ['--disable-e10s'], 04:37:53 INFO - 'tests': ['damp', 'tps']}, 04:37:53 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:37:53 INFO - 'tests': ['damp', 'tps']}, 04:37:53 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:37:53 INFO - 'tests': ['dromaeo_dom']}, 04:37:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:37:53 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:37:53 INFO - 'tests': ['a11yr', 04:37:53 INFO - 'ts_paint', 04:37:53 INFO - 'tpaint', 04:37:53 INFO - 'sessionrestore', 04:37:53 INFO - 'sessionrestore_no_auto_restore', 04:37:53 INFO - 'tabpaint']}, 04:37:53 INFO - 'other-e10s': {'tests': ['a11yr', 04:37:53 INFO - 'ts_paint', 04:37:53 INFO - 'tpaint', 04:37:53 INFO - 'sessionrestore', 04:37:53 INFO - 'sessionrestore_no_auto_restore', 04:37:53 INFO - 'tabpaint']}, 04:37:53 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:37:53 INFO - 'ts_paint', 04:37:53 INFO - 'tpaint', 04:37:53 INFO - 'sessionrestore', 04:37:53 INFO - 'sessionrestore_no_auto_restore', 04:37:53 INFO - 'tabpaint']}, 04:37:53 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:37:53 INFO - 'ts_paint', 04:37:53 INFO - 'tpaint', 04:37:53 INFO - 'sessionrestore', 04:37:53 INFO - 'sessionrestore_no_auto_restore', 04:37:53 INFO - 'tabpaint']}, 04:37:53 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:37:53 INFO - 'tests': ['a11yr', 04:37:53 INFO - 'ts_paint', 04:37:53 INFO - 'tpaint', 04:37:53 INFO - 'sessionrestore', 04:37:53 INFO - 'sessionrestore_no_auto_restore', 04:37:53 INFO - 'tabpaint']}, 04:37:53 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:37:53 INFO - 'tests': ['a11yr', 04:37:53 INFO - 'ts_paint', 04:37:53 INFO - 'tpaint', 04:37:53 INFO - 'sessionrestore', 04:37:53 INFO - 'sessionrestore_no_auto_restore', 04:37:53 INFO - 'tabpaint']}, 04:37:53 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:37:53 INFO - 'tests': ['tsvgx', 04:37:53 INFO - 'tsvgr_opacity', 04:37:53 INFO - 'tart', 04:37:53 INFO - 'tscrollx', 04:37:53 INFO - 'cart']}, 04:37:53 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:37:53 INFO - 'tsvgr_opacity', 04:37:53 INFO - 'tart', 04:37:53 INFO - 'tscrollx', 04:37:53 INFO - 'cart']}, 04:37:53 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:37:53 INFO - 'talos_options': ['--disable-e10s'], 04:37:53 INFO - 'tests': ['tp5o']}, 04:37:53 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:37:53 INFO - 'tests': ['tp5o']}, 04:37:53 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:37:53 INFO - 'talos_options': ['--disable-e10s', 04:37:53 INFO - '--xperf_path', 04:37:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:37:53 INFO - 'tests': ['tp5n']}, 04:37:53 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:37:53 INFO - 'talos_options': ['--xperf_path', 04:37:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:37:53 INFO - 'tests': ['tp5n']}}, 04:37:53 INFO - 'talos.zip': {'path': '', 04:37:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:37:53 INFO - Running post-action listener: _resource_record_post_action 04:37:53 INFO - ##### 04:37:53 INFO - ##### Running create-virtualenv step. 04:37:53 INFO - ##### 04:37:53 INFO - Running pre-action listener: _resource_record_pre_action 04:37:53 INFO - Running main action method: create_virtualenv 04:37:53 INFO - Creating virtualenv /builds/slave/test/build/venv 04:37:53 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:37:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:37:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:37:53 INFO - Using real prefix '/usr' 04:37:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:37:54 INFO - Installing distribute.............................................................................................................................................................................................done. 04:37:56 INFO - Installing pip.................done. 04:37:56 INFO - Return code: 0 04:37:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:37:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:37:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:37:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:37:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:37:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc4d765df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x135d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ec410>, '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 0x13ed310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13ed7a0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1461065172.603670-1984451590', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:37:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:37:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:37:56 INFO - Using env: {'DISPLAY': ':0', 04:37:56 INFO - 'HOME': '/home/cltbld', 04:37:56 INFO - 'LANG': 'en_US.UTF-8', 04:37:56 INFO - 'LANGUAGE': 'en_US:en', 04:37:56 INFO - 'LOGNAME': 'cltbld', 04:37:56 INFO - 'MAIL': '/var/mail/cltbld', 04:37:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:37:56 INFO - 'MOZ_NO_REMOTE': '1', 04:37:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:37:56 INFO - 'NO_EM_RESTART': '1', 04:37:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:37:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:37:56 INFO - 'PWD': '/builds/slave/test', 04:37:56 INFO - 'SHELL': '/bin/bash', 04:37:56 INFO - 'SHLVL': '1', 04:37:56 INFO - 'TERM': 'linux', 04:37:56 INFO - 'TMOUT': '86400', 04:37:56 INFO - 'USER': 'cltbld', 04:37:56 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1461065172.603670-1984451590', 04:37:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:37:56 INFO - '_': '/tools/buildbot/bin/python'} 04:37:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:37:56 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:37:56 INFO - Cleaning up... 04:37:56 INFO - Return code: 0 04:37:56 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:37:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:37:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:37:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:37:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:37:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fc4d765df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x135d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ec410>, '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 0x13ed310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13ed7a0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1461065172.603670-1984451590', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:37:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 04:37:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 04:37:56 INFO - Using env: {'DISPLAY': ':0', 04:37:56 INFO - 'HOME': '/home/cltbld', 04:37:56 INFO - 'LANG': 'en_US.UTF-8', 04:37:56 INFO - 'LANGUAGE': 'en_US:en', 04:37:56 INFO - 'LOGNAME': 'cltbld', 04:37:56 INFO - 'MAIL': '/var/mail/cltbld', 04:37:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:37:56 INFO - 'MOZ_NO_REMOTE': '1', 04:37:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:37:56 INFO - 'NO_EM_RESTART': '1', 04:37:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:37:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:37:56 INFO - 'PWD': '/builds/slave/test', 04:37:56 INFO - 'SHELL': '/bin/bash', 04:37:56 INFO - 'SHLVL': '1', 04:37:56 INFO - 'TERM': 'linux', 04:37:56 INFO - 'TMOUT': '86400', 04:37:56 INFO - 'USER': 'cltbld', 04:37:56 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1461065172.603670-1984451590', 04:37:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:37:56 INFO - '_': '/tools/buildbot/bin/python'} 04:37:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:37:56 INFO - Downloading/unpacking psutil>=0.7.1 04:37:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:37:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:37:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:37:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:37:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:37:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:37:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:37:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:37:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:37:58 INFO - Installing collected packages: psutil 04:37:58 INFO - Running setup.py install for psutil 04:37:58 INFO - building 'psutil._psutil_linux' extension 04:37:58 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 04:37:58 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 04:37:58 INFO - building 'psutil._psutil_posix' extension 04:37:58 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 04:37: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_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 04:37:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:37:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:37:59 INFO - Successfully installed psutil 04:37:59 INFO - Cleaning up... 04:37:59 INFO - Return code: 0 04:37:59 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:37:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:37:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:37:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:37:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:37:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fc4d765df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x135d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ec410>, '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 0x13ed310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13ed7a0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1461065172.603670-1984451590', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:37:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 04:37:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 04:37:59 INFO - Using env: {'DISPLAY': ':0', 04:37:59 INFO - 'HOME': '/home/cltbld', 04:37:59 INFO - 'LANG': 'en_US.UTF-8', 04:37:59 INFO - 'LANGUAGE': 'en_US:en', 04:37:59 INFO - 'LOGNAME': 'cltbld', 04:37:59 INFO - 'MAIL': '/var/mail/cltbld', 04:37:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:37:59 INFO - 'MOZ_NO_REMOTE': '1', 04:37:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:37:59 INFO - 'NO_EM_RESTART': '1', 04:37:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:37:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:37:59 INFO - 'PWD': '/builds/slave/test', 04:37:59 INFO - 'SHELL': '/bin/bash', 04:37:59 INFO - 'SHLVL': '1', 04:37:59 INFO - 'TERM': 'linux', 04:37:59 INFO - 'TMOUT': '86400', 04:37:59 INFO - 'USER': 'cltbld', 04:37:59 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1461065172.603670-1984451590', 04:37:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:37:59 INFO - '_': '/tools/buildbot/bin/python'} 04:37:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:37:59 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:37:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:37:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:37:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:37:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:37:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:37:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:38:01 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:38:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:38:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:38:01 INFO - Installing collected packages: mozsystemmonitor 04:38:01 INFO - Running setup.py install for mozsystemmonitor 04:38:01 INFO - Successfully installed mozsystemmonitor 04:38:01 INFO - Cleaning up... 04:38:01 INFO - Return code: 0 04:38:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:38:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:38:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:38:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:38:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:38:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fc4d765df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x135d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ec410>, '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 0x13ed310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13ed7a0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1461065172.603670-1984451590', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:38:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:38:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:38:01 INFO - Using env: {'DISPLAY': ':0', 04:38:01 INFO - 'HOME': '/home/cltbld', 04:38:01 INFO - 'LANG': 'en_US.UTF-8', 04:38:01 INFO - 'LANGUAGE': 'en_US:en', 04:38:01 INFO - 'LOGNAME': 'cltbld', 04:38:01 INFO - 'MAIL': '/var/mail/cltbld', 04:38:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:38:01 INFO - 'MOZ_NO_REMOTE': '1', 04:38:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:38:01 INFO - 'NO_EM_RESTART': '1', 04:38:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:38:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:38:01 INFO - 'PWD': '/builds/slave/test', 04:38:01 INFO - 'SHELL': '/bin/bash', 04:38:01 INFO - 'SHLVL': '1', 04:38:01 INFO - 'TERM': 'linux', 04:38:01 INFO - 'TMOUT': '86400', 04:38:01 INFO - 'USER': 'cltbld', 04:38:01 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1461065172.603670-1984451590', 04:38:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:38:01 INFO - '_': '/tools/buildbot/bin/python'} 04:38:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:38:01 INFO - Downloading/unpacking blobuploader==1.2.4 04:38:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:38:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:38:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:38:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:38:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:38:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:38:03 INFO - Downloading blobuploader-1.2.4.tar.gz 04:38:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:38:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:38:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:38:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:38:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:38:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:38:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:38:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:38:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:38:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:38: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 04:38: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 04:38: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 04:38: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 04:38: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 04:38: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 04:38:04 INFO - Downloading docopt-0.6.1.tar.gz 04:38:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:38:04 INFO - Installing collected packages: blobuploader, requests, docopt 04:38:04 INFO - Running setup.py install for blobuploader 04:38:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:38:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:38:04 INFO - Running setup.py install for requests 04:38:04 INFO - Running setup.py install for docopt 04:38:04 INFO - Successfully installed blobuploader requests docopt 04:38:04 INFO - Cleaning up... 04:38:04 INFO - Return code: 0 04:38:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:38:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:38:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:38:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:38:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:38:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc4d765df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x135d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ec410>, '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 0x13ed310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13ed7a0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1461065172.603670-1984451590', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:38:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:38:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:38:04 INFO - Using env: {'DISPLAY': ':0', 04:38:04 INFO - 'HOME': '/home/cltbld', 04:38:04 INFO - 'LANG': 'en_US.UTF-8', 04:38:04 INFO - 'LANGUAGE': 'en_US:en', 04:38:04 INFO - 'LOGNAME': 'cltbld', 04:38:04 INFO - 'MAIL': '/var/mail/cltbld', 04:38:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:38:04 INFO - 'MOZ_NO_REMOTE': '1', 04:38:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:38:04 INFO - 'NO_EM_RESTART': '1', 04:38:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:38:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:38:04 INFO - 'PWD': '/builds/slave/test', 04:38:04 INFO - 'SHELL': '/bin/bash', 04:38:04 INFO - 'SHLVL': '1', 04:38:04 INFO - 'TERM': 'linux', 04:38:04 INFO - 'TMOUT': '86400', 04:38:04 INFO - 'USER': 'cltbld', 04:38:04 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1461065172.603670-1984451590', 04:38:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:38:04 INFO - '_': '/tools/buildbot/bin/python'} 04:38:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:38:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:38:05 INFO - Running setup.py (path:/tmp/pip-3huGL4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:38:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:38:05 INFO - Running setup.py (path:/tmp/pip-nVC3hW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:38:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:38:05 INFO - Running setup.py (path:/tmp/pip-WZNZZh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:38:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:38:05 INFO - Running setup.py (path:/tmp/pip-uXLeMQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:38:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:38:05 INFO - Running setup.py (path:/tmp/pip-Jl6k9b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:38:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:38:05 INFO - Running setup.py (path:/tmp/pip-7TbN7c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:38:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:38:05 INFO - Running setup.py (path:/tmp/pip-_doMaB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:38:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:38:05 INFO - Running setup.py (path:/tmp/pip-_qSHTl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:38:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:38:05 INFO - Running setup.py (path:/tmp/pip-ULpp3D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:38:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:38:05 INFO - Running setup.py (path:/tmp/pip-0jXLLw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:38:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:38:05 INFO - Running setup.py (path:/tmp/pip-TRvJH4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:38:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:38:06 INFO - Running setup.py (path:/tmp/pip-WQJRl2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:38:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:38:06 INFO - Running setup.py (path:/tmp/pip-9WeWuj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:38:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:38:06 INFO - Running setup.py (path:/tmp/pip-yasVUm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:38:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:38:06 INFO - Running setup.py (path:/tmp/pip-WwvewP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:38:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:38:06 INFO - Running setup.py (path:/tmp/pip-5_x8e4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:38:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:38:06 INFO - Running setup.py (path:/tmp/pip-BrGwUd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:38:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:38:06 INFO - Running setup.py install for manifestparser 04:38:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:38:06 INFO - Running setup.py install for mozcrash 04:38:06 INFO - Running setup.py install for mozdebug 04:38:06 INFO - Running setup.py install for mozdevice 04:38:06 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:38:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:38:06 INFO - Running setup.py install for mozfile 04:38:06 INFO - Running setup.py install for mozhttpd 04:38:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:38:07 INFO - Running setup.py install for mozinfo 04:38:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:38:07 INFO - Running setup.py install for mozInstall 04:38:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:38:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:38:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:38:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:38:07 INFO - Running setup.py install for mozleak 04:38:07 INFO - Running setup.py install for mozlog 04:38:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:38:07 INFO - Running setup.py install for moznetwork 04:38:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:38:07 INFO - Running setup.py install for mozprocess 04:38:07 INFO - Running setup.py install for mozprofile 04:38:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:38:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:38:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:38:07 INFO - Running setup.py install for mozrunner 04:38:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:38:07 INFO - Running setup.py install for mozscreenshot 04:38:07 INFO - Running setup.py install for moztest 04:38:08 INFO - Running setup.py install for mozversion 04:38:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:38:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:38:08 INFO - Cleaning up... 04:38:08 INFO - Return code: 0 04:38:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:38:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:38:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:38:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:38:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:38:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:08 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 0x7fc4d765df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x135d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ec410>, '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 0x13ed310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13ed7a0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1461065172.603670-1984451590', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:38:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:38:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:38:08 INFO - Using env: {'DISPLAY': ':0', 04:38:08 INFO - 'HOME': '/home/cltbld', 04:38:08 INFO - 'LANG': 'en_US.UTF-8', 04:38:08 INFO - 'LANGUAGE': 'en_US:en', 04:38:08 INFO - 'LOGNAME': 'cltbld', 04:38:08 INFO - 'MAIL': '/var/mail/cltbld', 04:38:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:38:08 INFO - 'MOZ_NO_REMOTE': '1', 04:38:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:38:08 INFO - 'NO_EM_RESTART': '1', 04:38:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:38:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:38:08 INFO - 'PWD': '/builds/slave/test', 04:38:08 INFO - 'SHELL': '/bin/bash', 04:38:08 INFO - 'SHLVL': '1', 04:38:08 INFO - 'TERM': 'linux', 04:38:08 INFO - 'TMOUT': '86400', 04:38:08 INFO - 'USER': 'cltbld', 04:38:08 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1461065172.603670-1984451590', 04:38:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:38:08 INFO - '_': '/tools/buildbot/bin/python'} 04:38:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:38:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:38:08 INFO - Running setup.py (path:/tmp/pip-qkx9iI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:38:08 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:38:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:38:08 INFO - Running setup.py (path:/tmp/pip-h7IY69-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:38:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:38:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:38:08 INFO - Running setup.py (path:/tmp/pip-ZwowyW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:38:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:38:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:38:08 INFO - Running setup.py (path:/tmp/pip-rd8o7u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:38:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:38:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:38:08 INFO - Running setup.py (path:/tmp/pip-NoIlfL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:38:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:38:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:38:08 INFO - Running setup.py (path:/tmp/pip-4QpKbh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:38:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:38:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:38:08 INFO - Running setup.py (path:/tmp/pip-23HU0z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:38:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:38:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:38:08 INFO - Running setup.py (path:/tmp/pip-RjLpup-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:38:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:38:09 INFO - Running setup.py (path:/tmp/pip-ruTGn9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:38:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:38:09 INFO - Running setup.py (path:/tmp/pip-85DahY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:38:09 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)) 04:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:38:09 INFO - Running setup.py (path:/tmp/pip-itjB5F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:38:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:38:09 INFO - Running setup.py (path:/tmp/pip-s3Jh6z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:38:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:38:09 INFO - Running setup.py (path:/tmp/pip-lOpzUC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:38:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:38:09 INFO - Running setup.py (path:/tmp/pip-NPmoa3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:38:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:38:09 INFO - Running setup.py (path:/tmp/pip-DdSrUp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:38:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:38:09 INFO - Running setup.py (path:/tmp/pip-IFaTYm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:38:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:38:09 INFO - Running setup.py (path:/tmp/pip-fRPGLh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:38:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:38:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:38:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:38:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:38:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:38:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:38:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:38:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:38:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:38:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:38:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:38:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:38:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:38:11 INFO - Downloading blessings-1.6.tar.gz 04:38:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:38:11 INFO - Installing collected packages: blessings 04:38:11 INFO - Running setup.py install for blessings 04:38:11 INFO - Successfully installed blessings 04:38:11 INFO - Cleaning up... 04:38:11 INFO - Return code: 0 04:38:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:38:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:38:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:38:11 INFO - Reading from file tmpfile_stdout 04:38:11 INFO - Current package versions: 04:38:11 INFO - argparse == 1.2.1 04:38:11 INFO - blessings == 1.6 04:38:11 INFO - blobuploader == 1.2.4 04:38:11 INFO - docopt == 0.6.1 04:38:11 INFO - manifestparser == 1.1 04:38:11 INFO - mozInstall == 1.12 04:38:11 INFO - mozcrash == 0.17 04:38:11 INFO - mozdebug == 0.1 04:38:11 INFO - mozdevice == 0.48 04:38:11 INFO - mozfile == 1.2 04:38:11 INFO - mozhttpd == 0.7 04:38:11 INFO - mozinfo == 0.9 04:38:11 INFO - mozleak == 0.1 04:38:11 INFO - mozlog == 3.1 04:38:11 INFO - moznetwork == 0.27 04:38:11 INFO - mozprocess == 0.22 04:38:11 INFO - mozprofile == 0.28 04:38:11 INFO - mozrunner == 6.11 04:38:11 INFO - mozscreenshot == 0.1 04:38:11 INFO - mozsystemmonitor == 0.0 04:38:11 INFO - moztest == 0.7 04:38:11 INFO - mozversion == 1.4 04:38:11 INFO - psutil == 3.1.1 04:38:11 INFO - requests == 1.2.3 04:38:11 INFO - wsgiref == 0.1.2 04:38:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:38:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:38:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:38:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:38:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:38:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc4d765df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x135d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ec410>, '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 0x13ed310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13ed7a0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1461065172.603670-1984451590', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:38:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:38:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:38:11 INFO - Using env: {'DISPLAY': ':0', 04:38:11 INFO - 'HOME': '/home/cltbld', 04:38:11 INFO - 'LANG': 'en_US.UTF-8', 04:38:11 INFO - 'LANGUAGE': 'en_US:en', 04:38:11 INFO - 'LOGNAME': 'cltbld', 04:38:11 INFO - 'MAIL': '/var/mail/cltbld', 04:38:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:38:11 INFO - 'MOZ_NO_REMOTE': '1', 04:38:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:38:12 INFO - 'NO_EM_RESTART': '1', 04:38:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:38:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:38:12 INFO - 'PWD': '/builds/slave/test', 04:38:12 INFO - 'SHELL': '/bin/bash', 04:38:12 INFO - 'SHLVL': '1', 04:38:12 INFO - 'TERM': 'linux', 04:38:12 INFO - 'TMOUT': '86400', 04:38:12 INFO - 'USER': 'cltbld', 04:38:12 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1461065172.603670-1984451590', 04:38:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:38:12 INFO - '_': '/tools/buildbot/bin/python'} 04:38:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:38:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:38:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:38:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:38:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:38:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:38:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:38:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:38:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:38:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:38:12 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:38:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:38:12 INFO - Cleaning up... 04:38:12 INFO - Return code: 0 04:38:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:38:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:38:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:38:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:38:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:38:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc4d765df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x135d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ec410>, '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 0x13ed310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13ed7a0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1461065172.603670-1984451590', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:38:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:38:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:38:12 INFO - Using env: {'DISPLAY': ':0', 04:38:12 INFO - 'HOME': '/home/cltbld', 04:38:12 INFO - 'LANG': 'en_US.UTF-8', 04:38:12 INFO - 'LANGUAGE': 'en_US:en', 04:38:12 INFO - 'LOGNAME': 'cltbld', 04:38:12 INFO - 'MAIL': '/var/mail/cltbld', 04:38:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:38:12 INFO - 'MOZ_NO_REMOTE': '1', 04:38:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:38:12 INFO - 'NO_EM_RESTART': '1', 04:38:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:38:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:38:12 INFO - 'PWD': '/builds/slave/test', 04:38:12 INFO - 'SHELL': '/bin/bash', 04:38:12 INFO - 'SHLVL': '1', 04:38:12 INFO - 'TERM': 'linux', 04:38:12 INFO - 'TMOUT': '86400', 04:38:12 INFO - 'USER': 'cltbld', 04:38:12 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1461065172.603670-1984451590', 04:38:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:38:12 INFO - '_': '/tools/buildbot/bin/python'} 04:38:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:38:12 INFO - Downloading/unpacking jsonschema 04:38:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:38:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:38:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:38:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:38:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:38:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:38:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:38:14 INFO - Downloading/unpacking functools32 (from jsonschema) 04:38:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:38:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:38:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:38:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:38:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:38:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:38:14 INFO - Downloading functools32-3.2.3-2.tar.gz 04:38:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:38:14 INFO - warning: no files found matching '*.txt' 04:38:14 INFO - no previously-included directories found matching 'build' 04:38:14 INFO - no previously-included directories found matching 'dist' 04:38:14 INFO - no previously-included directories found matching '.git*' 04:38:14 INFO - Installing collected packages: jsonschema, functools32 04:38:14 INFO - Running setup.py install for functools32 04:38:14 INFO - warning: no files found matching '*.txt' 04:38:14 INFO - no previously-included directories found matching 'build' 04:38:14 INFO - no previously-included directories found matching 'dist' 04:38:14 INFO - no previously-included directories found matching '.git*' 04:38:14 INFO - Successfully installed jsonschema functools32 04:38:14 INFO - Cleaning up... 04:38:14 INFO - Return code: 0 04:38:14 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:38:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:38:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:38:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:38:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:38:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:14 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 0x7fc4d765df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x135d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ec410>, '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 0x13ed310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13ed7a0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1461065172.603670-1984451590', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:38:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 04:38:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 04:38:14 INFO - Using env: {'DISPLAY': ':0', 04:38:14 INFO - 'HOME': '/home/cltbld', 04:38:14 INFO - 'LANG': 'en_US.UTF-8', 04:38:14 INFO - 'LANGUAGE': 'en_US:en', 04:38:14 INFO - 'LOGNAME': 'cltbld', 04:38:14 INFO - 'MAIL': '/var/mail/cltbld', 04:38:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:38:14 INFO - 'MOZ_NO_REMOTE': '1', 04:38:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:38:14 INFO - 'NO_EM_RESTART': '1', 04:38:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:38:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:38:14 INFO - 'PWD': '/builds/slave/test', 04:38:14 INFO - 'SHELL': '/bin/bash', 04:38:14 INFO - 'SHLVL': '1', 04:38:14 INFO - 'TERM': 'linux', 04:38:14 INFO - 'TMOUT': '86400', 04:38:14 INFO - 'USER': 'cltbld', 04:38:14 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1461065172.603670-1984451590', 04:38:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:38:14 INFO - '_': '/tools/buildbot/bin/python'} 04:38:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:38:14 INFO - Downloading/unpacking flake8 04:38:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:38:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:38:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:38:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:38:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:38:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:38:16 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:38:16 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:38: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 04:38: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 04:38: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 04:38: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 04:38: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 04:38: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 04:38:17 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:38:17 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:38: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 04:38: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 04:38: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 04:38: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 04:38: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 04:38: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 04:38:17 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:38: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 04:38: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 04:38: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 04:38: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 04:38: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 04:38: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 04:38:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:38:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:38:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:38:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:38:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:38:17 INFO - no previously-included directories found matching 'docs/_build' 04:38:17 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:38:17 INFO - Running setup.py install for pep8 04:38:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:38:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:38:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:38:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:38:17 INFO - no previously-included directories found matching 'docs/_build' 04:38:17 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:38:17 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:38:17 INFO - Cleaning up... 04:38:17 INFO - Return code: 0 04:38:17 INFO - Running post-action listener: _resource_record_post_action 04:38:17 INFO - Running post-action listener: _start_resource_monitoring 04:38:17 INFO - Starting resource monitoring. 04:38:17 INFO - ##### 04:38:17 INFO - ##### Running install step. 04:38:17 INFO - ##### 04:38:17 INFO - Running pre-action listener: _resource_record_pre_action 04:38:17 INFO - Running main action method: install 04:38:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:38:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:38:18 INFO - Reading from file tmpfile_stdout 04:38:18 INFO - Detecting whether we're running mozinstall >=1.0... 04:38:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:38:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:38:18 INFO - Reading from file tmpfile_stdout 04:38:18 INFO - Output received: 04:38:18 INFO - Usage: mozinstall [options] installer 04:38:18 INFO - Options: 04:38:18 INFO - -h, --help show this help message and exit 04:38:18 INFO - -d DEST, --destination=DEST 04:38:18 INFO - Directory to install application into. [default: 04:38:18 INFO - "/builds/slave/test"] 04:38:18 INFO - --app=APP Application being installed. [default: firefox] 04:38:18 INFO - mkdir: /builds/slave/test/build/application 04:38:18 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'] 04:38:18 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 04:38:33 INFO - Reading from file tmpfile_stdout 04:38:33 INFO - Output received: 04:38:33 INFO - /builds/slave/test/build/application/firefox/firefox 04:38:33 INFO - Running post-action listener: _resource_record_post_action 04:38:33 INFO - ##### 04:38:33 INFO - ##### Running run-tests step. 04:38:33 INFO - ##### 04:38:33 INFO - Running pre-action listener: _resource_record_pre_action 04:38:33 INFO - Running main action method: run_tests 04:38:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:38:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:38:33 INFO - Python 2.7.3 04:38:33 INFO - Return code: 0 04:38:33 INFO - grabbing minidump binary from tooltool 04:38:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:38:33 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ec410>, '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 0x13ed310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13ed7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:38:33 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:38:33 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 04:38:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:38:33 INFO - Return code: 0 04:38:33 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:38:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:38:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:38:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:38:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:38:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:38:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:38:34 INFO - Return code: 0 04:38:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/emcTFQvoSFWyMwkGeum6Nw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 04:38:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/emcTFQvoSFWyMwkGeum6Nw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-012 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 04:38:34 INFO - Using env: {'DISPLAY': ':0', 04:38:34 INFO - 'HOME': '/home/cltbld', 04:38:34 INFO - 'LANG': 'en_US.UTF-8', 04:38:34 INFO - 'LANGUAGE': 'en_US:en', 04:38:34 INFO - 'LOGNAME': 'cltbld', 04:38:34 INFO - 'MAIL': '/var/mail/cltbld', 04:38:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:38:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:38:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:38:34 INFO - 'MOZ_NO_REMOTE': '1', 04:38:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:38:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:38:34 INFO - 'NO_EM_RESTART': '1', 04:38:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:38:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:38:34 INFO - 'PWD': '/builds/slave/test', 04:38:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:38:34 INFO - 'SHELL': '/bin/bash', 04:38:34 INFO - 'SHLVL': '1', 04:38:34 INFO - 'TERM': 'linux', 04:38:34 INFO - 'TMOUT': '86400', 04:38:34 INFO - 'USER': 'cltbld', 04:38:34 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1461065172.603670-1984451590', 04:38:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:38:34 INFO - '_': '/tools/buildbot/bin/python'} 04:38:34 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/emcTFQvoSFWyMwkGeum6Nw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 04:38:35 INFO - mozversion application_buildid: 20160419032946 04:38:35 INFO - mozversion application_changeset: 29d7a174bdb4f63cb198b639d62a80fc6ea02dc6 04:38:35 INFO - mozversion application_display_name: Nightly 04:38:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:38:35 INFO - mozversion application_name: Firefox 04:38:35 INFO - mozversion application_remotingname: firefox 04:38:35 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 04:38:35 INFO - mozversion application_vendor: Mozilla 04:38:35 INFO - mozversion application_version: 48.0a1 04:38:35 INFO - mozversion platform_buildid: 20160419032946 04:38:35 INFO - mozversion platform_changeset: 29d7a174bdb4f63cb198b639d62a80fc6ea02dc6 04:38:35 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 04:38:35 INFO - mozversion platform_version: 48.0a1 04:38:35 INFO - using testdate: 1461065915 04:38:35 INFO - actual date: 1461065915 04:38:35 INFO - starting webserver on 'localhost:46356' 04:38:35 INFO - SUITE-START | Running 2 tests 04:38:35 INFO - TEST-START | dromaeo_css 04:38:35 INFO - operating with platform_type : linux_ 04:38:35 INFO - Initialising browser for dromaeo_css test... 04:38:35 INFO - TEST-INFO | started process 8491 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptKCIxu/profile http://localhost:46356/getInfo.html) 04:38:39 INFO - PROCESS | 8491 | __metrics Screen width/height:1600/1200 04:38:39 INFO - PROCESS | 8491 | colorDepth:24 04:38:39 INFO - PROCESS | 8491 | Browser inner width/height: 1024/697 04:38:39 INFO - PROCESS | 8491 | __metrics 04:38:39 ERROR - PROCESS | 8491 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:38:40 INFO - TEST-INFO | 8491: exit 0 04:38:40 INFO - Browser initialized. 04:38:40 INFO - Running cycle 1/1 for dromaeo_css test... 04:38:40 INFO - TEST-INFO | started process 8571 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptKCIxu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:38:52 INFO - PROCESS | 8571 | RSS: Main: 154763264 04:38:52 INFO - PROCESS | 8571 | 04:39:44 INFO - PROCESS | 8571 | 1461065984304 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 04:41:55 INFO - PROCESS | 8571 | Cycle 1(1): loaded http://localhost:46356/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46356/tests/dromaeo/cssquery-ext.html) 04:41:56 INFO - PROCESS | 8571 | RSS: Main: 262287360 04:41:56 INFO - PROCESS | 8571 | 04:44:59 INFO - PROCESS | 8571 | Cycle 1(1): loaded http://localhost:46356/tests/dromaeo/cssquery-ext.html (next: http://localhost:46356/tests/dromaeo/cssquery-jquery.html) 04:44:59 INFO - PROCESS | 8571 | RSS: Main: 241217536 04:44:59 INFO - PROCESS | 8571 | 04:48:01 INFO - PROCESS | 8571 | Cycle 1(1): loaded http://localhost:46356/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46356/tests/dromaeo/cssquery-mootools.html) 04:48:02 INFO - PROCESS | 8571 | RSS: Main: 238968832 04:48:02 INFO - PROCESS | 8571 | 04:51:04 INFO - PROCESS | 8571 | Cycle 1(1): loaded http://localhost:46356/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46356/tests/dromaeo/cssquery-prototype.html) 04:51:05 INFO - PROCESS | 8571 | RSS: Main: 233771008 04:51:05 INFO - PROCESS | 8571 | 04:54:08 INFO - PROCESS | 8571 | Cycle 1(1): loaded http://localhost:46356/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46356/tests/dromaeo/cssquery-yui.html) 04:54:08 INFO - PROCESS | 8571 | RSS: Main: 222789632 04:54:08 INFO - PROCESS | 8571 | 04:57:11 INFO - PROCESS | 8571 | Cycle 1(1): loaded http://localhost:46356/tests/dromaeo/cssquery-yui.html (next: http://localhost:46356/tests/dromaeo/cssquery-dojo.html) 04:57:11 INFO - PROCESS | 8571 | RSS: Main: 268652544 04:57:11 INFO - PROCESS | 8571 | 04:57:11 INFO - PROCESS | 8571 | __start_tp_report 04:57:11 INFO - PROCESS | 8571 | _x_x_mozilla_page_load 04:57:11 INFO - PROCESS | 8571 | _x_x_mozilla_page_load_details 04:57:11 INFO - PROCESS | 8571 | |i|pagename|runs| 04:57:11 INFO - PROCESS | 8571 | |0;dojo.html;2609.1650671785023;2659.202239328201;2674.2200606329116;2714.7556719895206;2725.2369336585753;4580.175568397687;4658.394408726861;4715.622750179986;4755.952440475594;4785.210440277355;4638.860834174971;4716.033213191296;4759.333693282943;4805.0389922015565;4821.734804585746;4286.657067434598;4301.397804307399;4312.094460163369;4331.545187755288;4391.780410979454;4250;4304.870853874373;4388.780560971954;4402.559744025604;4418.9337159942625;4188.057687020427;4338.132373525276;4370.4755429348525;4381.474223093233;4382.4741031076155;4205.600467955539;4282.657387409;4288.399624052635;4320.330348795942;4343.109662519176;4228.9154216915795;4234.872953811359;4245;4285.657147428198;4292.420523229386;4438.667099967483;4529.456465224162;4543.250363689987;4562.817487300504;4584.862454126348;4999.8000079996755;5035.622328325354;5044.066847633199;5077.441481437039;5082.161443361841;5009.4239162496415;5019.698818070891;5020.2720605511995;5059.544640982329;5083;4548.74981876;4660.86017419478;4673.345731597579;4685.742284174403;4690.788914498821;5160.071187186268;5167.844964651066;5187.325647665779;5212.843614691566;5218.086834803894;4944.53026962438;4948;4952.975235123801;4957.20684690455;5024.84925452237;4888.022395520839;5043.899122017539;5045.596352291808;5047.394312682502;5052.747362631853;4892.8532144035735;4922.237053256751;4928;4952.777125029383;4958.380202474691;4921.114199444134;4926.531979461945;4932.8766780830765;4938.38270216223;4971.105201063843;4082.3672330788777;4157.646600039031;4204.012057166564;4213.97893010533;4251.234777740036;3681.9631803682155;3716.3496388132507;3756.7933763643264;3784.829682664287;3843.1160833008566;4313.223619748475;4313.870583882489;4317.460317460317;4318.136372725405;4350.9564904350555;4816.301636262722;4954.331165292711;4964.05682920244;4966.553010229097;4971.751412429364;4332.458442694663;4360.106178233455;4364.650827933758;4399.1641588098155;4409;4527.886802829956;4529.297958816389;4532.478764942074;4542.250528662799;4572.9314060289125;4547.8180872764715;4689.413823272091;4738.928916066262;4751.192297309535;4757.690750101232;5010;5031.144705400164;5031.496850315086;5041.470645582308;5085.211792172219;4719.2921061841;4736.834210802605;4737.952620473751;4745.217039188496;4792.041591681747;4844.660873738804;4882.658213924991;4917.360743103373;4982.526659967298;4983.70097794119;4968.875778105432;4990.50094990498;4996.325496058131;4997.600191984705;5036.29491871131;4857.635677324144;4862.756862156807;4868.95131048685;4871.269309603446;4912.729799861042;4667.159911215878;4848.248521479177;4910.975445122752;4920.975395123001;4927.655064145475;4779.948411349497;4788.928166077581;4793.209120495079;4793.2091204952185;4818.686785359081;4885.731284779371;4886.389201349832;4890.046440943982;4891.461939186615;4939.283803848493;4607.101615185007;4750.263709125091;4777.713337199779;4823.300621409946;4826.1795494766675 04:57:11 INFO - PROCESS | 8571 | |1;ext.html;567.302218271526;612.7089632424596;613.8864310102631;621.5742216581642;623.2085251730302;26715.866420667895;27204.727952720466;27254.31864203396;27270.31824204396;27273;27169.320766980836;34341.828290858575;35267;35273.11817204571;35392.82303588485;7703.653335599897;7906.209379062077;7911.287984081431;7913.129555748863;7914.52512849228;7800.453968222227;7951.522908625501;7953;7961.880571791427;7965.322947549465;7943.880841787378;7999.600019998977;8002.279794818465;8003;8003.639836207385;7826.1391246962785;7875;7880.408969327266;7909.96045019777;7924.564148971805;7779.922200777976;7884.72403465876;7902.446828721992;7904.723334683316;7908.2882540571045;37478.43782343267;37980.24039519222;38031;38042.80978595117;38067;2910.941781164365;2978.851057447119;2991.6110905582136;3001.8048826826184;3063.2801291696433;27159;27174.320641984108;28652.283692907637;28765.28086797847;29291.121266362043;3263.9836800816083;3335.7368407966433;3352.279259959096;3391.982405278431;3394.6605339466105;224603;225632;226391;226490;226929;33127.83436082852;51088.74455627698;51443.74278128585;51451.485485145415;51540.22689659658;31072.378552428825;31112.68887311143;31115;31146.065618031495;31246;12200.511979520898;12477.500899964081;12495.500179992698;12500.062495312888;12543.3101179436;10185.287029907835;10251.231157663206;10274.075333220046;10284.331518451278;10284.434356110336;7923.247291507298;8177.427580069338;8184.7953801155445;8223.17768223173;8251.463654862415;3186.3467989062187;3192.2657788708725;3198.2484116232667;3218.935621287608;3245.7403407727797;910.6858133943779;966.1883523373568;973.8089299077077;996.6147055592731;1020.3877673395903;28158;28214.43571128566;28314.2921426966;28535;28817;787.2835719495346;1001.5843424978552;1052;1058.8147074261974;1093.3549205968516;13087.476500940045;13540.729185416236;13752.724945501233;13841.238731869844;13847.16916984964;329990;336772;337390;337685;338001;45369;46130.308045379345;46138.307925381145;46176.538234617896;46252.306215406796;1048.370977413561;1203.5907791350983;1216.9087318451152;1228.705110773408;1246;25351.87324063368;26248.868755656098;26749.732502675502;26773.732262677124;26801.731982679925;38748.80625596854;39970.60029399785;40208.798956005034;40364.79817600893;40394.39408408818;224943;226390;227496;227597;412643;25239;25777.613335800354;25892.093776717724;26067.478650426507;26076.8696156518;36794.26411471809;36831.63168368389;36959.009854876465;36974.8151259242;37950.62049379471;31310;31931.201719957186;31988.071669716937;34760.82619586886;35261;33465.49801753024;33821.32357352888;33940.83029584836;34024.65975340314;34174;34413.827930860185;34653.48019779655;34678.306433870675;34798.82600587082;34904.47643285403;30210.24474388158;31317.338026267113;31460.52809207818;31488.685113148575;31503.84248078745;23531.235157363608;23623.763762362156;24250;24367.390815229053;24643.753562464146 04:57:11 INFO - PROCESS | 8571 | |2;jquery.html;381.4449975285958;382.79329162252367;386.2333268462103;386.5419477918667;398.8683734367659;15572.398563070514;17033.91483042583;17619;17912.82087179131;17915;16551.66896662069;16759.748603770953;16841.242144103515;17272.13639318032;17275.568110797238;5095.388553373591;5210.635255532115;5245.921311180336;5275.762590683409;5278.604104692164;3655.1958569114754;3906.0625449891963;4302.354646802974;6064.696765161746;6076.756929722806;5926.851828704273;5988.97005514974;6045.697715114248;6048.788292409767;6055.788047418341;5737.713114344287;5950.761969521214;6004.0693692477735;6017.789377371815;6029.487493563074;5336.226247194135;5377;5382.434844341327;5386.165144402624;5393.703346315951;20051.79948200514;20873;21337.25319613806;21361.35915922525;22186.778132218795;2081.2091405266056;2099.4331530486684;2451.7425670304538;2692.986535067312;2724.0738149029426;12767.233965962072;13210.273434961073;13212.801807972888;13848.86151138496;13851.030427870053;1833.706606942896;1865.3750993417223;1892.0917959379574;1925.1817977359567;1932.6327997680537;76868.61565692192;77673.22326776717;78106.60946695287;78305.21694783094;79528.60235698843;15597.532074037797;15853.603659908364;15968.201589920458;16961.166067670656;16972.49082527526;28532;28835.134945951653;29010.854945725136;29049.56425653617;29097;7950.284474397332;8670.306375489945;8700.695475658322;8798.34012449056;8811.251043661232;6949.131358580177;6954.478414118961;7069.575825450489;7110.32451917067;7134.571925684476;7970.960145199237;8002;8135.616945119344;8164.510129392255;8443.240108390275;3032.6360836699737;3141.659179394992;3170.461021626329;3194.3167739099267;3505.859765609347;775.5734346109617;843.9873401898976;845.8054647431126;913.2237598041611;932.664240873285;16158.515244542683;16464.259108340153;16729.665406691798;16956.982581045177;17153.485395438158;856.4518708026868;866.9263112635497;868.3400615532241;925.3383830561181;925.7361651929168;9447.33868629203;9471.715848524555;9478.431294122374;9531.952340238393;9670.70987870365;379237;393469;394740;396097;398155;70103;71482.2851771486;72416.63791681008;72477.27522724705;74260.62869685618;929.1451864284874;935.102301790289;939.2720641503026;942.8585712143097;948.1656142594611;14250;14529.273536323353;14601.269936503344;14670.33983470725;14703.55889323322;31226;32305;33178.66821331756;33671.66328336783;33813.66186338105;45803.77098114488;46709.766451167525;46826.76586617045;46882.531174687814;47029.294560582304;6158.076288556752;6501.642409667514;7710.643486430149;7825.726099586487;7975.361971042186;7593.468457207942;8147.877781833396;8294.129116442928;11435.256708313933;11463.484143213409;9716.417014979124;9854.11312981835;9866.654667086617;10088;10126.088652021353;9997;10130.797384052425;10345.172386208935;10461.68614941553;10646.361218326925;5257.132573125392;7421.740239091606;9744.220462363135;10230.618866452933;10317.123044540998;7745.186755390603;7771.844563108819;7849.254320839511;7853.1361550228285;7939.444238903221;7921.485103468256;9190.218831399407;10499.527521261714;10563.15494760402;10681 04:57:11 INFO - PROCESS | 8571 | |3;mootools.html;1262.8168915507247;1448.768197088466;1492.4850926430381;1602.6313947792007;1772.804991450941;6821.761238356658;7615.504992175512;7761.495502792329;7774.8445031099345;7795.844083118342;7502.92497075029;7558.2819632135;7630.351420129296;7648.2734140256725;7658.617069146534;1927.8650494465394;2191.189259973804;2207.878566678832;2213.1368766181204;2237.3847192022163;2228.3092241405134;2229.2420577003813;2229.6209644360415;2231.1187081102953;2234.19568955176;2131.3286314810784;2157.320444060116;2160.6650969099737;2161.070739581979;2179.0847843905517;1879.2013394307432;2135.519508110678;2169.490169810101;2202.680611311367;2204.5811295853896;2151.354593621907;2173.3154056472163;2173.913043478259;2174.7607763146198;2176.031665908671;7609.353204977583;7724.613769311568;7728.574928378937;7737.497062690907;7748.380129589619;4596.747178905159;4730.195866702668;4730.219513780222;4749.050189961987;4752.6910750801435;2888.79778415511;2910.9272268193254;2937.8384188869604;2983.2243616659607;3001.3397052648384;891.2157301574638;902.3007169443669;909.7771046093683;934.8083642853267;941.637469574212;10624.999999999924;10661;10663.946680266548;10696.197785166143;10697.518611662494;4155.750654960712;4257.467816522934;4411.404460397805;4413.933790993137;4416.24923762961;9069.54652267384;9124.361294709439;9125.498097604695;9155.908440915506;9162.129597688208;4788.976055119702;4797.088553174955;4812.663113582085;4822.927656085161;4827.758612069452;3793.772373657534;4219.07180420307;4290.828366865353;4295.78521073945;4297.806598703066;3637.308911306843;3691;3771.132639492877;3790.75360101598;3818.961810381916;1238.9690257743628;1245.5640525815893;1252.5929073051295;1254.084518301645;1255.579380907388;706.9151701795818;764.1746913333586;836.2975100915261;850.6427300533667;862.7713655881197;5122.410922743858;5375.623706340519;5386.730663466811;5391.946080539223;5393.6224464287125;922.4188761080476;937.4188003437912;940.1773448232797;947.5925352098526;950.9729492148601;3517.278957813642;3686.9262614747554;3711;3768.3028639701743;3839.040239940015;9552.713418597454;9741.366811157252;9768.724719073098;9877.654282100091;10001.79996400068;9725.513724313756;9793.36343137708;9891.60433582663;9902.702918912444;9908.405495670282;7377.704891804375;7400.148982866932;7488.625568721543;7534.208908064684;7565.583892885944;5312.5218730314455;5346.224797404277;5379.73101344939;5507.201455788968;5559.72201389937;8618.612162452579;8744.825103498022;8793.164649358301;8891.777705557413;8898.911010889808;8636.222739953435;8786.736397908073;8928.15182557656;9022.368434209542;9024.864627030469;5973.193618861398;6547.214334279917;6561.212654481493;6690.096836927147;6700.329967003261;7227.096612923385;7231.096112985877;7269.345758881726;7303.963480182565;7311.597862117422;6444;6635.6350400728425;6641.136652235178;6735.865282694416;6746.595204287759;6582.703778329891;6587.571807832475;6592.044153597797;6639.3360663935155;6653.567518111307;6249.875002500015;6274.278457977391;6305.873882522415;6312.274088479883;6329.145565348803;4337.9783101084295;4443.577860103285;4476.641868650565;4480.955190448054;4503.707259028152;4444.066745983379;4486.304622783474;4524.819007239806;4551.226291530514;4565.497795242587 04:57:11 INFO - PROCESS | 8571 | |4;prototype.html;313.2435169066704;316.92076980754814;319.8528676808668;320.4344332253573;323.59873756541896;5072.644914855961;5112.51431114044;5130.256112863637;5136.152534831757;5176.637635365526;5049.949500504994;5057.9241311380265;5060.493950604938;5072.26452164436;5089.389273287202;3738.8130593470355;3842.8855631866863;3989.381645844884;3991.7804520751347;3992.9817896436366;3955.8417663293435;3979.6617287530594;3981.701372397067;3983.7012224083164;3992.4610177626087;3703.462997865308;3947.3881548359905;3957.445957565943;3959.3862951242604;3963.6036396360278;3808.1241314497684;3933.7836418997085;3937.5274967004143;3946.684265258801;3956.3076461619103;3481.0775144586705;3488.7383446241633;3496.877609283663;3502.124468882779;3506.386382383073;4889.242167464049;4893.04585605807;4906.828261010884;4914.0908931847725;4915.754212289371;4235.894102647428;4470.508244093147;4486.080353527519;4498.640108791289;4580.129775342674;5280.78541935357;5290.576753859682;5290.814821481268;5291;5309.787608495655;3707.6292370762976;3712.350338690718;3727.552693676776;3733.1040550268012;3739.7943113128767;5252.579793616502;5556.277683901108;5557.472040156179;5582.162675598652;5613.803516876889;3801.82891769871;3805.6384643458828;3807.0114959756456;3820.1213720843807;3828.1003964068423;3859.1895701902354;3878.3406820840523;3886.6696330811633;3886.6696330812197;3894.6494815466745;4204.978975105105;4462.665300102505;4474.552544745499;4487.708298960557;4491.46102467706;5262.210668399694;5283.365996080495;5313.521783039545;5314.256004159421;5322.361316642027;1309.9017573682013;1327.1771501669027;1344.28080976677;1348.9730205395838;1351.5337208662995;831.8876951611455;881.7134431309722;897.1835629577184;907.9001309855911;909.2725819344498;4666.906661866744;4677.321788340671;4681.6722829401615;4683.95316046842;4705.4588722296685;5429.511343979061;5447.53695935842;5449.536789372868;5451.754671039813;5452.5365343946205;4487.41663583732;4651.883702907455;4671.76641167947;4678.8596342109795;4749.24012158053;2920.0801747449486;2921.575092673076;2933.750631196372;2938.839158532368;2941.014760055363;5129.076766182123;5146.871328216825;5152.149895267314;5154.304168937146;5178.249153872667;5495.505404513533;5589.720513974366;5622.971885140548;5636.520895723827;5639.210510528529;5096.063495871619;5132.948670513247;5144.742762861917;5154.201098829687;5160.535551800356;5502.174673798962;5508.531774799187;5512.503874651301;5517.724113794375;5522.420145884625;5139.537441630271;5416.4041955385665;5418.403975562606;5440.102383106743;5451.1005684063275;5132.871678208075;5166.819161329336;5166.881578552926;5170.819021334235;5170.870728231825;3793.506844110248;3808.2383523294898;3808.771473711586;3814.8474061037246;3817.370133927982;5215.269862219368;5493.813588118961;5493.835184944458;5510.6969116698965;5519.3652729936575;5315.123004704181;5328.09422398201;5333.093374126485;5336.306280183551;5355.22349259363;5142.537171654569;5323;5323.2547443358735;5335.813246536352;5338;4975.228839529878;5253.947460525499;5259.500347466985;5261.736913154404;5273.762680679455;5254.290670759398;5263.499967503081;5284;5287.4976877196605;5292.41783403833;5070.974645126751;5207.791688332424;5212.139996900621;5231.808596756052;5236.39781425141 04:57:11 INFO - PROCESS | 8571 | |5;yui.html;681.9624920629365;688.1432616392585;694.1080711285996;701.4984286235342;705.2383425900028;11634.534618615256;11895.405229738522;11935.283882967027;11945.462454189561;11950.521979120836;10938.56245750169;10991.285566438177;11010.779784404307;11012.559497620106;11041.613543525978;632.6899819088659;800.1918062756629;811.8579248631495;812.10262659761;812.8211793405442;646.7800947677789;648.3646026893647;649.5290914087273;763.9656215470317;799.0650938402083;837.9902217827533;839.4040231435657;839.6221700234888;840.357126798;846.7967687754925;834.6327615849068;835.1523203947967;835.5655059369125;835.6699103853974;836.0135040652028;493.37341576198384;600.8708127752554;611.1260896917406;616.014376996806;616.0820377637333;10797.460126993697;10804.837927431096;10806.837897431546;10835.133189344833;10891.83662245067;11460.598879039277;12123.6362909112;12132.818007729891;12172.81740773889;12849.935750321189;8695.347848911293;8929.508877011762;9010.459372437675;9072.54637268134;9230.907690923072;2786.080593404172;2795.9021434249703;2813.1982385020374;2824.957625635617;2843.3176037750995;46719;47052.76473617644;47459.28811067837;47619.523804761855;47876.04247915057;9977.850332245021;10005.899941000642;10020.498975051218;10129.290949633454;10213.795724085625;16955;17093.572660683334;17109.743353849703;17113.48659540216;17121;6064.241969753781;6166.167567378437;6206.658633775186;6239.344868788802;6346.650934198571;3315.0386387947706;3356.983215083958;3357.2110554019787;3396.1509622594353;3449.292894956578;2735.480258750831;2837.5318072517803;2843.8720257588457;2844.416894536615;2844.5448728203387;499.0592732698889;510.48186091117543;512.5873671694322;515.2451658320579;520.903632827928;531.1634176172544;566.832784328624;571.588456311455;575.1803679756414;577.1170109732033;7615.581143037075;7616.961915190499;7734.806629834299;7751.224877512203;7974.162712915177;502.3519659639098;537.7553213287945;555.447524169946;561.0714267886655;584.3484514766005;3645.54430696163;3780.31954248238;3785.8107094645156;3817.4846395736777;3931.8427262909736;51432.74283628633;52105.2184217237;52119;52224.738876305375;52262.47737522576;44246.77876610596;44744.77627611841;45434.54565454369;45835.31247031297;46281.53718462772;41225.58774412277;41265.58734412617;41479.37780933289;41609;42660.78669606694;7063.752768653072;7183.389411900047;7522.435817313614;7529.548227106391;7558.508696934681;28510.42979140447;28931.42137157203;28966.27584310409;28995.13014609565;29372.412551749272;34816.651833481345;34854.47718284177;37340.626593733716;37391.6260837399;38106.0473488165;8484.448510846774;8515.957420212859;8547.914520854712;8568.40021198535;8606.354523410895;10401.479926003518;10432.895671043496;10482.161427085663;11201.775964480828;11603.88396116028;10611.257211995086;10720.249582529148;10784.245102842726;10861.67414977552;10889.564417423215;9752.512374381395;9816.55825487869;10091.545880435546;10311.175105991653;10635.840462392916;10899.128069754559;11253.437328133725;11532.94233528827;11553.480093395985;11560.364179970182;8824.294056475595;9086.863697044417;9255.490947997925;9316.767080822763;9328.347015708836;8316.875246871423;8333.499990000619;8924.553772311489;9003.369764116449;9065.864012039956 04:57:11 INFO - PROCESS | 8571 | __end_tp_report 04:57:11 INFO - PROCESS | 8571 | __start_cc_report 04:57:11 INFO - PROCESS | 8571 | _x_x_mozilla_cycle_collect,1003 04:57:11 INFO - PROCESS | 8571 | __end_cc_report 04:57:11 INFO - PROCESS | 8571 | __startTimestamp1461067031792__endTimestamp 04:57:11 INFO - PROCESS | 8571 | 04:57:11 INFO - PROCESS | 8571 | ------- Summary: start ------- 04:57:11 INFO - PROCESS | 8571 | Number of tests: 6 04:57:11 INFO - PROCESS | 8571 | 04:57:11 INFO - PROCESS | 8571 | [#0] dojo.html Cycles:165 Average:4626.70 Median:4757.69 stddev:474.82 (10.0%) stddev-sans-first:449.12 04:57:11 INFO - PROCESS | 8571 | Values: 2609.2 2659.2 2674.2 2714.8 2725.2 4580.2 4658.4 4715.6 4756.0 4785.2 4638.9 4716.0 4759.3 4805.0 4821.7 4286.7 4301.4 4312.1 4331.5 4391.8 4250.0 4304.9 4388.8 4402.6 4418.9 4188.1 4338.1 4370.5 4381.5 4382.5 4205.6 4282.7 4288.4 4320.3 4343.1 4228.9 4234.9 4245.0 4285.7 4292.4 4438.7 4529.5 4543.3 4562.8 4584.9 4999.8 5035.6 5044.1 5077.4 5082.2 5009.4 5019.7 5020.3 5059.5 5083.0 4548.7 4660.9 4673.3 4685.7 4690.8 5160.1 5167.8 5187.3 5212.8 5218.1 4944.5 4948.0 4953.0 4957.2 5024.8 4888.0 5043.9 5045.6 5047.4 5052.7 4892.9 4922.2 4928.0 4952.8 4958.4 4921.1 4926.5 4932.9 4938.4 4971.1 4082.4 4157.6 4204.0 4214.0 4251.2 3682.0 3716.3 3756.8 3784.8 3843.1 4313.2 4313.9 4317.5 4318.1 4351.0 4816.3 4954.3 4964.1 4966.6 4971.8 4332.5 4360.1 4364.7 4399.2 4409.0 4527.9 4529.3 4532.5 4542.3 4572.9 4547.8 4689.4 4738.9 4751.2 4757.7 5010.0 5031.1 5031.5 5041.5 5085.2 4719.3 4736.8 4738.0 4745.2 4792.0 4844.7 4882.7 4917.4 4982.5 4983.7 4968.9 4990.5 4996.3 4997.6 5036.3 4857.6 4862.8 4869.0 4871.3 4912.7 4667.2 4848.2 4911.0 4921.0 4927.7 4779.9 4788.9 4793.2 4793.2 4818.7 4885.7 4886.4 4890.0 4891.5 4939.3 4607.1 4750.3 4777.7 4823.3 4826.2 04:57:11 INFO - PROCESS | 8571 | 04:57:11 INFO - PROCESS | 8571 | [#1] ext.html Cycles:180 Average:41369.61 Median:18231.79 stddev:74370.87 (407.9%) stddev-sans-first:74516.40 04:57:11 INFO - PROCESS | 8571 | Values: 567.3 612.7 613.9 621.6 623.2 26715.9 27204.7 27254.3 27270.3 27273.0 27169.3 34341.8 35267.0 35273.1 35392.8 7703.7 7906.2 7911.3 7913.1 7914.5 7800.5 7951.5 7953.0 7961.9 7965.3 7943.9 7999.6 8002.3 8003.0 8003.6 7826.1 7875.0 7880.4 7910.0 7924.6 7779.9 7884.7 7902.4 7904.7 7908.3 37478.4 37980.2 38031.0 38042.8 38067.0 2910.9 2978.9 2991.6 3001.8 3063.3 27159.0 27174.3 28652.3 28765.3 29291.1 3264.0 3335.7 3352.3 3392.0 3394.7 224603.0 225632.0 226391.0 226490.0 226929.0 33127.8 51088.7 51443.7 51451.5 51540.2 31072.4 31112.7 31115.0 31146.1 31246.0 12200.5 12477.5 12495.5 12500.1 12543.3 10185.3 10251.2 10274.1 10284.3 10284.4 7923.2 8177.4 8184.8 8223.2 8251.5 3186.3 3192.3 3198.2 3218.9 3245.7 910.7 966.2 973.8 996.6 1020.4 28158.0 28214.4 28314.3 28535.0 28817.0 787.3 1001.6 1052.0 1058.8 1093.4 13087.5 13540.7 13752.7 13841.2 13847.2 329990.0 336772.0 337390.0 337685.0 338001.0 45369.0 46130.3 46138.3 46176.5 46252.3 1048.4 1203.6 1216.9 1228.7 1246.0 25351.9 26248.9 26749.7 26773.7 26801.7 38748.8 39970.6 40208.8 40364.8 40394.4 224943.0 226390.0 227496.0 227597.0 412643.0 25239.0 25777.6 25892.1 26067.5 26076.9 36794.3 36831.6 36959.0 36974.8 37950.6 31310.0 31931.2 31988.1 34760.8 35261.0 33465.5 33821.3 33940.8 34024.7 34174.0 34413.8 34653.5 34678.3 34798.8 34904.5 30210.2 31317.3 31460.5 31488.7 31503.8 23531.2 23623.8 24250.0 24367.4 24643.8 04:57:11 INFO - PROCESS | 8571 | 04:57:11 INFO - PROCESS | 8571 | [#2] jquery.html Cycles:180 Average:25041.25 Median:26062.34 stddev:64687.94 (248.2%) stddev-sans-first:64842.91 04:57:11 INFO - PROCESS | 8571 | Values: 381.4 382.8 386.2 386.5 398.9 15572.4 17033.9 17619.0 17912.8 17915.0 16551.7 16759.7 16841.2 17272.1 17275.6 5095.4 5210.6 5245.9 5275.8 5278.6 3655.2 3906.1 4302.4 6064.7 6076.8 5926.9 5989.0 6045.7 6048.8 6055.8 5737.7 5950.8 6004.1 6017.8 6029.5 5336.2 5377.0 5382.4 5386.2 5393.7 20051.8 20873.0 21337.3 21361.4 22186.8 2081.2 2099.4 2451.7 2693.0 2724.1 12767.2 13210.3 13212.8 13848.9 13851.0 1833.7 1865.4 1892.1 1925.2 1932.6 76868.6 77673.2 78106.6 78305.2 79528.6 15597.5 15853.6 15968.2 16961.2 16972.5 28532.0 28835.1 29010.9 29049.6 29097.0 7950.3 8670.3 8700.7 8798.3 8811.3 6949.1 6954.5 7069.6 7110.3 7134.6 7971.0 8002.0 8135.6 8164.5 8443.2 3032.6 3141.7 3170.5 3194.3 3505.9 775.6 844.0 845.8 913.2 932.7 16158.5 16464.3 16729.7 16957.0 17153.5 856.5 866.9 868.3 925.3 925.7 9447.3 9471.7 9478.4 9532.0 9670.7 379237.0 393469.0 394740.0 396097.0 398155.0 70103.0 71482.3 72416.6 72477.3 74260.6 929.1 935.1 939.3 942.9 948.2 14250.0 14529.3 14601.3 14670.3 14703.6 31226.0 32305.0 33178.7 33671.7 33813.7 45803.8 46709.8 46826.8 46882.5 47029.3 6158.1 6501.6 7710.6 7825.7 7975.4 7593.5 8147.9 8294.1 11435.3 11463.5 9716.4 9854.1 9866.7 10088.0 10126.1 9997.0 10130.8 10345.2 10461.7 10646.4 5257.1 7421.7 9744.2 10230.6 10317.1 7745.2 7771.8 7849.3 7853.1 7939.4 7921.5 9190.2 10499.5 10563.2 10681.0 04:57:11 INFO - PROCESS | 8571 | 04:57:11 INFO - PROCESS | 8571 | [#3] mootools.html Cycles:180 Average:5142.83 Median:5383.23 stddev:2858.24 (53.1%) stddev-sans-first:2851.38 04:57:11 INFO - PROCESS | 8571 | Values: 1262.8 1448.8 1492.5 1602.6 1772.8 6821.8 7615.5 7761.5 7774.8 7795.8 7502.9 7558.3 7630.4 7648.3 7658.6 1927.9 2191.2 2207.9 2213.1 2237.4 2228.3 2229.2 2229.6 2231.1 2234.2 2131.3 2157.3 2160.7 2161.1 2179.1 1879.2 2135.5 2169.5 2202.7 2204.6 2151.4 2173.3 2173.9 2174.8 2176.0 7609.4 7724.6 7728.6 7737.5 7748.4 4596.7 4730.2 4730.2 4749.1 4752.7 2888.8 2910.9 2937.8 2983.2 3001.3 891.2 902.3 909.8 934.8 941.6 10625.0 10661.0 10663.9 10696.2 10697.5 4155.8 4257.5 4411.4 4413.9 4416.2 9069.5 9124.4 9125.5 9155.9 9162.1 4789.0 4797.1 4812.7 4822.9 4827.8 3793.8 4219.1 4290.8 4295.8 4297.8 3637.3 3691.0 3771.1 3790.8 3819.0 1239.0 1245.6 1252.6 1254.1 1255.6 706.9 764.2 836.3 850.6 862.8 5122.4 5375.6 5386.7 5391.9 5393.6 922.4 937.4 940.2 947.6 951.0 3517.3 3686.9 3711.0 3768.3 3839.0 9552.7 9741.4 9768.7 9877.7 10001.8 9725.5 9793.4 9891.6 9902.7 9908.4 7377.7 7400.1 7488.6 7534.2 7565.6 5312.5 5346.2 5379.7 5507.2 5559.7 8618.6 8744.8 8793.2 8891.8 8898.9 8636.2 8786.7 8928.2 9022.4 9024.9 5973.2 6547.2 6561.2 6690.1 6700.3 7227.1 7231.1 7269.3 7304.0 7311.6 6444.0 6635.6 6641.1 6735.9 6746.6 6582.7 6587.6 6592.0 6639.3 6653.6 6249.9 6274.3 6305.9 6312.3 6329.1 4338.0 4443.6 4476.6 4481.0 4503.7 4444.1 4486.3 4524.8 4551.2 4565.5 04:57:11 INFO - PROCESS | 8571 | 04:57:11 INFO - PROCESS | 8571 | [#4] prototype.html Cycles:180 Average:4401.13 Median:5072.45 stddev:1286.34 (25.4%) stddev-sans-first:1252.82 04:57:11 INFO - PROCESS | 8571 | Values: 313.2 316.9 319.9 320.4 323.6 5072.6 5112.5 5130.3 5136.2 5176.6 5049.9 5057.9 5060.5 5072.3 5089.4 3738.8 3842.9 3989.4 3991.8 3993.0 3955.8 3979.7 3981.7 3983.7 3992.5 3703.5 3947.4 3957.4 3959.4 3963.6 3808.1 3933.8 3937.5 3946.7 3956.3 3481.1 3488.7 3496.9 3502.1 3506.4 4889.2 4893.0 4906.8 4914.1 4915.8 4235.9 4470.5 4486.1 4498.6 4580.1 5280.8 5290.6 5290.8 5291.0 5309.8 3707.6 3712.4 3727.6 3733.1 3739.8 5252.6 5556.3 5557.5 5582.2 5613.8 3801.8 3805.6 3807.0 3820.1 3828.1 3859.2 3878.3 3886.7 3886.7 3894.6 4205.0 4462.7 4474.6 4487.7 4491.5 5262.2 5283.4 5313.5 5314.3 5322.4 1309.9 1327.2 1344.3 1349.0 1351.5 831.9 881.7 897.2 907.9 909.3 4666.9 4677.3 4681.7 4684.0 4705.5 5429.5 5447.5 5449.5 5451.8 5452.5 4487.4 4651.9 4671.8 4678.9 4749.2 2920.1 2921.6 2933.8 2938.8 2941.0 5129.1 5146.9 5152.1 5154.3 5178.2 5495.5 5589.7 5623.0 5636.5 5639.2 5096.1 5132.9 5144.7 5154.2 5160.5 5502.2 5508.5 5512.5 5517.7 5522.4 5139.5 5416.4 5418.4 5440.1 5451.1 5132.9 5166.8 5166.9 5170.8 5170.9 3793.5 3808.2 3808.8 3814.8 3817.4 5215.3 5493.8 5493.8 5510.7 5519.4 5315.1 5328.1 5333.1 5336.3 5355.2 5142.5 5323.0 5323.3 5335.8 5338.0 4975.2 5253.9 5259.5 5261.7 5273.8 5254.3 5263.5 5284.0 5287.5 5292.4 5071.0 5207.8 5212.1 5231.8 5236.4 04:57:11 INFO - PROCESS | 8571 | 04:57:11 INFO - PROCESS | 8571 | [#5] yui.html Cycles:180 Average:12318.29 Median:47747.78 stddev:14323.83 (30.0%) stddev-sans-first:14337.36 04:57:11 INFO - PROCESS | 8571 | Values: 682.0 688.1 694.1 701.5 705.2 11634.5 11895.4 11935.3 11945.5 11950.5 10938.6 10991.3 11010.8 11012.6 11041.6 632.7 800.2 811.9 812.1 812.8 646.8 648.4 649.5 764.0 799.1 838.0 839.4 839.6 840.4 846.8 834.6 835.2 835.6 835.7 836.0 493.4 600.9 611.1 616.0 616.1 10797.5 10804.8 10806.8 10835.1 10891.8 11460.6 12123.6 12132.8 12172.8 12849.9 8695.3 8929.5 9010.5 9072.5 9230.9 2786.1 2795.9 2813.2 2825.0 2843.3 46719.0 47052.8 47459.3 47619.5 47876.0 9977.9 10005.9 10020.5 10129.3 10213.8 16955.0 17093.6 17109.7 17113.5 17121.0 6064.2 6166.2 6206.7 6239.3 6346.7 3315.0 3357.0 3357.2 3396.2 3449.3 2735.5 2837.5 2843.9 2844.4 2844.5 499.1 510.5 512.6 515.2 520.9 531.2 566.8 571.6 575.2 577.1 7615.6 7617.0 7734.8 7751.2 7974.2 502.4 537.8 555.4 561.1 584.3 3645.5 3780.3 3785.8 3817.5 3931.8 51432.7 52105.2 52119.0 52224.7 52262.5 44246.8 44744.8 45434.5 45835.3 46281.5 41225.6 41265.6 41479.4 41609.0 42660.8 7063.8 7183.4 7522.4 7529.5 7558.5 28510.4 28931.4 28966.3 28995.1 29372.4 34816.7 34854.5 37340.6 37391.6 38106.0 8484.4 8516.0 8547.9 8568.4 8606.4 10401.5 10432.9 10482.2 11201.8 11603.9 10611.3 10720.2 10784.2 10861.7 10889.6 9752.5 9816.6 10091.5 10311.2 10635.8 10899.1 11253.4 11532.9 11553.5 11560.4 8824.3 9086.9 9255.5 9316.8 9328.3 8316.9 8333.5 8924.6 9003.4 9065.9 04:57:11 INFO - PROCESS | 8571 | -------- Summary: end -------- 04:57:11 INFO - PROCESS | 8571 | 04:57:12 INFO - TEST-INFO | 8571: exit 0 04:57:12 INFO - TEST-OK | dromaeo_css | took 1117324ms 04:57:12 INFO - TEST-START | kraken 04:57:12 INFO - operating with platform_type : linux_ 04:57:12 INFO - Initialising browser for kraken test... 04:57:12 INFO - TEST-INFO | started process 8747 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphdBKUS/profile http://localhost:46356/getInfo.html) 04:57:16 INFO - PROCESS | 8747 | __metrics Screen width/height:1600/1200 04:57:16 INFO - PROCESS | 8747 | colorDepth:24 04:57:16 INFO - PROCESS | 8747 | Browser inner width/height: 1024/697 04:57:16 INFO - PROCESS | 8747 | __metrics 04:57:17 ERROR - PROCESS | 8747 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:57:17 INFO - TEST-INFO | 8747: exit 0 04:57:17 INFO - Browser initialized. 04:57:17 INFO - Running cycle 1/1 for kraken test... 04:57:17 INFO - TEST-INFO | started process 8829 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphdBKUS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:57:29 INFO - PROCESS | 8829 | RSS: Main: 154333184 04:57:29 INFO - PROCESS | 8829 | 04:57:32 INFO - PROCESS | 8829 | Cycle 1(1): loaded http://localhost:46356/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46356/tests/kraken/driver.html?testName=audio-beat-detection) 04:57:33 INFO - PROCESS | 8829 | RSS: Main: 209649664 04:57:33 INFO - PROCESS | 8829 | 04:57:36 INFO - PROCESS | 8829 | Cycle 1(1): loaded http://localhost:46356/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46356/tests/kraken/driver.html?testName=audio-dft) 04:57:36 INFO - PROCESS | 8829 | RSS: Main: 195186688 04:57:36 INFO - PROCESS | 8829 | 04:57:39 INFO - PROCESS | 8829 | Cycle 1(1): loaded http://localhost:46356/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46356/tests/kraken/driver.html?testName=audio-fft) 04:57:40 INFO - PROCESS | 8829 | RSS: Main: 266235904 04:57:40 INFO - PROCESS | 8829 | 04:57:42 INFO - PROCESS | 8829 | Cycle 1(1): loaded http://localhost:46356/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46356/tests/kraken/driver.html?testName=audio-oscillator) 04:57:43 INFO - PROCESS | 8829 | RSS: Main: 174682112 04:57:43 INFO - PROCESS | 8829 | 04:57:45 INFO - PROCESS | 8829 | Cycle 1(1): loaded http://localhost:46356/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46356/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:57:46 INFO - PROCESS | 8829 | RSS: Main: 179392512 04:57:46 INFO - PROCESS | 8829 | 04:57:49 INFO - PROCESS | 8829 | Cycle 1(1): loaded http://localhost:46356/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46356/tests/kraken/driver.html?testName=imaging-darkroom) 04:57:49 INFO - PROCESS | 8829 | RSS: Main: 215240704 04:57:49 INFO - PROCESS | 8829 | 04:57:53 INFO - PROCESS | 8829 | Cycle 1(1): loaded http://localhost:46356/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46356/tests/kraken/driver.html?testName=imaging-desaturate) 04:57:53 INFO - PROCESS | 8829 | RSS: Main: 211795968 04:57:53 INFO - PROCESS | 8829 | 04:57:56 INFO - PROCESS | 8829 | Cycle 1(1): loaded http://localhost:46356/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46356/tests/kraken/driver.html?testName=json-parse-financial) 04:57:57 INFO - PROCESS | 8829 | RSS: Main: 213340160 04:57:57 INFO - PROCESS | 8829 | 04:57:59 INFO - PROCESS | 8829 | Cycle 1(1): loaded http://localhost:46356/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46356/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:57:59 INFO - PROCESS | 8829 | RSS: Main: 201248768 04:57:59 INFO - PROCESS | 8829 | 04:58:01 INFO - PROCESS | 8829 | Cycle 1(1): loaded http://localhost:46356/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46356/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:58:02 INFO - PROCESS | 8829 | RSS: Main: 204009472 04:58:02 INFO - PROCESS | 8829 | 04:58:04 INFO - PROCESS | 8829 | Cycle 1(1): loaded http://localhost:46356/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46356/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:58:05 INFO - PROCESS | 8829 | RSS: Main: 220094464 04:58:05 INFO - PROCESS | 8829 | 04:58:07 INFO - PROCESS | 8829 | Cycle 1(1): loaded http://localhost:46356/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46356/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:58:08 INFO - PROCESS | 8829 | RSS: Main: 222736384 04:58:08 INFO - PROCESS | 8829 | 04:58:11 INFO - PROCESS | 8829 | Cycle 1(1): loaded http://localhost:46356/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46356/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:58:11 INFO - PROCESS | 8829 | RSS: Main: 217661440 04:58:11 INFO - PROCESS | 8829 | 04:58:13 INFO - PROCESS | 8829 | Cycle 1(1): loaded http://localhost:46356/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46356/tests/kraken/driver.html?testName=ai-astar) 04:58:14 INFO - PROCESS | 8829 | RSS: Main: 281243648 04:58:14 INFO - PROCESS | 8829 | 04:58:14 INFO - PROCESS | 8829 | __start_tp_report 04:58:14 INFO - PROCESS | 8829 | _x_x_mozilla_page_load 04:58:14 INFO - PROCESS | 8829 | _x_x_mozilla_page_load_details 04:58:14 INFO - PROCESS | 8829 | |i|pagename|runs| 04:58:14 INFO - PROCESS | 8829 | |0;ai-astar;109;115;109;114;115;114;102;115;112;112 04:58:14 INFO - PROCESS | 8829 | |1;audio-beat-detection;156;133;157;183;133;158;152;136;191;134 04:58:14 INFO - PROCESS | 8829 | |2;audio-dft;160;164;161;161;163;163;163;162;162;163 04:58:14 INFO - PROCESS | 8829 | |3;audio-fft;74;74;119;123;80;74;74;119;100;75 04:58:14 INFO - PROCESS | 8829 | |4;audio-oscillator;94;95;144;94;94;93;144;94;94;150 04:58:14 INFO - PROCESS | 8829 | |5;imaging-gaussian-blur;117;117;117;118;117;116;117;117;117;117 04:58:14 INFO - PROCESS | 8829 | |6;imaging-darkroom;147;146;145;145;147;146;146;146;146;146 04:58:14 INFO - PROCESS | 8829 | |7;imaging-desaturate;94;95;94;95;95;95;95;94;95;94 04:58:14 INFO - PROCESS | 8829 | |8;json-parse-financial;63;64;65;63;64;73;64;81;64;62 04:58:14 INFO - PROCESS | 8829 | |9;json-stringify-tinderbox;64;65;65;65;65;65;65;64;65;65 04:58:14 INFO - PROCESS | 8829 | |10;stanford-crypto-aes;79;86;79;77;87;78;79;81;80;79 04:58:14 INFO - PROCESS | 8829 | |11;stanford-crypto-ccm;134;139;134;142;130;151;134;141;164;138 04:58:14 INFO - PROCESS | 8829 | |12;stanford-crypto-pbkdf2;178;170;183;174;175;178;173;178;171;170 04:58:14 INFO - PROCESS | 8829 | |13;stanford-crypto-sha256-iterative;72;73;74;74;74;71;73;72;71;70 04:58:14 INFO - PROCESS | 8829 | __end_tp_report 04:58:14 INFO - PROCESS | 8829 | __start_cc_report 04:58:14 INFO - PROCESS | 8829 | _x_x_mozilla_cycle_collect,1877 04:58:14 INFO - PROCESS | 8829 | __end_cc_report 04:58:14 INFO - PROCESS | 8829 | __startTimestamp1461067094029__endTimestamp 04:58:14 INFO - PROCESS | 8829 | 04:58:14 INFO - PROCESS | 8829 | ------- Summary: start ------- 04:58:14 INFO - PROCESS | 8829 | Number of tests: 14 04:58:14 INFO - PROCESS | 8829 | 04:58:14 INFO - PROCESS | 8829 | [#0] ai-astar Cycles:10 Average:111.70 Median:114.00 stddev:4.11 (3.6%) stddev-sans-first:4.24 04:58:14 INFO - PROCESS | 8829 | Values: 109.0 115.0 109.0 114.0 115.0 114.0 102.0 115.0 112.0 112.0 04:58:14 INFO - PROCESS | 8829 | 04:58:14 INFO - PROCESS | 8829 | [#1] audio-beat-detection Cycles:10 Average:153.30 Median:156.50 stddev:20.67 (13.2%) stddev-sans-first:21.90 04:58:14 INFO - PROCESS | 8829 | Values: 156.0 133.0 157.0 183.0 133.0 158.0 152.0 136.0 191.0 134.0 04:58:14 INFO - PROCESS | 8829 | 04:58:14 INFO - PROCESS | 8829 | [#2] audio-dft Cycles:10 Average:162.20 Median:163.00 stddev:1.23 (0.8%) stddev-sans-first:1.01 04:58:14 INFO - PROCESS | 8829 | Values: 160.0 164.0 161.0 161.0 163.0 163.0 163.0 162.0 162.0 163.0 04:58:14 INFO - PROCESS | 8829 | 04:58:14 INFO - PROCESS | 8829 | [#3] audio-fft Cycles:10 Average:91.20 Median:74.00 stddev:21.62 (29.2%) stddev-sans-first:22.01 04:58:14 INFO - PROCESS | 8829 | Values: 74.0 74.0 119.0 123.0 80.0 74.0 74.0 119.0 100.0 75.0 04:58:14 INFO - PROCESS | 8829 | 04:58:14 INFO - PROCESS | 8829 | [#4] audio-oscillator Cycles:10 Average:109.60 Median:94.00 stddev:25.18 (26.8%) stddev-sans-first:26.06 04:58:14 INFO - PROCESS | 8829 | Values: 94.0 95.0 144.0 94.0 94.0 93.0 144.0 94.0 94.0 150.0 04:58:14 INFO - PROCESS | 8829 | 04:58:14 INFO - PROCESS | 8829 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 04:58:14 INFO - PROCESS | 8829 | Values: 117.0 117.0 117.0 118.0 117.0 116.0 117.0 117.0 117.0 117.0 04:58:14 INFO - PROCESS | 8829 | 04:58:14 INFO - PROCESS | 8829 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.60 04:58:14 INFO - PROCESS | 8829 | Values: 147.0 146.0 145.0 145.0 147.0 146.0 146.0 146.0 146.0 146.0 04:58:14 INFO - PROCESS | 8829 | 04:58:14 INFO - PROCESS | 8829 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 04:58:14 INFO - PROCESS | 8829 | Values: 94.0 95.0 94.0 95.0 95.0 95.0 95.0 94.0 95.0 94.0 04:58:14 INFO - PROCESS | 8829 | 04:58:14 INFO - PROCESS | 8829 | [#8] json-parse-financial Cycles:10 Average:66.30 Median:64.00 stddev:6.00 (9.4%) stddev-sans-first:6.24 04:58:14 INFO - PROCESS | 8829 | Values: 63.0 64.0 65.0 63.0 64.0 73.0 64.0 81.0 64.0 62.0 04:58:14 INFO - PROCESS | 8829 | 04:58:14 INFO - PROCESS | 8829 | [#9] json-stringify-tinderbox Cycles:10 Average:64.80 Median:65.00 stddev:0.42 (0.6%) stddev-sans-first:0.33 04:58:14 INFO - PROCESS | 8829 | Values: 64.0 65.0 65.0 65.0 65.0 65.0 65.0 64.0 65.0 65.0 04:58:14 INFO - PROCESS | 8829 | 04:58:14 INFO - PROCESS | 8829 | [#10] stanford-crypto-aes Cycles:10 Average:80.50 Median:79.50 stddev:3.34 (4.2%) stddev-sans-first:3.50 04:58:14 INFO - PROCESS | 8829 | Values: 79.0 86.0 79.0 77.0 87.0 78.0 79.0 81.0 80.0 79.0 04:58:14 INFO - PROCESS | 8829 | 04:58:14 INFO - PROCESS | 8829 | [#11] stanford-crypto-ccm Cycles:10 Average:140.70 Median:140.00 stddev:10.06 (7.2%) stddev-sans-first:10.37 04:58:14 INFO - PROCESS | 8829 | Values: 134.0 139.0 134.0 142.0 130.0 151.0 134.0 141.0 164.0 138.0 04:58:14 INFO - PROCESS | 8829 | 04:58:14 INFO - PROCESS | 8829 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.00 Median:176.50 stddev:4.24 (2.4%) stddev-sans-first:4.36 04:58:14 INFO - PROCESS | 8829 | Values: 178.0 170.0 183.0 174.0 175.0 178.0 173.0 178.0 171.0 170.0 04:58:14 INFO - PROCESS | 8829 | 04:58:14 INFO - PROCESS | 8829 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.40 Median:73.00 stddev:1.43 (2.0%) stddev-sans-first:1.51 04:58:14 INFO - PROCESS | 8829 | Values: 72.0 73.0 74.0 74.0 74.0 71.0 73.0 72.0 71.0 70.0 04:58:14 INFO - PROCESS | 8829 | -------- Summary: end -------- 04:58:14 INFO - PROCESS | 8829 | 04:58:15 INFO - TEST-INFO | 8829: exit 0 04:58:15 INFO - TEST-OK | kraken | took 62607ms 04:58:15 INFO - SUITE-END | took 1179s 04:58:15 INFO - Completed test suite (00:19:40) 04:58:15 INFO - javascript benchmark 04:58:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2609.1650671785023, 2659.202239328201, 2674.2200606329116, 2714.7556719895206, 2725.2369336585753, 4580.175568397687, 4658.394408726861, 4715.622750179986, 4755.952440475594, 4785.210440277355, 4638.860834174971, 4716.033213191296, 4759.333693282943, 4805.0389922015565, 4821.734804585746, 4286.657067434598, 4301.397804307399, 4312.094460163369, 4331.545187755288, 4391.780410979454, 4250.0, 4304.870853874373, 4388.780560971954, 4402.559744025604, 4418.9337159942625, 4188.057687020427, 4338.132373525276, 4370.4755429348525, 4381.474223093233, 4382.4741031076155, 4205.600467955539, 4282.657387409, 4288.399624052635, 4320.330348795942, 4343.109662519176, 4228.9154216915795, 4234.872953811359, 4245.0, 4285.657147428198, 4292.420523229386, 4438.667099967483, 4529.456465224162, 4543.250363689987, 4562.817487300504, 4584.862454126348, 4999.8000079996755, 5035.622328325354, 5044.066847633199, 5077.441481437039, 5082.161443361841, 5009.4239162496415, 5019.698818070891, 5020.2720605511995, 5059.544640982329, 5083.0, 4548.74981876, 4660.86017419478, 4673.345731597579, 4685.742284174403, 4690.788914498821, 5160.071187186268, 5167.844964651066, 5187.325647665779, 5212.843614691566, 5218.086834803894, 4944.53026962438, 4948.0, 4952.975235123801, 4957.20684690455, 5024.84925452237, 4888.022395520839, 5043.899122017539, 5045.596352291808, 5047.394312682502, 5052.747362631853, 4892.8532144035735, 4922.237053256751, 4928.0, 4952.777125029383, 4958.380202474691, 4921.114199444134, 4926.531979461945, 4932.8766780830765, 4938.38270216223, 4971.105201063843, 4082.3672330788777, 4157.646600039031, 4204.012057166564, 4213.97893010533, 4251.234777740036, 3681.9631803682155, 3716.3496388132507, 3756.7933763643264, 3784.829682664287, 3843.1160833008566, 4313.223619748475, 4313.870583882489, 4317.460317460317, 4318.136372725405, 4350.9564904350555, 4816.301636262722, 4954.331165292711, 4964.05682920244, 4966.553010229097, 4971.751412429364, 4332.458442694663, 4360.106178233455, 4364.650827933758, 4399.1641588098155, 4409.0, 4527.886802829956, 4529.297958816389, 4532.478764942074, 4542.250528662799, 4572.9314060289125, 4547.8180872764715, 4689.413823272091, 4738.928916066262, 4751.192297309535, 4757.690750101232, 5010.0, 5031.144705400164, 5031.496850315086, 5041.470645582308, 5085.211792172219, 4719.2921061841, 4736.834210802605, 4737.952620473751, 4745.217039188496, 4792.041591681747, 4844.660873738804, 4882.658213924991, 4917.360743103373, 4982.526659967298, 4983.70097794119, 4968.875778105432, 4990.50094990498, 4996.325496058131, 4997.600191984705, 5036.29491871131, 4857.635677324144, 4862.756862156807, 4868.95131048685, 4871.269309603446, 4912.729799861042, 4667.159911215878, 4848.248521479177, 4910.975445122752, 4920.975395123001, 4927.655064145475, 4779.948411349497, 4788.928166077581, 4793.209120495079, 4793.2091204952185, 4818.686785359081, 4885.731284779371, 4886.389201349832, 4890.046440943982, 4891.461939186615, 4939.283803848493, 4607.101615185007, 4750.263709125091, 4777.713337199779, 4823.300621409946, 4826.1795494766675], "value": 4597.457933818716, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [567.302218271526, 612.7089632424596, 613.8864310102631, 621.5742216581642, 623.2085251730302, 26715.866420667895, 27204.727952720466, 27254.31864203396, 27270.31824204396, 27273.0, 27169.320766980836, 34341.828290858575, 35267.0, 35273.11817204571, 35392.82303588485, 7703.653335599897, 7906.209379062077, 7911.287984081431, 7913.129555748863, 7914.52512849228, 7800.453968222227, 7951.522908625501, 7953.0, 7961.880571791427, 7965.322947549465, 7943.880841787378, 7999.600019998977, 8002.279794818465, 8003.0, 8003.639836207385, 7826.1391246962785, 7875.0, 7880.408969327266, 7909.96045019777, 7924.564148971805, 7779.922200777976, 7884.72403465876, 7902.446828721992, 7904.723334683316, 7908.2882540571045, 37478.43782343267, 37980.24039519222, 38031.0, 38042.80978595117, 38067.0, 2910.941781164365, 2978.851057447119, 2991.6110905582136, 3001.8048826826184, 3063.2801291696433, 27159.0, 27174.320641984108, 28652.283692907637, 28765.28086797847, 29291.121266362043, 3263.9836800816083, 3335.7368407966433, 3352.279259959096, 3391.982405278431, 3394.6605339466105, 224603.0, 225632.0, 226391.0, 226490.0, 226929.0, 33127.83436082852, 51088.74455627698, 51443.74278128585, 51451.485485145415, 51540.22689659658, 31072.378552428825, 31112.68887311143, 31115.0, 31146.065618031495, 31246.0, 12200.511979520898, 12477.500899964081, 12495.500179992698, 12500.062495312888, 12543.3101179436, 10185.287029907835, 10251.231157663206, 10274.075333220046, 10284.331518451278, 10284.434356110336, 7923.247291507298, 8177.427580069338, 8184.7953801155445, 8223.17768223173, 8251.463654862415, 3186.3467989062187, 3192.2657788708725, 3198.2484116232667, 3218.935621287608, 3245.7403407727797, 910.6858133943779, 966.1883523373568, 973.8089299077077, 996.6147055592731, 1020.3877673395903, 28158.0, 28214.43571128566, 28314.2921426966, 28535.0, 28817.0, 787.2835719495346, 1001.5843424978552, 1052.0, 1058.8147074261974, 1093.3549205968516, 13087.476500940045, 13540.729185416236, 13752.724945501233, 13841.238731869844, 13847.16916984964, 329990.0, 336772.0, 337390.0, 337685.0, 338001.0, 45369.0, 46130.308045379345, 46138.307925381145, 46176.538234617896, 46252.306215406796, 1048.370977413561, 1203.5907791350983, 1216.9087318451152, 1228.705110773408, 1246.0, 25351.87324063368, 26248.868755656098, 26749.732502675502, 26773.732262677124, 26801.731982679925, 38748.80625596854, 39970.60029399785, 40208.798956005034, 40364.79817600893, 40394.39408408818, 224943.0, 226390.0, 227496.0, 227597.0, 412643.0, 25239.0, 25777.613335800354, 25892.093776717724, 26067.478650426507, 26076.8696156518, 36794.26411471809, 36831.63168368389, 36959.009854876465, 36974.8151259242, 37950.62049379471, 31310.0, 31931.201719957186, 31988.071669716937, 34760.82619586886, 35261.0, 33465.49801753024, 33821.32357352888, 33940.83029584836, 34024.65975340314, 34174.0, 34413.827930860185, 34653.48019779655, 34678.306433870675, 34798.82600587082, 34904.47643285403, 30210.24474388158, 31317.338026267113, 31460.52809207818, 31488.685113148575, 31503.84248078745, 23531.235157363608, 23623.763762362156, 24250.0, 24367.390815229053, 24643.753562464146], "value": 15691.626757483564, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [381.4449975285958, 382.79329162252367, 386.2333268462103, 386.5419477918667, 398.8683734367659, 15572.398563070514, 17033.91483042583, 17619.0, 17912.82087179131, 17915.0, 16551.66896662069, 16759.748603770953, 16841.242144103515, 17272.13639318032, 17275.568110797238, 5095.388553373591, 5210.635255532115, 5245.921311180336, 5275.762590683409, 5278.604104692164, 3655.1958569114754, 3906.0625449891963, 4302.354646802974, 6064.696765161746, 6076.756929722806, 5926.851828704273, 5988.97005514974, 6045.697715114248, 6048.788292409767, 6055.788047418341, 5737.713114344287, 5950.761969521214, 6004.0693692477735, 6017.789377371815, 6029.487493563074, 5336.226247194135, 5377.0, 5382.434844341327, 5386.165144402624, 5393.703346315951, 20051.79948200514, 20873.0, 21337.25319613806, 21361.35915922525, 22186.778132218795, 2081.2091405266056, 2099.4331530486684, 2451.7425670304538, 2692.986535067312, 2724.0738149029426, 12767.233965962072, 13210.273434961073, 13212.801807972888, 13848.86151138496, 13851.030427870053, 1833.706606942896, 1865.3750993417223, 1892.0917959379574, 1925.1817977359567, 1932.6327997680537, 76868.61565692192, 77673.22326776717, 78106.60946695287, 78305.21694783094, 79528.60235698843, 15597.532074037797, 15853.603659908364, 15968.201589920458, 16961.166067670656, 16972.49082527526, 28532.0, 28835.134945951653, 29010.854945725136, 29049.56425653617, 29097.0, 7950.284474397332, 8670.306375489945, 8700.695475658322, 8798.34012449056, 8811.251043661232, 6949.131358580177, 6954.478414118961, 7069.575825450489, 7110.32451917067, 7134.571925684476, 7970.960145199237, 8002.0, 8135.616945119344, 8164.510129392255, 8443.240108390275, 3032.6360836699737, 3141.659179394992, 3170.461021626329, 3194.3167739099267, 3505.859765609347, 775.5734346109617, 843.9873401898976, 845.8054647431126, 913.2237598041611, 932.664240873285, 16158.515244542683, 16464.259108340153, 16729.665406691798, 16956.982581045177, 17153.485395438158, 856.4518708026868, 866.9263112635497, 868.3400615532241, 925.3383830561181, 925.7361651929168, 9447.33868629203, 9471.715848524555, 9478.431294122374, 9531.952340238393, 9670.70987870365, 379237.0, 393469.0, 394740.0, 396097.0, 398155.0, 70103.0, 71482.2851771486, 72416.63791681008, 72477.27522724705, 74260.62869685618, 929.1451864284874, 935.102301790289, 939.2720641503026, 942.8585712143097, 948.1656142594611, 14250.0, 14529.273536323353, 14601.269936503344, 14670.33983470725, 14703.55889323322, 31226.0, 32305.0, 33178.66821331756, 33671.66328336783, 33813.66186338105, 45803.77098114488, 46709.766451167525, 46826.76586617045, 46882.531174687814, 47029.294560582304, 6158.076288556752, 6501.642409667514, 7710.643486430149, 7825.726099586487, 7975.361971042186, 7593.468457207942, 8147.877781833396, 8294.129116442928, 11435.256708313933, 11463.484143213409, 9716.417014979124, 9854.11312981835, 9866.654667086617, 10088.0, 10126.088652021353, 9997.0, 10130.797384052425, 10345.172386208935, 10461.68614941553, 10646.361218326925, 5257.132573125392, 7421.740239091606, 9744.220462363135, 10230.618866452933, 10317.123044540998, 7745.186755390603, 7771.844563108819, 7849.254320839511, 7853.1361550228285, 7939.444238903221, 7921.485103468256, 9190.218831399407, 10499.527521261714, 10563.15494760402, 10681.0], "value": 8873.148188375206, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1262.8168915507247, 1448.768197088466, 1492.4850926430381, 1602.6313947792007, 1772.804991450941, 6821.761238356658, 7615.504992175512, 7761.495502792329, 7774.8445031099345, 7795.844083118342, 7502.92497075029, 7558.2819632135, 7630.351420129296, 7648.2734140256725, 7658.617069146534, 1927.8650494465394, 2191.189259973804, 2207.878566678832, 2213.1368766181204, 2237.3847192022163, 2228.3092241405134, 2229.2420577003813, 2229.6209644360415, 2231.1187081102953, 2234.19568955176, 2131.3286314810784, 2157.320444060116, 2160.6650969099737, 2161.070739581979, 2179.0847843905517, 1879.2013394307432, 2135.519508110678, 2169.490169810101, 2202.680611311367, 2204.5811295853896, 2151.354593621907, 2173.3154056472163, 2173.913043478259, 2174.7607763146198, 2176.031665908671, 7609.353204977583, 7724.613769311568, 7728.574928378937, 7737.497062690907, 7748.380129589619, 4596.747178905159, 4730.195866702668, 4730.219513780222, 4749.050189961987, 4752.6910750801435, 2888.79778415511, 2910.9272268193254, 2937.8384188869604, 2983.2243616659607, 3001.3397052648384, 891.2157301574638, 902.3007169443669, 909.7771046093683, 934.8083642853267, 941.637469574212, 10624.999999999924, 10661.0, 10663.946680266548, 10696.197785166143, 10697.518611662494, 4155.750654960712, 4257.467816522934, 4411.404460397805, 4413.933790993137, 4416.24923762961, 9069.54652267384, 9124.361294709439, 9125.498097604695, 9155.908440915506, 9162.129597688208, 4788.976055119702, 4797.088553174955, 4812.663113582085, 4822.927656085161, 4827.758612069452, 3793.772373657534, 4219.07180420307, 4290.828366865353, 4295.78521073945, 4297.806598703066, 3637.308911306843, 3691.0, 3771.132639492877, 3790.75360101598, 3818.961810381916, 1238.9690257743628, 1245.5640525815893, 1252.5929073051295, 1254.084518301645, 1255.579380907388, 706.9151701795818, 764.1746913333586, 836.2975100915261, 850.6427300533667, 862.7713655881197, 5122.410922743858, 5375.623706340519, 5386.730663466811, 5391.946080539223, 5393.6224464287125, 922.4188761080476, 937.4188003437912, 940.1773448232797, 947.5925352098526, 950.9729492148601, 3517.278957813642, 3686.9262614747554, 3711.0, 3768.3028639701743, 3839.040239940015, 9552.713418597454, 9741.366811157252, 9768.724719073098, 9877.654282100091, 10001.79996400068, 9725.513724313756, 9793.36343137708, 9891.60433582663, 9902.702918912444, 9908.405495670282, 7377.704891804375, 7400.148982866932, 7488.625568721543, 7534.208908064684, 7565.583892885944, 5312.5218730314455, 5346.224797404277, 5379.73101344939, 5507.201455788968, 5559.72201389937, 8618.612162452579, 8744.825103498022, 8793.164649358301, 8891.777705557413, 8898.911010889808, 8636.222739953435, 8786.736397908073, 8928.15182557656, 9022.368434209542, 9024.864627030469, 5973.193618861398, 6547.214334279917, 6561.212654481493, 6690.096836927147, 6700.329967003261, 7227.096612923385, 7231.096112985877, 7269.345758881726, 7303.963480182565, 7311.597862117422, 6444.0, 6635.6350400728425, 6641.136652235178, 6735.865282694416, 6746.595204287759, 6582.703778329891, 6587.571807832475, 6592.044153597797, 6639.3360663935155, 6653.567518111307, 6249.875002500015, 6274.278457977391, 6305.873882522415, 6312.274088479883, 6329.145565348803, 4337.9783101084295, 4443.577860103285, 4476.641868650565, 4480.955190448054, 4503.707259028152, 4444.066745983379, 4486.304622783474, 4524.819007239806, 4551.226291530514, 4565.497795242587], "value": 4159.30034594386, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [313.2435169066704, 316.92076980754814, 319.8528676808668, 320.4344332253573, 323.59873756541896, 5072.644914855961, 5112.51431114044, 5130.256112863637, 5136.152534831757, 5176.637635365526, 5049.949500504994, 5057.9241311380265, 5060.493950604938, 5072.26452164436, 5089.389273287202, 3738.8130593470355, 3842.8855631866863, 3989.381645844884, 3991.7804520751347, 3992.9817896436366, 3955.8417663293435, 3979.6617287530594, 3981.701372397067, 3983.7012224083164, 3992.4610177626087, 3703.462997865308, 3947.3881548359905, 3957.445957565943, 3959.3862951242604, 3963.6036396360278, 3808.1241314497684, 3933.7836418997085, 3937.5274967004143, 3946.684265258801, 3956.3076461619103, 3481.0775144586705, 3488.7383446241633, 3496.877609283663, 3502.124468882779, 3506.386382383073, 4889.242167464049, 4893.04585605807, 4906.828261010884, 4914.0908931847725, 4915.754212289371, 4235.894102647428, 4470.508244093147, 4486.080353527519, 4498.640108791289, 4580.129775342674, 5280.78541935357, 5290.576753859682, 5290.814821481268, 5291.0, 5309.787608495655, 3707.6292370762976, 3712.350338690718, 3727.552693676776, 3733.1040550268012, 3739.7943113128767, 5252.579793616502, 5556.277683901108, 5557.472040156179, 5582.162675598652, 5613.803516876889, 3801.82891769871, 3805.6384643458828, 3807.0114959756456, 3820.1213720843807, 3828.1003964068423, 3859.1895701902354, 3878.3406820840523, 3886.6696330811633, 3886.6696330812197, 3894.6494815466745, 4204.978975105105, 4462.665300102505, 4474.552544745499, 4487.708298960557, 4491.46102467706, 5262.210668399694, 5283.365996080495, 5313.521783039545, 5314.256004159421, 5322.361316642027, 1309.9017573682013, 1327.1771501669027, 1344.28080976677, 1348.9730205395838, 1351.5337208662995, 831.8876951611455, 881.7134431309722, 897.1835629577184, 907.9001309855911, 909.2725819344498, 4666.906661866744, 4677.321788340671, 4681.6722829401615, 4683.95316046842, 4705.4588722296685, 5429.511343979061, 5447.53695935842, 5449.536789372868, 5451.754671039813, 5452.5365343946205, 4487.41663583732, 4651.883702907455, 4671.76641167947, 4678.8596342109795, 4749.24012158053, 2920.0801747449486, 2921.575092673076, 2933.750631196372, 2938.839158532368, 2941.014760055363, 5129.076766182123, 5146.871328216825, 5152.149895267314, 5154.304168937146, 5178.249153872667, 5495.505404513533, 5589.720513974366, 5622.971885140548, 5636.520895723827, 5639.210510528529, 5096.063495871619, 5132.948670513247, 5144.742762861917, 5154.201098829687, 5160.535551800356, 5502.174673798962, 5508.531774799187, 5512.503874651301, 5517.724113794375, 5522.420145884625, 5139.537441630271, 5416.4041955385665, 5418.403975562606, 5440.102383106743, 5451.1005684063275, 5132.871678208075, 5166.819161329336, 5166.881578552926, 5170.819021334235, 5170.870728231825, 3793.506844110248, 3808.2383523294898, 3808.771473711586, 3814.8474061037246, 3817.370133927982, 5215.269862219368, 5493.813588118961, 5493.835184944458, 5510.6969116698965, 5519.3652729936575, 5315.123004704181, 5328.09422398201, 5333.093374126485, 5336.306280183551, 5355.22349259363, 5142.537171654569, 5323.0, 5323.2547443358735, 5335.813246536352, 5338.0, 4975.228839529878, 5253.947460525499, 5259.500347466985, 5261.736913154404, 5273.762680679455, 5254.290670759398, 5263.499967503081, 5284.0, 5287.4976877196605, 5292.41783403833, 5070.974645126751, 5207.791688332424, 5212.139996900621, 5231.808596756052, 5236.39781425141], "value": 3992.7475674358907, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [681.9624920629365, 688.1432616392585, 694.1080711285996, 701.4984286235342, 705.2383425900028, 11634.534618615256, 11895.405229738522, 11935.283882967027, 11945.462454189561, 11950.521979120836, 10938.56245750169, 10991.285566438177, 11010.779784404307, 11012.559497620106, 11041.613543525978, 632.6899819088659, 800.1918062756629, 811.8579248631495, 812.10262659761, 812.8211793405442, 646.7800947677789, 648.3646026893647, 649.5290914087273, 763.9656215470317, 799.0650938402083, 837.9902217827533, 839.4040231435657, 839.6221700234888, 840.357126798, 846.7967687754925, 834.6327615849068, 835.1523203947967, 835.5655059369125, 835.6699103853974, 836.0135040652028, 493.37341576198384, 600.8708127752554, 611.1260896917406, 616.014376996806, 616.0820377637333, 10797.460126993697, 10804.837927431096, 10806.837897431546, 10835.133189344833, 10891.83662245067, 11460.598879039277, 12123.6362909112, 12132.818007729891, 12172.81740773889, 12849.935750321189, 8695.347848911293, 8929.508877011762, 9010.459372437675, 9072.54637268134, 9230.907690923072, 2786.080593404172, 2795.9021434249703, 2813.1982385020374, 2824.957625635617, 2843.3176037750995, 46719.0, 47052.76473617644, 47459.28811067837, 47619.523804761855, 47876.04247915057, 9977.850332245021, 10005.899941000642, 10020.498975051218, 10129.290949633454, 10213.795724085625, 16955.0, 17093.572660683334, 17109.743353849703, 17113.48659540216, 17121.0, 6064.241969753781, 6166.167567378437, 6206.658633775186, 6239.344868788802, 6346.650934198571, 3315.0386387947706, 3356.983215083958, 3357.2110554019787, 3396.1509622594353, 3449.292894956578, 2735.480258750831, 2837.5318072517803, 2843.8720257588457, 2844.416894536615, 2844.5448728203387, 499.0592732698889, 510.48186091117543, 512.5873671694322, 515.2451658320579, 520.903632827928, 531.1634176172544, 566.832784328624, 571.588456311455, 575.1803679756414, 577.1170109732033, 7615.581143037075, 7616.961915190499, 7734.806629834299, 7751.224877512203, 7974.162712915177, 502.3519659639098, 537.7553213287945, 555.447524169946, 561.0714267886655, 584.3484514766005, 3645.54430696163, 3780.31954248238, 3785.8107094645156, 3817.4846395736777, 3931.8427262909736, 51432.74283628633, 52105.2184217237, 52119.0, 52224.738876305375, 52262.47737522576, 44246.77876610596, 44744.77627611841, 45434.54565454369, 45835.31247031297, 46281.53718462772, 41225.58774412277, 41265.58734412617, 41479.37780933289, 41609.0, 42660.78669606694, 7063.752768653072, 7183.389411900047, 7522.435817313614, 7529.548227106391, 7558.508696934681, 28510.42979140447, 28931.42137157203, 28966.27584310409, 28995.13014609565, 29372.412551749272, 34816.651833481345, 34854.47718284177, 37340.626593733716, 37391.6260837399, 38106.0473488165, 8484.448510846774, 8515.957420212859, 8547.914520854712, 8568.40021198535, 8606.354523410895, 10401.479926003518, 10432.895671043496, 10482.161427085663, 11201.775964480828, 11603.88396116028, 10611.257211995086, 10720.249582529148, 10784.245102842726, 10861.67414977552, 10889.564417423215, 9752.512374381395, 9816.55825487869, 10091.545880435546, 10311.175105991653, 10635.840462392916, 10899.128069754559, 11253.437328133725, 11532.94233528827, 11553.480093395985, 11560.364179970182, 8824.294056475595, 9086.863697044417, 9255.490947997925, 9316.767080822763, 9328.347015708836, 8316.875246871423, 8333.499990000619, 8924.553772311489, 9003.369764116449, 9065.864012039956], "value": 5633.832975961223, "unit": "score"}], "name": "dromaeo_css", "value": 6255.097097672109, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 115.0, 109.0, 114.0, 115.0, 114.0, 102.0, 115.0, 112.0, 112.0], "value": 111.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 133.0, 157.0, 183.0, 133.0, 158.0, 152.0, 136.0, 191.0, 134.0], "value": 153.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 164.0, 161.0, 161.0, 163.0, 163.0, 163.0, 162.0, 162.0, 163.0], "value": 162.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 119.0, 123.0, 80.0, 74.0, 74.0, 119.0, 100.0, 75.0], "value": 91.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 144.0, 94.0, 94.0, 93.0, 144.0, 94.0, 94.0, 150.0], "value": 109.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 118.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 145.0, 145.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 65.0, 63.0, 64.0, 73.0, 64.0, 81.0, 64.0, 62.0], "value": 66.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 65.0, 65.0, 65.0, 65.0, 65.0, 64.0, 65.0, 65.0], "value": 64.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 86.0, 79.0, 77.0, 87.0, 78.0, 79.0, 81.0, 80.0, 79.0], "value": 80.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 139.0, 134.0, 142.0, 130.0, 151.0, 134.0, 141.0, 164.0, 138.0], "value": 140.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 170.0, 183.0, 174.0, 175.0, 178.0, 173.0, 178.0, 171.0, 170.0], "value": 175.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 73.0, 74.0, 74.0, 74.0, 71.0, 73.0, 72.0, 71.0, 70.0], "value": 72.4, "unit": "score"}], "name": "kraken", "value": 1585.3000000000002, "alertThreshold": 2.0}]} 04:58:15 INFO - Return code: 0 04:58:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:58:15 ERROR - # TBPL SUCCESS # 04:58:15 INFO - Running post-action listener: _resource_record_post_action 04:58:15 INFO - Running post-run listener: _resource_record_post_run 04:58:16 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 0; Write bytes: 519557120; Read time: 0; Write time: 452940 04:58:16 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 240607232; Read time: 0; Write time: 280832 04:58:16 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 0; Write bytes: 278949888; Read time: 0; Write time: 172108 04:58:16 INFO - Running post-run listener: _upload_blobber_files 04:58:16 INFO - Blob upload gear active. 04:58:16 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:58:16 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:58:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:58:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:58:16 INFO - (blobuploader) - INFO - Open directory for files ... 04:58:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:58:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:58:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:58:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:58:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:58:17 INFO - (blobuploader) - INFO - Done attempting. 04:58:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:58:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:58:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:58:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:58:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:58:18 INFO - (blobuploader) - INFO - Done attempting. 04:58:18 INFO - (blobuploader) - INFO - Iteration through files over. 04:58:18 INFO - Return code: 0 04:58:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:58:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:58:18 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/38631acc8645376e8ac4db1c36da3a30964f5a455078d13d3e5a4a61f7a8f6b810747f61292f409020257c82568227213119068b78ac657f1c4af4822345d10b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b79baae08d6ac468879bbbf0ca1cd758fd51ef0b447f25f80fad55393fa7e0d4466716ab5cb86e847df1917eba2846e119cb26cf167bf7f93aa96035096d8405"} 04:58:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:58:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:58:18 INFO - Contents: 04:58:18 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/38631acc8645376e8ac4db1c36da3a30964f5a455078d13d3e5a4a61f7a8f6b810747f61292f409020257c82568227213119068b78ac657f1c4af4822345d10b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b79baae08d6ac468879bbbf0ca1cd758fd51ef0b447f25f80fad55393fa7e0d4466716ab5cb86e847df1917eba2846e119cb26cf167bf7f93aa96035096d8405"} 04:58:18 INFO - Running post-run listener: copy_logs_to_upload_dir 04:58:18 INFO - Copying logs to upload dir... 04:58:18 INFO - mkdir: /builds/slave/test/build/upload/logs 04:58:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.490969 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-04-19 04:58:17.910367) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-19 04:58:17.913541) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1461065172.603670-1984451590 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-Non-PGO/sha512/38631acc8645376e8ac4db1c36da3a30964f5a455078d13d3e5a4a61f7a8f6b810747f61292f409020257c82568227213119068b78ac657f1c4af4822345d10b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b79baae08d6ac468879bbbf0ca1cd758fd51ef0b447f25f80fad55393fa7e0d4466716ab5cb86e847df1917eba2846e119cb26cf167bf7f93aa96035096d8405"} build_url:https://queue.taskcluster.net/v1/task/emcTFQvoSFWyMwkGeum6Nw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011404 build_url: 'https://queue.taskcluster.net/v1/task/emcTFQvoSFWyMwkGeum6Nw/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-Non-PGO/sha512/38631acc8645376e8ac4db1c36da3a30964f5a455078d13d3e5a4a61f7a8f6b810747f61292f409020257c82568227213119068b78ac657f1c4af4822345d10b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b79baae08d6ac468879bbbf0ca1cd758fd51ef0b447f25f80fad55393fa7e0d4466716ab5cb86e847df1917eba2846e119cb26cf167bf7f93aa96035096d8405"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-19 04:58:17.938834) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 04:58:17.939187) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1461065172.603670-1984451590 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004393 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 04:58:18.023551) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-19 04:58:18.023895) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-19 04:58:18.024198) ========= ========= Total master_lag: 0.17 =========