builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-043 starttime: 1461832055.08 results: success (0) buildid: 20160428004946 builduid: 06e8e06109ba41128714129a5c173f67 revision: e7570b6d28aaf015f5f69cf3a95f6396bf87e451 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-28 01:27:35.084570) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-28 01:27:35.085041) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-28 01:27:35.085336) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-28 01:27:35.101984) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 01:27:35.102315) ========= 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=d2a8c569965ab8367867b893000001a1-1461831939.134167-1763156482 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-28 01:27:35-- 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% 221M=0s 2016-04-28 01:27:35 (221 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.177751 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 01:27:35.293332) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 01:27:35.293670) ========= 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=d2a8c569965ab8367867b893000001a1-1461831939.134167-1763156482 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015101 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 01:27:35.342973) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-04-28 01:27:35.343332) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev e7570b6d28aaf015f5f69cf3a95f6396bf87e451 --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 e7570b6d28aaf015f5f69cf3a95f6396bf87e451 --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=d2a8c569965ab8367867b893000001a1-1461831939.134167-1763156482 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-28 01:27:35,615 truncating revision to first 12 chars 2016-04-28 01:27:35,615 Setting DEBUG logging. 2016-04-28 01:27:35,615 attempt 1/10 2016-04-28 01:27:35,615 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/e7570b6d28aa?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-28 01:27:36,675 unpacking tar archive at: fx-team-e7570b6d28aa/testing/mozharness/ program finished with exit code 0 elapsedTime=1.365563 ========= master_lag: 0.87 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-04-28 01:27:37.578655) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-28 01:27:37.578975) ========= script_repo_revision: e7570b6d28aaf015f5f69cf3a95f6396bf87e451 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-28 01:27:37.579362) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-28 01:27:37.579636) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-28 01:27:37.648424) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-04-28 01:27:37.648702) ========= /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=d2a8c569965ab8367867b893000001a1-1461831939.134167-1763156482 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:27:38 INFO - MultiFileLogger online at 20160428 01:27:38 in /builds/slave/test 01:27:38 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 01:27:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:27:38 INFO - {'append_to_log': False, 01:27:38 INFO - 'base_work_dir': '/builds/slave/test', 01:27:38 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 01:27:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:27:38 INFO - 'branch': 'Fx-Team-Non-PGO', 01:27:38 INFO - 'buildbot_json_path': 'buildprops.json', 01:27:38 INFO - 'config_files': ('talos/linux_config.py',), 01:27:38 INFO - 'default_actions': ('clobber', 01:27:38 INFO - 'read-buildbot-config', 01:27:38 INFO - 'download-and-extract', 01:27:38 INFO - 'populate-webroot', 01:27:38 INFO - 'create-virtualenv', 01:27:38 INFO - 'install', 01:27:38 INFO - 'run-tests'), 01:27:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:27:38 INFO - 'download_minidump_stackwalk': True, 01:27:38 INFO - 'download_symbols': 'ondemand', 01:27:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:27:38 INFO - 'tooltool.py': '/tools/tooltool.py', 01:27:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:27:38 INFO - '/tools/misc-python/virtualenv.py')}, 01:27:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:27:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:27:38 INFO - 'installer_path': 'installer.exe', 01:27:38 INFO - 'log_level': 'info', 01:27:38 INFO - 'log_name': 'talos', 01:27:38 INFO - 'log_to_console': True, 01:27:38 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:27:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:27:38 INFO - 'opt_config_files': (), 01:27:38 INFO - 'pip_index': False, 01:27:38 INFO - 'sps_profile': False, 01:27:38 INFO - 'sps_profile_interval': 0, 01:27:38 INFO - 'suite': 'dromaeojs', 01:27:38 INFO - 'system_bits': '32', 01:27:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:27:38 INFO - 'title': 'talos-linux64-ix-043', 01:27:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:27:38 INFO - 'use_talos_json': True, 01:27:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:27:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:27:38 INFO - 'work_dir': 'build'} 01:27:38 INFO - ##### 01:27:38 INFO - ##### Running clobber step. 01:27:38 INFO - ##### 01:27:38 INFO - Running pre-action listener: _resource_record_pre_action 01:27:38 INFO - Running main action method: clobber 01:27:38 INFO - rmtree: /builds/slave/test/build 01:27:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:27:38 INFO - Running post-action listener: _resource_record_post_action 01:27:38 INFO - ##### 01:27:38 INFO - ##### Running read-buildbot-config step. 01:27:38 INFO - ##### 01:27:38 INFO - Running pre-action listener: _resource_record_pre_action 01:27:38 INFO - Running main action method: read_buildbot_config 01:27:38 INFO - Using buildbot properties: 01:27:38 INFO - { 01:27:38 INFO - "project": "", 01:27:38 INFO - "product": "firefox", 01:27:38 INFO - "script_repo_revision": "production", 01:27:38 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 01:27:38 INFO - "repository": "", 01:27:38 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 01:27:38 INFO - "buildid": "20160428004946", 01:27:38 INFO - "pgo_build": "False", 01:27:38 INFO - "basedir": "/builds/slave/test", 01:27:38 INFO - "buildnumber": 1613, 01:27:38 INFO - "slavename": "talos-linux64-ix-043", 01:27:38 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 01:27:38 INFO - "platform": "ubuntu64_hw", 01:27:38 INFO - "scheduler": "tests-fx-team-linux64-talos", 01:27:38 INFO - "branch": "fx-team", 01:27:38 INFO - "repo_path": "integration/fx-team", 01:27:38 INFO - "revision": "e7570b6d28aaf015f5f69cf3a95f6396bf87e451", 01:27:38 INFO - "stage_platform": "linux64", 01:27:38 INFO - "builduid": "06e8e06109ba41128714129a5c173f67", 01:27:38 INFO - "slavebuilddir": "test" 01:27:38 INFO - } 01:27:38 INFO - Found installer url https://queue.taskcluster.net/v1/task/HWS_gDzuSMaCvWCPzhCglA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 01:27:38 INFO - Running post-action listener: _resource_record_post_action 01:27:38 INFO - ##### 01:27:38 INFO - ##### Running download-and-extract step. 01:27:38 INFO - ##### 01:27:38 INFO - Running pre-action listener: _resource_record_pre_action 01:27:38 INFO - Running main action method: download_and_extract 01:27:38 INFO - mkdir: /builds/slave/test/build/tests 01:27:38 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')]} 01:27:38 INFO - https://queue.taskcluster.net/v1/task/HWS_gDzuSMaCvWCPzhCglA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 01:27:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HWS_gDzuSMaCvWCPzhCglA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 01:27:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HWS_gDzuSMaCvWCPzhCglA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 01:27:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HWS_gDzuSMaCvWCPzhCglA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 01:27:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HWS_gDzuSMaCvWCPzhCglA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 01:27:39 INFO - Downloaded 1361 bytes. 01:27:39 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 01:27:39 INFO - Using the following test package requirements: 01:27:39 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 01:27:39 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:27:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 01:27:39 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:27:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 01:27:39 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:27:39 INFO - u'jsshell-linux-x86_64.zip'], 01:27:39 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:27:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 01:27:39 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 01:27:39 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:27:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 01:27:39 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:27:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 01:27:39 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:27:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 01:27:39 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:27:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 01:27:39 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:27:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:27:39 INFO - https://queue.taskcluster.net/v1/task/HWS_gDzuSMaCvWCPzhCglA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:27:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HWS_gDzuSMaCvWCPzhCglA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 01:27:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HWS_gDzuSMaCvWCPzhCglA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 01:27:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HWS_gDzuSMaCvWCPzhCglA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 01:27:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HWS_gDzuSMaCvWCPzhCglA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:27:41 INFO - Downloaded 22293278 bytes. 01:27:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:27:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 01:27:42 INFO - Return code: 0 01:27:42 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 01:27:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:27:42 INFO - https://queue.taskcluster.net/v1/task/HWS_gDzuSMaCvWCPzhCglA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:27:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HWS_gDzuSMaCvWCPzhCglA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 01:27:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HWS_gDzuSMaCvWCPzhCglA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 01:27:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HWS_gDzuSMaCvWCPzhCglA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 01:27:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HWS_gDzuSMaCvWCPzhCglA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:27:44 INFO - Downloaded 22293278 bytes. 01:27:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:27:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 01:27:45 INFO - Return code: 0 01:27:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:27:45 INFO - https://queue.taskcluster.net/v1/task/HWS_gDzuSMaCvWCPzhCglA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 01:27:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HWS_gDzuSMaCvWCPzhCglA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 01:27:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HWS_gDzuSMaCvWCPzhCglA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 01:27:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HWS_gDzuSMaCvWCPzhCglA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 01:27:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HWS_gDzuSMaCvWCPzhCglA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 01:27:46 INFO - Downloaded 10840145 bytes. 01:27:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:27:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 01:27:46 INFO - Return code: 0 01:27: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')]} 01:27:46 INFO - https://queue.taskcluster.net/v1/task/HWS_gDzuSMaCvWCPzhCglA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 01:27:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HWS_gDzuSMaCvWCPzhCglA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 01:27:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HWS_gDzuSMaCvWCPzhCglA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 01:27:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HWS_gDzuSMaCvWCPzhCglA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 01:27:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HWS_gDzuSMaCvWCPzhCglA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 01:27:50 INFO - Downloaded 54838733 bytes. 01:27:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HWS_gDzuSMaCvWCPzhCglA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 01:27:50 INFO - mkdir: /builds/slave/test/properties 01:27:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:27:50 INFO - Writing to file /builds/slave/test/properties/build_url 01:27:50 INFO - Contents: 01:27:50 INFO - build_url:https://queue.taskcluster.net/v1/task/HWS_gDzuSMaCvWCPzhCglA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 01:27:50 INFO - Running post-action listener: _resource_record_post_action 01:27:50 INFO - Running post-action listener: set_extra_try_arguments 01:27:50 INFO - ##### 01:27:50 INFO - ##### Running populate-webroot step. 01:27:50 INFO - ##### 01:27:50 INFO - Running pre-action listener: _resource_record_pre_action 01:27:50 INFO - Running main action method: populate_webroot 01:27:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:27:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:27:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:27:50 INFO - '--tppagecycles', 01:27:50 INFO - '7'], 01:27:50 INFO - 'tests': ['tsvgm']}}, 01:27:50 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:27:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:27:50 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:27:50 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:27:50 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:27:50 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:27:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:27:50 INFO - 'talos_options': ['--disable-e10s'], 01:27:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:27:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:27:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:27:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:27:50 INFO - 'talos_options': ['--disable-e10s'], 01:27:50 INFO - 'tests': ['damp', 'tps']}, 01:27:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:27:50 INFO - 'tests': ['damp', 'tps']}, 01:27:50 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:27:50 INFO - 'tests': ['dromaeo_dom']}, 01:27:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:27:50 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:27:50 INFO - 'tests': ['a11yr', 01:27:50 INFO - 'ts_paint', 01:27:50 INFO - 'tpaint', 01:27:50 INFO - 'sessionrestore', 01:27:50 INFO - 'sessionrestore_no_auto_restore', 01:27:50 INFO - 'tabpaint']}, 01:27:50 INFO - 'other-e10s': {'tests': ['a11yr', 01:27:50 INFO - 'ts_paint', 01:27:50 INFO - 'tpaint', 01:27:50 INFO - 'sessionrestore', 01:27:50 INFO - 'sessionrestore_no_auto_restore', 01:27:50 INFO - 'tabpaint']}, 01:27:50 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:27:50 INFO - 'ts_paint', 01:27:50 INFO - 'tpaint', 01:27:50 INFO - 'sessionrestore', 01:27:50 INFO - 'sessionrestore_no_auto_restore', 01:27:50 INFO - 'tabpaint']}, 01:27:50 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:27:50 INFO - 'ts_paint', 01:27:50 INFO - 'tpaint', 01:27:50 INFO - 'sessionrestore', 01:27:50 INFO - 'sessionrestore_no_auto_restore', 01:27:50 INFO - 'tabpaint']}, 01:27:50 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:27:50 INFO - 'tests': ['a11yr', 01:27:50 INFO - 'ts_paint', 01:27:50 INFO - 'tpaint', 01:27:50 INFO - 'sessionrestore', 01:27:50 INFO - 'sessionrestore_no_auto_restore', 01:27:50 INFO - 'tabpaint']}, 01:27:50 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:27:50 INFO - 'tests': ['a11yr', 01:27:50 INFO - 'ts_paint', 01:27:50 INFO - 'tpaint', 01:27:50 INFO - 'sessionrestore', 01:27:50 INFO - 'sessionrestore_no_auto_restore', 01:27:50 INFO - 'tabpaint']}, 01:27:50 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:27:50 INFO - 'tests': ['tsvgx', 01:27:50 INFO - 'tsvgr_opacity', 01:27:50 INFO - 'tart', 01:27:50 INFO - 'tscrollx', 01:27:50 INFO - 'cart']}, 01:27:50 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:27:50 INFO - 'tsvgr_opacity', 01:27:50 INFO - 'tart', 01:27:50 INFO - 'tscrollx', 01:27:50 INFO - 'cart']}, 01:27:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:27:50 INFO - 'talos_options': ['--disable-e10s'], 01:27:50 INFO - 'tests': ['tp5o']}, 01:27:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:27:50 INFO - 'tests': ['tp5o']}, 01:27:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:27:50 INFO - 'talos_options': ['--disable-e10s', 01:27:50 INFO - '--xperf_path', 01:27:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:27:50 INFO - 'tests': ['tp5n']}, 01:27:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:27:50 INFO - 'talos_options': ['--xperf_path', 01:27:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:27:50 INFO - 'tests': ['tp5n']}}, 01:27:50 INFO - 'talos.zip': {'path': '', 01:27:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:27:50 INFO - Running post-action listener: _resource_record_post_action 01:27:50 INFO - ##### 01:27:50 INFO - ##### Running create-virtualenv step. 01:27:50 INFO - ##### 01:27:50 INFO - Running pre-action listener: _resource_record_pre_action 01:27:50 INFO - Running main action method: create_virtualenv 01:27:50 INFO - Creating virtualenv /builds/slave/test/build/venv 01:27:50 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 01:27:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:27:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:27:51 INFO - Using real prefix '/usr' 01:27:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:27:51 INFO - Installing distribute.............................................................................................................................................................................................done. 01:27:53 INFO - Installing pip.................done. 01:27:53 INFO - Return code: 0 01:27:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:27:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:27:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:27:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:27:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:27:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:27:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:27:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8025b06f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bf05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c7f410>, '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 0x2c80310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c807a0>, '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': 'd2a8c569965ab8367867b893000001a1-1461831939.134167-1763156482', '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 01:27:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 01:27:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 01:27:53 INFO - Using env: {'DISPLAY': ':0', 01:27:53 INFO - 'HOME': '/home/cltbld', 01:27:53 INFO - 'LANG': 'en_US.UTF-8', 01:27:53 INFO - 'LANGUAGE': 'en_US:en', 01:27:53 INFO - 'LOGNAME': 'cltbld', 01:27:53 INFO - 'MAIL': '/var/mail/cltbld', 01:27:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:27:53 INFO - 'MOZ_NO_REMOTE': '1', 01:27:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:27:53 INFO - 'NO_EM_RESTART': '1', 01:27:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:27:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:27:53 INFO - 'PWD': '/builds/slave/test', 01:27:53 INFO - 'SHELL': '/bin/bash', 01:27:53 INFO - 'SHLVL': '1', 01:27:53 INFO - 'TERM': 'linux', 01:27:53 INFO - 'TMOUT': '86400', 01:27:53 INFO - 'USER': 'cltbld', 01:27:53 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1461831939.134167-1763156482', 01:27:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:27:53 INFO - '_': '/tools/buildbot/bin/python'} 01:27:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:27:53 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 01:27:53 INFO - Cleaning up... 01:27:53 INFO - Return code: 0 01:27:53 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 01:27:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:27:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:27:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:27:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:27:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:27:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:27:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f8025b06f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bf05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c7f410>, '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 0x2c80310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c807a0>, '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': 'd2a8c569965ab8367867b893000001a1-1461831939.134167-1763156482', '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 01:27:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 01:27:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 01:27:53 INFO - Using env: {'DISPLAY': ':0', 01:27:53 INFO - 'HOME': '/home/cltbld', 01:27:53 INFO - 'LANG': 'en_US.UTF-8', 01:27:53 INFO - 'LANGUAGE': 'en_US:en', 01:27:53 INFO - 'LOGNAME': 'cltbld', 01:27:53 INFO - 'MAIL': '/var/mail/cltbld', 01:27:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:27:53 INFO - 'MOZ_NO_REMOTE': '1', 01:27:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:27:53 INFO - 'NO_EM_RESTART': '1', 01:27:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:27:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:27:53 INFO - 'PWD': '/builds/slave/test', 01:27:53 INFO - 'SHELL': '/bin/bash', 01:27:53 INFO - 'SHLVL': '1', 01:27:53 INFO - 'TERM': 'linux', 01:27:53 INFO - 'TMOUT': '86400', 01:27:53 INFO - 'USER': 'cltbld', 01:27:53 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1461831939.134167-1763156482', 01:27:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:27:53 INFO - '_': '/tools/buildbot/bin/python'} 01:27:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:27:53 INFO - Downloading/unpacking psutil>=0.7.1 01:27:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:27:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:27:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:27:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:27:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:27:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:27:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:27:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:27:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:27:55 INFO - Installing collected packages: psutil 01:27:55 INFO - Running setup.py install for psutil 01:27:55 INFO - building 'psutil._psutil_linux' extension 01:27:55 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 01:27:56 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 01:27:56 INFO - building 'psutil._psutil_posix' extension 01:27:56 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 01:27:56 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 01:27:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:27:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:27:56 INFO - Successfully installed psutil 01:27:56 INFO - Cleaning up... 01:27:56 INFO - Return code: 0 01:27:56 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 01:27: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')]} 01:27:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:27:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:27: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')]} 01:27:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:27:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:27:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8025b06f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bf05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c7f410>, '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 0x2c80310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c807a0>, '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': 'd2a8c569965ab8367867b893000001a1-1461831939.134167-1763156482', '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 01:27:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 01:27:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 01:27:56 INFO - Using env: {'DISPLAY': ':0', 01:27:56 INFO - 'HOME': '/home/cltbld', 01:27:56 INFO - 'LANG': 'en_US.UTF-8', 01:27:56 INFO - 'LANGUAGE': 'en_US:en', 01:27:56 INFO - 'LOGNAME': 'cltbld', 01:27:56 INFO - 'MAIL': '/var/mail/cltbld', 01:27:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:27:56 INFO - 'MOZ_NO_REMOTE': '1', 01:27:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:27:56 INFO - 'NO_EM_RESTART': '1', 01:27:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:27:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:27:56 INFO - 'PWD': '/builds/slave/test', 01:27:56 INFO - 'SHELL': '/bin/bash', 01:27:56 INFO - 'SHLVL': '1', 01:27:56 INFO - 'TERM': 'linux', 01:27:56 INFO - 'TMOUT': '86400', 01:27:56 INFO - 'USER': 'cltbld', 01:27:56 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1461831939.134167-1763156482', 01:27:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:27:56 INFO - '_': '/tools/buildbot/bin/python'} 01:27:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:27:56 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 01:27: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 01:27: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 01:27: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 01:27: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 01:27: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 01:27: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 01:27:58 INFO - Downloading mozsystemmonitor-0.0.tar.gz 01:27:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:27:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 01:27:58 INFO - Installing collected packages: mozsystemmonitor 01:27:58 INFO - Running setup.py install for mozsystemmonitor 01:27:58 INFO - Successfully installed mozsystemmonitor 01:27:58 INFO - Cleaning up... 01:27:58 INFO - Return code: 0 01:27:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:27:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:27:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:27:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:27:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:27:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:27:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:27:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f8025b06f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bf05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c7f410>, '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 0x2c80310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c807a0>, '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': 'd2a8c569965ab8367867b893000001a1-1461831939.134167-1763156482', '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 01:27:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 01:27:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 01:27:58 INFO - Using env: {'DISPLAY': ':0', 01:27:58 INFO - 'HOME': '/home/cltbld', 01:27:58 INFO - 'LANG': 'en_US.UTF-8', 01:27:58 INFO - 'LANGUAGE': 'en_US:en', 01:27:58 INFO - 'LOGNAME': 'cltbld', 01:27:58 INFO - 'MAIL': '/var/mail/cltbld', 01:27:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:27:58 INFO - 'MOZ_NO_REMOTE': '1', 01:27:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:27:58 INFO - 'NO_EM_RESTART': '1', 01:27:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:27:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:27:58 INFO - 'PWD': '/builds/slave/test', 01:27:58 INFO - 'SHELL': '/bin/bash', 01:27:58 INFO - 'SHLVL': '1', 01:27:58 INFO - 'TERM': 'linux', 01:27:58 INFO - 'TMOUT': '86400', 01:27:58 INFO - 'USER': 'cltbld', 01:27:58 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1461831939.134167-1763156482', 01:27:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:27:58 INFO - '_': '/tools/buildbot/bin/python'} 01:27:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:27:58 INFO - Downloading/unpacking blobuploader==1.2.4 01:27:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:27:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:27:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:27:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:27:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:27:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:28:00 INFO - Downloading blobuploader-1.2.4.tar.gz 01:28:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:28:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:28:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:28:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:28:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:28:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:28:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:28:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:28:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:28:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:28: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 01:28: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 01:28: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 01:28: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 01:28: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 01:28: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 01:28:01 INFO - Downloading docopt-0.6.1.tar.gz 01:28:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:28:01 INFO - Installing collected packages: blobuploader, requests, docopt 01:28:01 INFO - Running setup.py install for blobuploader 01:28:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:28:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:28:01 INFO - Running setup.py install for requests 01:28:02 INFO - Running setup.py install for docopt 01:28:02 INFO - Successfully installed blobuploader requests docopt 01:28:02 INFO - Cleaning up... 01:28:02 INFO - Return code: 0 01:28:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:28:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:28:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:28:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:28:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:28:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:28:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:28:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8025b06f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bf05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c7f410>, '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 0x2c80310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c807a0>, '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': 'd2a8c569965ab8367867b893000001a1-1461831939.134167-1763156482', '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 01:28:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 01:28:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 01:28:02 INFO - Using env: {'DISPLAY': ':0', 01:28:02 INFO - 'HOME': '/home/cltbld', 01:28:02 INFO - 'LANG': 'en_US.UTF-8', 01:28:02 INFO - 'LANGUAGE': 'en_US:en', 01:28:02 INFO - 'LOGNAME': 'cltbld', 01:28:02 INFO - 'MAIL': '/var/mail/cltbld', 01:28:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:28:02 INFO - 'MOZ_NO_REMOTE': '1', 01:28:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:28:02 INFO - 'NO_EM_RESTART': '1', 01:28:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:28:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:28:02 INFO - 'PWD': '/builds/slave/test', 01:28:02 INFO - 'SHELL': '/bin/bash', 01:28:02 INFO - 'SHLVL': '1', 01:28:02 INFO - 'TERM': 'linux', 01:28:02 INFO - 'TMOUT': '86400', 01:28:02 INFO - 'USER': 'cltbld', 01:28:02 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1461831939.134167-1763156482', 01:28:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:28:02 INFO - '_': '/tools/buildbot/bin/python'} 01:28:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:28:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:28:02 INFO - Running setup.py (path:/tmp/pip-cX3F6n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:28:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:28:02 INFO - Running setup.py (path:/tmp/pip-Srs8p_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:28:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:28:02 INFO - Running setup.py (path:/tmp/pip-ni4LcF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:28:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:28:02 INFO - Running setup.py (path:/tmp/pip-sz7MJ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:28:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:28:02 INFO - Running setup.py (path:/tmp/pip-_yxPW_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:28:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:28:02 INFO - Running setup.py (path:/tmp/pip-YcBtb7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:28:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:28:02 INFO - Running setup.py (path:/tmp/pip-w23_jf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:28:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:28:02 INFO - Running setup.py (path:/tmp/pip-0E4JC3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:28:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:28:02 INFO - Running setup.py (path:/tmp/pip-EGQIL6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:28:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:28:03 INFO - Running setup.py (path:/tmp/pip-560F8e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:28:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:28:03 INFO - Running setup.py (path:/tmp/pip-WrWdyH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:28:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:28:03 INFO - Running setup.py (path:/tmp/pip-DGGE3k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:28:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:28:03 INFO - Running setup.py (path:/tmp/pip-pAmT6n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:28:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:28:03 INFO - Running setup.py (path:/tmp/pip-GjufWQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:28:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:28:03 INFO - Running setup.py (path:/tmp/pip-_60iJ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:28:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:28:03 INFO - Running setup.py (path:/tmp/pip-xL3_Vv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:28:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:28:03 INFO - Running setup.py (path:/tmp/pip-gupRUz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:28:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:28:03 INFO - Running setup.py install for manifestparser 01:28:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:28:03 INFO - Running setup.py install for mozcrash 01:28:03 INFO - Running setup.py install for mozdebug 01:28:03 INFO - Running setup.py install for mozdevice 01:28:04 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:28:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:28:04 INFO - Running setup.py install for mozfile 01:28:04 INFO - Running setup.py install for mozhttpd 01:28:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:28:04 INFO - Running setup.py install for mozinfo 01:28:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:28:04 INFO - Running setup.py install for mozInstall 01:28:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:28:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:28:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:28:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:28:04 INFO - Running setup.py install for mozleak 01:28:04 INFO - Running setup.py install for mozlog 01:28:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:28:04 INFO - Running setup.py install for moznetwork 01:28:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:28:04 INFO - Running setup.py install for mozprocess 01:28:04 INFO - Running setup.py install for mozprofile 01:28:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:28:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:28:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:28:04 INFO - Running setup.py install for mozrunner 01:28:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:28:05 INFO - Running setup.py install for mozscreenshot 01:28:05 INFO - Running setup.py install for moztest 01:28:05 INFO - Running setup.py install for mozversion 01:28:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:28:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:28:05 INFO - Cleaning up... 01:28:05 INFO - Return code: 0 01:28:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:28:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:28:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:28:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:28:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:28:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:28:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:28:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8025b06f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bf05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c7f410>, '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 0x2c80310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c807a0>, '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': 'd2a8c569965ab8367867b893000001a1-1461831939.134167-1763156482', '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 01:28:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 01:28:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 01:28:05 INFO - Using env: {'DISPLAY': ':0', 01:28:05 INFO - 'HOME': '/home/cltbld', 01:28:05 INFO - 'LANG': 'en_US.UTF-8', 01:28:05 INFO - 'LANGUAGE': 'en_US:en', 01:28:05 INFO - 'LOGNAME': 'cltbld', 01:28:05 INFO - 'MAIL': '/var/mail/cltbld', 01:28:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:28:05 INFO - 'MOZ_NO_REMOTE': '1', 01:28:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:28:05 INFO - 'NO_EM_RESTART': '1', 01:28:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:28:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:28:05 INFO - 'PWD': '/builds/slave/test', 01:28:05 INFO - 'SHELL': '/bin/bash', 01:28:05 INFO - 'SHLVL': '1', 01:28:05 INFO - 'TERM': 'linux', 01:28:05 INFO - 'TMOUT': '86400', 01:28:05 INFO - 'USER': 'cltbld', 01:28:05 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1461831939.134167-1763156482', 01:28:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:28:05 INFO - '_': '/tools/buildbot/bin/python'} 01:28:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:28:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:28:05 INFO - Running setup.py (path:/tmp/pip-8PKhoA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:28:05 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)) 01:28:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:28:05 INFO - Running setup.py (path:/tmp/pip-ZeMKZ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:28:05 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)) 01:28:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:28:05 INFO - Running setup.py (path:/tmp/pip-yeCNZk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:28:05 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)) 01:28:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:28:05 INFO - Running setup.py (path:/tmp/pip-N5IMJm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:28:05 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)) 01:28:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:28:05 INFO - Running setup.py (path:/tmp/pip-j7Srjg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:28:05 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)) 01:28:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:28:05 INFO - Running setup.py (path:/tmp/pip-SMKpvj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:28:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 01:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:28:06 INFO - Running setup.py (path:/tmp/pip-dUalW4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:28:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 01:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:28:06 INFO - Running setup.py (path:/tmp/pip-4bu0Lc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:28:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 01:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:28:06 INFO - Running setup.py (path:/tmp/pip-wqgX5M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:28:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 01:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:28:06 INFO - Running setup.py (path:/tmp/pip-Wf4CKZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:28:06 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)) 01:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:28:06 INFO - Running setup.py (path:/tmp/pip-DoJJft-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:28:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 01:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:28:06 INFO - Running setup.py (path:/tmp/pip-TB5C2Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:28:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 01:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:28:06 INFO - Running setup.py (path:/tmp/pip-Jws7B9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:28:06 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)) 01:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:28:06 INFO - Running setup.py (path:/tmp/pip-eVcpDo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:28:06 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)) 01:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:28:06 INFO - Running setup.py (path:/tmp/pip-K2V9E4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:28:06 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)) 01:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:28:06 INFO - Running setup.py (path:/tmp/pip-DQsnCv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:28:06 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)) 01:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:28:06 INFO - Running setup.py (path:/tmp/pip-H7YOF8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:28:06 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)) 01:28:06 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)) 01:28:06 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)) 01:28:06 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)) 01:28:06 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)) 01:28:06 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)) 01:28:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:28:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:28:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:28:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:28:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:28:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:28:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:28:08 INFO - Downloading blessings-1.6.tar.gz 01:28:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:28:08 INFO - Installing collected packages: blessings 01:28:08 INFO - Running setup.py install for blessings 01:28:08 INFO - Successfully installed blessings 01:28:08 INFO - Cleaning up... 01:28:08 INFO - Return code: 0 01:28:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:28:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:28:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:28:09 INFO - Reading from file tmpfile_stdout 01:28:09 INFO - Current package versions: 01:28:09 INFO - argparse == 1.2.1 01:28:09 INFO - blessings == 1.6 01:28:09 INFO - blobuploader == 1.2.4 01:28:09 INFO - docopt == 0.6.1 01:28:09 INFO - manifestparser == 1.1 01:28:09 INFO - mozInstall == 1.12 01:28:09 INFO - mozcrash == 0.17 01:28:09 INFO - mozdebug == 0.1 01:28:09 INFO - mozdevice == 0.48 01:28:09 INFO - mozfile == 1.2 01:28:09 INFO - mozhttpd == 0.7 01:28:09 INFO - mozinfo == 0.9 01:28:09 INFO - mozleak == 0.1 01:28:09 INFO - mozlog == 3.1 01:28:09 INFO - moznetwork == 0.27 01:28:09 INFO - mozprocess == 0.22 01:28:09 INFO - mozprofile == 0.28 01:28:09 INFO - mozrunner == 6.11 01:28:09 INFO - mozscreenshot == 0.1 01:28:09 INFO - mozsystemmonitor == 0.0 01:28:09 INFO - moztest == 0.7 01:28:09 INFO - mozversion == 1.4 01:28:09 INFO - psutil == 3.1.1 01:28:09 INFO - requests == 1.2.3 01:28:09 INFO - wsgiref == 0.1.2 01:28:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:28:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:28:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:28:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:28:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:28:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:28:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:28:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8025b06f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bf05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c7f410>, '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 0x2c80310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c807a0>, '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': 'd2a8c569965ab8367867b893000001a1-1461831939.134167-1763156482', '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 01:28:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 01:28:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 01:28:09 INFO - Using env: {'DISPLAY': ':0', 01:28:09 INFO - 'HOME': '/home/cltbld', 01:28:09 INFO - 'LANG': 'en_US.UTF-8', 01:28:09 INFO - 'LANGUAGE': 'en_US:en', 01:28:09 INFO - 'LOGNAME': 'cltbld', 01:28:09 INFO - 'MAIL': '/var/mail/cltbld', 01:28:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:28:09 INFO - 'MOZ_NO_REMOTE': '1', 01:28:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:28:09 INFO - 'NO_EM_RESTART': '1', 01:28:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:28:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:28:09 INFO - 'PWD': '/builds/slave/test', 01:28:09 INFO - 'SHELL': '/bin/bash', 01:28:09 INFO - 'SHLVL': '1', 01:28:09 INFO - 'TERM': 'linux', 01:28:09 INFO - 'TMOUT': '86400', 01:28:09 INFO - 'USER': 'cltbld', 01:28:09 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1461831939.134167-1763156482', 01:28:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:28:09 INFO - '_': '/tools/buildbot/bin/python'} 01:28:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:28:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 01:28:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 01:28:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 01:28:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 01:28:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 01:28:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 01:28:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 01:28:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 01:28:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 01:28:09 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 01:28:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 01:28:09 INFO - Cleaning up... 01:28:09 INFO - Return code: 0 01:28:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:28:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:28:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:28:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:28:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:28:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:28:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:28:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8025b06f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bf05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c7f410>, '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 0x2c80310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c807a0>, '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': 'd2a8c569965ab8367867b893000001a1-1461831939.134167-1763156482', '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 01:28:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 01:28:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 01:28:09 INFO - Using env: {'DISPLAY': ':0', 01:28:09 INFO - 'HOME': '/home/cltbld', 01:28:09 INFO - 'LANG': 'en_US.UTF-8', 01:28:09 INFO - 'LANGUAGE': 'en_US:en', 01:28:09 INFO - 'LOGNAME': 'cltbld', 01:28:09 INFO - 'MAIL': '/var/mail/cltbld', 01:28:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:28:09 INFO - 'MOZ_NO_REMOTE': '1', 01:28:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:28:09 INFO - 'NO_EM_RESTART': '1', 01:28:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:28:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:28:09 INFO - 'PWD': '/builds/slave/test', 01:28:09 INFO - 'SHELL': '/bin/bash', 01:28:09 INFO - 'SHLVL': '1', 01:28:09 INFO - 'TERM': 'linux', 01:28:09 INFO - 'TMOUT': '86400', 01:28:09 INFO - 'USER': 'cltbld', 01:28:09 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1461831939.134167-1763156482', 01:28:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:28:09 INFO - '_': '/tools/buildbot/bin/python'} 01:28:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:28:09 INFO - Downloading/unpacking jsonschema 01:28: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 01:28: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 01:28: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 01:28: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 01:28: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 01:28: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 01:28:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:28:11 INFO - Downloading/unpacking functools32 (from jsonschema) 01:28:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:28:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:28:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:28:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:28:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:28:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:28:11 INFO - Downloading functools32-3.2.3-2.tar.gz 01:28:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:28:11 INFO - warning: no files found matching '*.txt' 01:28:11 INFO - no previously-included directories found matching 'build' 01:28:11 INFO - no previously-included directories found matching 'dist' 01:28:11 INFO - no previously-included directories found matching '.git*' 01:28:11 INFO - Installing collected packages: jsonschema, functools32 01:28:11 INFO - Running setup.py install for functools32 01:28:11 INFO - warning: no files found matching '*.txt' 01:28:11 INFO - no previously-included directories found matching 'build' 01:28:11 INFO - no previously-included directories found matching 'dist' 01:28:11 INFO - no previously-included directories found matching '.git*' 01:28:11 INFO - Successfully installed jsonschema functools32 01:28:11 INFO - Cleaning up... 01:28:11 INFO - Return code: 0 01:28:11 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 01:28: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')]} 01:28:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:28:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:28: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')]} 01:28:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:28:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:28:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8025b06f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bf05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c7f410>, '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 0x2c80310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c807a0>, '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': 'd2a8c569965ab8367867b893000001a1-1461831939.134167-1763156482', '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 01:28:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 01:28:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 01:28:11 INFO - Using env: {'DISPLAY': ':0', 01:28:11 INFO - 'HOME': '/home/cltbld', 01:28:11 INFO - 'LANG': 'en_US.UTF-8', 01:28:11 INFO - 'LANGUAGE': 'en_US:en', 01:28:11 INFO - 'LOGNAME': 'cltbld', 01:28:11 INFO - 'MAIL': '/var/mail/cltbld', 01:28:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:28:11 INFO - 'MOZ_NO_REMOTE': '1', 01:28:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:28:11 INFO - 'NO_EM_RESTART': '1', 01:28:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:28:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:28:11 INFO - 'PWD': '/builds/slave/test', 01:28:11 INFO - 'SHELL': '/bin/bash', 01:28:11 INFO - 'SHLVL': '1', 01:28:11 INFO - 'TERM': 'linux', 01:28:11 INFO - 'TMOUT': '86400', 01:28:11 INFO - 'USER': 'cltbld', 01:28:11 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1461831939.134167-1763156482', 01:28:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:28:11 INFO - '_': '/tools/buildbot/bin/python'} 01:28:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:28:12 INFO - Downloading/unpacking flake8 01:28: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 01:28: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 01:28: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 01:28: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 01:28: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 01:28: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 01:28:14 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:28:14 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:28: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 01:28: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 01:28: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 01:28: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 01:28: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 01:28: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 01:28:14 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:28:14 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:28: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 01:28: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 01:28: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 01:28: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 01:28: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 01:28: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 01:28:14 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:28: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 01:28: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 01:28: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 01:28: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 01:28: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 01:28: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 01:28:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 01:28:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:28:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:28:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:28:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:28:14 INFO - no previously-included directories found matching 'docs/_build' 01:28:14 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:28:14 INFO - Running setup.py install for pep8 01:28:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:28:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:28:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:28:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:28:14 INFO - no previously-included directories found matching 'docs/_build' 01:28:14 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 01:28:14 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:28:14 INFO - Cleaning up... 01:28:14 INFO - Return code: 0 01:28:14 INFO - Running post-action listener: _resource_record_post_action 01:28:14 INFO - Running post-action listener: _start_resource_monitoring 01:28:15 INFO - Starting resource monitoring. 01:28:15 INFO - ##### 01:28:15 INFO - ##### Running install step. 01:28:15 INFO - ##### 01:28:15 INFO - Running pre-action listener: _resource_record_pre_action 01:28:15 INFO - Running main action method: install 01:28:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:28:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:28:15 INFO - Reading from file tmpfile_stdout 01:28:15 INFO - Detecting whether we're running mozinstall >=1.0... 01:28:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:28:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:28:15 INFO - Reading from file tmpfile_stdout 01:28:15 INFO - Output received: 01:28:15 INFO - Usage: mozinstall [options] installer 01:28:15 INFO - Options: 01:28:15 INFO - -h, --help show this help message and exit 01:28:15 INFO - -d DEST, --destination=DEST 01:28:15 INFO - Directory to install application into. [default: 01:28:15 INFO - "/builds/slave/test"] 01:28:15 INFO - --app=APP Application being installed. [default: firefox] 01:28:15 INFO - mkdir: /builds/slave/test/build/application 01:28:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 01:28:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 01:28:31 INFO - Reading from file tmpfile_stdout 01:28:31 INFO - Output received: 01:28:31 INFO - /builds/slave/test/build/application/firefox/firefox 01:28:31 INFO - Running post-action listener: _resource_record_post_action 01:28:31 INFO - ##### 01:28:31 INFO - ##### Running run-tests step. 01:28:31 INFO - ##### 01:28:31 INFO - Running pre-action listener: _resource_record_pre_action 01:28:31 INFO - Running main action method: run_tests 01:28:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:28:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:28:31 INFO - Python 2.7.3 01:28:31 INFO - Return code: 0 01:28:31 INFO - grabbing minidump binary from tooltool 01:28:31 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')]} 01:28:31 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 0x2c7f410>, '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 0x2c80310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c807a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:28:31 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 01:28:31 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 01:28:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:28:31 INFO - Return code: 0 01:28:31 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:28:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:28:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:28:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:28:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:28:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 01:28:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 01:28:32 INFO - Return code: 0 01:28:32 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/HWS_gDzuSMaCvWCPzhCglA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--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 01:28:32 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/HWS_gDzuSMaCvWCPzhCglA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-043 --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 01:28:32 INFO - Using env: {'DISPLAY': ':0', 01:28:32 INFO - 'HOME': '/home/cltbld', 01:28:32 INFO - 'LANG': 'en_US.UTF-8', 01:28:32 INFO - 'LANGUAGE': 'en_US:en', 01:28:32 INFO - 'LOGNAME': 'cltbld', 01:28:32 INFO - 'MAIL': '/var/mail/cltbld', 01:28:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:28:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:28:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:28:32 INFO - 'MOZ_NO_REMOTE': '1', 01:28:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:28:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:28:32 INFO - 'NO_EM_RESTART': '1', 01:28:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:28:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:28:32 INFO - 'PWD': '/builds/slave/test', 01:28:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:28:32 INFO - 'SHELL': '/bin/bash', 01:28:32 INFO - 'SHLVL': '1', 01:28:32 INFO - 'TERM': 'linux', 01:28:32 INFO - 'TMOUT': '86400', 01:28:32 INFO - 'USER': 'cltbld', 01:28:32 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1461831939.134167-1763156482', 01:28:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:28:32 INFO - '_': '/tools/buildbot/bin/python'} 01:28:32 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/HWS_gDzuSMaCvWCPzhCglA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--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 01:28:32 INFO - mozversion application_buildid: 20160428004946 01:28:32 INFO - mozversion application_changeset: e7570b6d28aaf015f5f69cf3a95f6396bf87e451 01:28:32 INFO - mozversion application_display_name: Nightly 01:28:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:28:32 INFO - mozversion application_name: Firefox 01:28:32 INFO - mozversion application_remotingname: firefox 01:28:32 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 01:28:32 INFO - mozversion application_vendor: Mozilla 01:28:32 INFO - mozversion application_version: 49.0a1 01:28:32 INFO - mozversion platform_buildid: 20160428004946 01:28:32 INFO - mozversion platform_changeset: e7570b6d28aaf015f5f69cf3a95f6396bf87e451 01:28:32 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 01:28:32 INFO - mozversion platform_version: 49.0a1 01:28:32 INFO - using testdate: 1461832112 01:28:32 INFO - actual date: 1461832112 01:28:32 INFO - starting webserver on 'localhost:52425' 01:28:32 INFO - SUITE-START | Running 2 tests 01:28:32 INFO - TEST-START | dromaeo_css 01:28:32 INFO - operating with platform_type : linux_ 01:28:32 INFO - Initialising browser for dromaeo_css test... 01:28:32 INFO - TEST-INFO | started process 21740 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5A3_Yi/profile http://localhost:52425/getInfo.html) 01:28:36 INFO - PROCESS | 21740 | __metrics Screen width/height:1600/1200 01:28:36 INFO - PROCESS | 21740 | colorDepth:24 01:28:36 INFO - PROCESS | 21740 | Browser inner width/height: 1024/697 01:28:36 INFO - PROCESS | 21740 | __metrics 01:28:38 ERROR - PROCESS | 21740 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 01:28:38 INFO - TEST-INFO | 21740: exit 0 01:28:38 INFO - Browser initialized. 01:28:38 INFO - Running cycle 1/1 for dromaeo_css test... 01:28:38 INFO - TEST-INFO | started process 21821 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5A3_Yi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:28:50 INFO - PROCESS | 21821 | RSS: Main: 156770304 01:28:50 INFO - PROCESS | 21821 | 01:29:42 INFO - PROCESS | 21821 | 1461832182553 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] 01:31:53 INFO - PROCESS | 21821 | Cycle 1(1): loaded http://localhost:52425/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52425/tests/dromaeo/cssquery-ext.html) 01:31:55 INFO - PROCESS | 21821 | RSS: Main: 271843328 01:31:55 INFO - PROCESS | 21821 | 01:34:57 INFO - PROCESS | 21821 | Cycle 1(1): loaded http://localhost:52425/tests/dromaeo/cssquery-ext.html (next: http://localhost:52425/tests/dromaeo/cssquery-jquery.html) 01:34:58 INFO - PROCESS | 21821 | RSS: Main: 238174208 01:34:58 INFO - PROCESS | 21821 | 01:38:00 INFO - PROCESS | 21821 | Cycle 1(1): loaded http://localhost:52425/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52425/tests/dromaeo/cssquery-mootools.html) 01:38:00 INFO - PROCESS | 21821 | RSS: Main: 232435712 01:38:00 INFO - PROCESS | 21821 | 01:41:03 INFO - PROCESS | 21821 | Cycle 1(1): loaded http://localhost:52425/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52425/tests/dromaeo/cssquery-prototype.html) 01:41:03 INFO - PROCESS | 21821 | RSS: Main: 230477824 01:41:03 INFO - PROCESS | 21821 | 01:44:06 INFO - PROCESS | 21821 | Cycle 1(1): loaded http://localhost:52425/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52425/tests/dromaeo/cssquery-yui.html) 01:44:07 INFO - PROCESS | 21821 | RSS: Main: 222273536 01:44:07 INFO - PROCESS | 21821 | 01:47:10 INFO - PROCESS | 21821 | Cycle 1(1): loaded http://localhost:52425/tests/dromaeo/cssquery-yui.html (next: http://localhost:52425/tests/dromaeo/cssquery-dojo.html) 01:47:10 INFO - PROCESS | 21821 | RSS: Main: 267268096 01:47:10 INFO - PROCESS | 21821 | 01:47:10 INFO - PROCESS | 21821 | __start_tp_report 01:47:10 INFO - PROCESS | 21821 | _x_x_mozilla_page_load 01:47:10 INFO - PROCESS | 21821 | _x_x_mozilla_page_load_details 01:47:10 INFO - PROCESS | 21821 | |i|pagename|runs| 01:47:10 INFO - PROCESS | 21821 | |0;dojo.html;2640.8811603477848;2712.7694145997602;2714.457108578285;2720.7415295546916;2750.202441292025;4559.338895860106;4724.763761811909;4728.598069164121;4734.479207287204;4746.193147164978;4747.572718455347;4775.2598347256235;4844.61243100552;4845.927311090337;4856.05306965142;4350.173467041268;4388.692791504596;4405.317175837734;4465.040016396474;4509.458864936212;4442.378067070596;4484.461864576239;4500.819967201308;4507.504174540798;4529.094181163764;4254.702170848011;4351.804168812411;4385.846495372647;4419.602235798761;4484.349769283468;4403.3174857897075;4422.823087076546;4437.711548749321;4439.66702497314;4479.372887795711;4383.978080109611;4389.758563279051;4413.668974826901;4420.977895110536;4454.754988475633;4496.910061798779;4636.211843986531;4642.698224615423;4682.29765535169;4725.5510726480925;5032.748362581856;5053.797848086072;5055.393352797688;5058.924116138261;5102.69383836971;5097.541221290102;5128.9230661540105;5135.563477104451;5143.177091665353;5168.586513078944;4622.329762184464;4726.952730472685;4755.714657120515;4843.321934929113;4854.029194161182;5188.195829646411;5193.870153246199;5200.2979597754575;5201.08980928336;5207.973960130251;4982.451930287665;4985.027919555724;4988.501149884983;4991.276264941564;5028.120078986236;4957;5069.5437410632485;5163.432022477525;5168.457311982263;5172.19830926207;5068.594918528042;5084.237364395371;5113.74431278442;5115.846524604268;5125;5105.846824595268;5111.846644600668;5118.97440512795;5120.155174396183;5155.38135423744;3869.5743468218475;3893.649571538575;3895.824687889052;3901.4342920276968;3971.5631280559114;3510.315488479722;3515.226650136966;3544.167120726627;3560;3588.3361578108133;4323.308270676676;4333.458317710286;4338.522762496123;4379.474463064453;4380.342948557678;5002.949970500321;5087.186050231945;5097.745112744422;5127.1540195867265;5206.635535512478;4282.935755963663;4293.141371725667;4296.677749168824;4325.9134817303475;4341.261985462479;4549.112922980054;4558.772061396983;4560.315952607069;4564.7032942858605;4596.7931443085145;4795.328653988375;4826.276058591239;4829.396325459317;4885.609151267961;4935.259711043373;5111.080005599028;5123.359580052494;5144.6398752087;5147.56245719118;5187.714675692873;4872.585830204331;4895.902081958269;4907.116718990616;4910.263460480814;4958.206686930074;4852.902941941071;5008.123578373843;5036.093503169464;5066.974665126798;5095.77069031887;5065.594752419724;5101.69389836611;5105.617078719037;5106.7446627669215;5155.175171972616;4743.762811859324;4958.454569997225;4965.4041515018425;4965.875853103701;4969.776360063734;4859.222524396079;4869.853904382732;4888.437829649493;4911.26331050331;4952.207646776643;4822.638302127284;4824.179889418878;4828.493008234085;4831.251156070814;4864.197407427876;4784.425868895755;4874.902501950012;4916.213405855046;4927.605791536596;4971.328870602567;4764;4800.3279540865005;4810.062037902575;4871.48849370811;4879.4876537963 01:47:10 INFO - PROCESS | 21821 | |1;ext.html;575.7006356694519;584.6024703201824;599.7181324777354;609.2293249039964;627.031236739238;28217.576736348972;29890.850545747267;33314.83342583287;34038.14904627379;34473.48289775649;34817.30365392691;35373;35475;35497.46753798695;35595;7463.589502577356;7657.042869641295;7659.770206893802;7675.654595543186;7684;7093.3970612498;9240.122188392092;9544.761380965461;9554.187894029015;9557.092076252746;9483.383580067308;9659.903400966006;9664.75838104046;9667.661631842888;9680.177184939253;9356.532173391337;9493.477858717803;9507.096825801538;9513.571889265;9516.286278529138;9444.197243234334;9545.761355966157;9563.665271715456;9571.952140239255;9575.521223938775;35978.280434391425;36588.81705591481;36651.633483665355;36653.45019824705;36664.816675916714;3112.859921303547;3317.93364132716;3589.94615080774;3692.2061756722164;3734;28225.717742822515;28822.186068033057;28949.565756513668;29124.41751164986;29344.266393340124;3142.9371412571622;3143.8899638512544;3161.573187619665;3179.1734149121394;3251.4960181171955;200217;200237;200281;200400;200685;49764.01415915057;50172.49827501751;50467.49532504701;50556.74721626442;50560.24159637609;53960.73019634877;54322.185167222524;54590.45409545933;54677;54718.726406367714;14148.292585370691;14555.199464029369;14579.854201457849;14587.635309117144;14596.489122880861;11492.023178029962;11531;11544.538218471334;11547.133964952662;11548.307101573933;16090.839091608934;16358.918205408896;16378.836211637969;16462.42381516641;16487;5674.347450043216;5777.277840269966;5816.88366232673;5890.352061273256;5898.793542226002;907.3331101640289;937.7702462896498;990.3661656539821;1022.6880801355658;1065.6909496246158;27279.863600682267;27497.45005099887;27914.44171116607;28298.71701283002;28410.71589284122;960.9327347085776;1037.3516552154904;1061.0053149890668;1110.5169251375678;1129.7966366054025;14300.499482518062;14740;14740.631484212767;14860.70278594422;14961.850381496046;267160;269584;272694;272721;273010;46923.53076469192;47167.29249061267;47269.29096063562;47356;47510.762446187546;1036.4247842447514;1236.1655882279426;1252.2111070026008;1256.2839181666363;1258.6979125009932;24487.247370051024;26519.7348026525;26976.595351069358;27020.59469108004;28463.145716664858;40953.385699215134;42016.159676805684;42025;42064.15871682488;42100.789496052326;242588;251306;252500;252583;252983;28729.994450194143;32754.83622581872;33292;33714.3257134851;33773.83113084419;36527.81736091409;36869.26261474809;37206.25587488181;37464.06339841526;38019.80990095032;31540.211494712818;33540.49689254712;35313.64686353104;35495.82252088723;36012;34919.82540087283;35049.29901401907;35146.82426587851;35221.647783522865;35253.29493410169;34482.65517344794;34850.128746781535;35475.82262088673;35806.283874321845;35978.4603230957;30287.545686815156;30557.08328750141;31471.685283146875;31693.36613267768;31871.362572747952;24025;24246.15138470145;24461.266162015167;24477.632835507124;24610.630840537764 01:47:10 INFO - PROCESS | 21821 | |2;jquery.html;383.1780830119393;389.7647769571067;390.0657924271372;395.19972056585414;395.82385838301957;15025.39898404064;15300.31148598313;15477;15490.845091549081;15497.612559686013;14646.048006879546;14750.188739619343;15253.92373038136;15374.308156132973;15395.538133855975;5032.67287626304;5172.09488339541;5203.661761985478;5213.478652134775;5216.400113986883;5014.924776128361;5014.974925125388;5096;5112.565431938289;5141.126008578532;4972.378452693413;5081.898362032757;5083;5111.335526381584;5124.103281925667;5002.549770520671;5077.213031980049;5092.541671249587;5095.643304968654;5124.666896651705;4472.686911916167;4524.977375113103;4574.19951508488;4586.931196032062;4616.330632058366;18226.36207732723;18256.817431825646;18262.178201980943;18510.907445462686;18565.535861603432;1739.6433731085096;1890.1872194956163;1956.3055115434101;1972.5068732816796;1985.6227316809905;8763.912360876373;8784;8845.911540884574;9093.726878237052;9104.63581456741;1757.4376199616129;1837.5865430278081;1866.962660746791;1889.2065332560358;1889.9244030238774;57253.71373143149;58682.413175868125;60172;60358.094628580606;61210.08184877275;9873.50632468388;9894.356866803635;9970.50147492637;9989.350692204984;10156.289059765746;13764.518241861486;13821.239831809145;13833.654158646114;13834.031617786859;13856.237906915216;6887.7244910203035;7023.89464158038;7081.46888983318;7215.567065976058;7239.89140162898;6707.731690732316;6731.259561448237;6746.797596072126;6876.277990810993;6892.586444813327;4385.846495372647;4435.467743870756;4440.158298688842;4444.377787109807;4484.327350897326;1798.1728404933876;1837.5773572078228;1855.8564857589236;1858.9721154182698;1860.553467167897;890.1009979920327;916.8349697054595;918.2424499787568;923.1460898668839;985.3644399362371;14739.557813265405;14807.777883331759;15074.397024118913;15399.307031183624;15835.920820395824;848.3764433141636;852.1691350932915;853.9402241843011;889.7375274294099;952.842780941137;8594.613242404106;8842.867356989651;8880.73357799267;8905.332100092519;9188.724338269863;345593.9271356146;346603;355729;356662;357008;44331.77834110809;64783.67608161929;66406.33593664099;67035;67767.32232677708;877.9165979231963;882.7049670855852;903.746950853762;913.5614904845711;915.0940568836936;13942.790858136934;14279.928600356932;14354.85645143577;14405.279736013366;14636.195009274592;29431.26421839471;31141.22146946254;31149.221269467536;31761.523577146825;31963.36073278475;38100.237995240495;38932;39114.4132838002;41662.58337416708;41895.58104419039;7390.187079421367;7438.739644112647;7463.776086717407;7560.924390756242;7658.846823063619;10873.238873278795;10977.725556861142;11085.889141108486;11118.277311974696;11216.831747523956;9525.285603579621;9614.71155865325;9761.121499065119;10031.247656425652;10152.949235253776;9176.6788162414;9671.129598336183;9797.804043919225;9814.362066465657;10050.145737612092;6005.009173486325;6423.614583125028;9851.605935762776;10018.1985441166;10320.690379288633;7269.60017199038;7273.127224733066;7354.1910389856;7440.144383395762;7764.534127952341;8167;9906.603735850485;10104.49477526106;10161.949190254298;10162.847557286794 01:47:10 INFO - PROCESS | 21821 | |3;mootools.html;1216.0818581970611;1424.4515861393363;1482.6664000599862;1568.5451219146448;1731.7575539424474;6370.331115232903;7037.577745335277;7171.247019063001;7196.028536147618;7199.640017999092;6873.072135261738;6994.580325180493;7004.229534751174;7005.369516743504;7018.929810701891;1892.441729689738;1948.704111765674;2220.7779222077825;2221.7889300516426;2245.595792757303;2277.646964720471;2280.247518318951;2280.327303445479;2281.1559722902466;2281.155972290255;2180.869147851134;2191.660292654633;2252.3017864461985;2259.107652477279;2259.3899647095354;1902.6765449873556;2154.6121698094335;2188.5732282204976;2221.44463884029;2224.477247846755;2249.246502421691;2251.594712951668;2272.2955883676113;2275.6586512023164;2278.0773786616446;7456.664450099758;7476.028116344894;7534.284242996907;7537.698492060311;7543.924560754377;4566.794494247767;4762.09520191166;4772.045590881838;4772.80908763649;4774.7135171889795;2882.769378449719;2935.5596660501096;2998.7301142897027;3064.417760625474;3065.846707664608;882.496976723268;894.49461054504;895.1853813030176;906.7733066733317;920.5121285718579;10118.190544756402;10130.392176469435;10137.594496220143;10149.594016239342;10153.89846101537;4245.893852653709;4388.846390376321;4410.140022695544;4477.843275485342;4486.1924853526025;8713.52075635846;8717.782055448537;8783.780405489913;8806.119388061143;8812.779680508038;4606.930896036562;4608.907821843544;4621.676482646182;4624.815007399667;4625.32932724753;3774.8112594370173;4185.560516145822;4355.2813785725;4357.281048627005;4362.738235705868;3614.8192590370377;3712.6472985066375;3743.082944678571;3761.0409345616695;3780.243951209714;1251.1429670675616;1257.251935098615;1273.1978853322348;1276.6616846535676;1280.8975281977418;732.3774791427351;773.7330620935768;818.3984771193168;821.5070957425617;838.7316058861106;4960.429550601655;5079.492050794891;5144.71704056273;5247.842564723064;5396;835.1356346181673;841.4026041510596;872.6247713483136;884.4869975414244;901.7790641292794;3739.9439008414897;3758.210775737126;3780.8487660493824;3804.334241507725;3877.9529527027544;8852.955735221283;9182.63269469227;9433.528323583794;9450.149486546106;9594.904050959402;9287.628494860264;9380.9361940373;9482.620695172254;9488.620455181715;9516.38143520669;7048;7127.180374256923;7166.355028047501;7195.02867112933;7195.136583609896;5306.575473961997;5325.307709997831;5492.5331346835965;5552.888942221052;5724.570657200643;8156.632951517077;8392.412531122764;8428.620712067848;8474.1949514796;8506.319494440553;8092.6762929482165;8376.623051962555;8472.110428405174;8475.788105297417;8540.188682075193;6003.7898673546215;6235.220597425322;6237.251529816451;6591.802245932629;6737.59574425536;6591.5056370773345;7000.334968178015;7206;7272.927270727437;7286.7085316586745;6449.96775016122;6461.353864613501;6532.5753826001155;6705.994100884906;6911.619860907698;6393.680315984089;6410.871782564416;6415.582987105823;6421.743130274924;6458.321876202931;6165.075238714049;6208.596441231305;6236.875262494816;6252.812415627538;6259.874802504016;4444.8444304449185;4578.198815207259;4601.918549141016;4647.488776234544;4713.010267843792;4578.5421457853945;4633.559811817872;4661.86014419568;4730.314104454904;4758.833440829554 01:47:10 INFO - PROCESS | 21821 | |4;prototype.html;304.593367853915;317.89827255278306;320.03668956441106;320.0670046813538;322.3086479501471;4686.086213188425;4701.85894423167;4720.291956206566;4738.8104475820965;4770.928436073453;4396.27461468858;4505.43682039745;4608.21660317746;4713.952860471394;4723.338732577433;3780.60303668115;3785.8642407277844;3788.9431658525145;3805.56236032857;3810.7523011004337;3756.192418629994;3779.8866034019024;3796.2407518496275;3810.40938654509;3839.7504162229366;3561.519194908693;3658.396364599851;3753.493278407421;3762.6136477170494;3799.6010418905894;3741.681957033655;3752.774833509998;3758.849646014156;3772.1701225730294;3778.1876896467115;3340.7160391366765;3367.848446819899;3379.4086034943784;3387.7120444762227;3395.779274347184;4388.934165987513;4532.79602417892;4589.334546490773;4591.770411479412;4603.884902877421;4288.721233119837;4299.742015479082;4303.591158839905;4314.201872653569;4324.848630297956;4875.951240487585;4908.214685650279;4909;4916.237983112587;4940.950590494085;3665.157013886794;3676.8161591920298;3684;3690.1881586051027;3722.3113723960882;5001.8499445016705;5156.9742151289;5161.561267292247;5178.766955487012;5204.635675502678;3780.5085338906315;3788.242351529705;3789.957761615578;3790.374588192917;3807.7334586579227;3837.6354246346555;3840.135969406861;3849.538055433366;3853;3870.7096967727534;3983.820728067186;4224.134052519226;4262.808173632194;4298.2263192625005;4303.1393721255245;5001.524855138756;5013.799448022039;5021.347224860818;5023.899522009612;5027.723475208899;1263.197869352949;1289.2586762611536;1297.8767017133357;1339.8995075369387;1359.8572149924314;852.4885068958575;883.4478450968145;894.9463032217958;914.9085091490798;935.2331088507494;4571.474280457724;4612.584867361954;4616.76916154191;4625;4629.930551041737;5327.440618735054;5426.158945363475;5457.727113644302;5461.2627295315415;5465.890682186334;4571.634269258451;4598.586127248564;4599.977000114978;4617.468991066004;4627.745473998963;2841.6447944007;2890.1474065150833;2894.6671132819997;2896.9710302897124;2905.4043920996146;4976.2038073908;5182.222666599965;5187.610929180327;5211.270422140903;5214.478552144831;5458.181272809111;5529.502344788988;5561.749721262553;5570.303712035996;5572.777088916479;5152.124138896322;5175.223716442564;5188.886667999171;5194.92207616886;5201.765920533585;4921.753912304299;5123.359580052494;5170.6380553360905;5407.86480337979;5432.483914028161;5048.7728052237;5061.114304996685;5065.797368105382;5068.695878247317;5072.5796776902525;4932.950670493249;4965.255211718127;4986.8753281168265;4988.8752781180765;5007.198848184273;3639.2721455708433;3646.817659117087;3706.425504046877;3707.796071216109;3725.7086891562035;5110.259012443249;5125.513076257749;5138.614603904797;5147.742612869416;5162.845114646567;4983.526564976321;4993.300937868774;5019.899602008012;5025.145725226647;5049.813293875863;4740.78666460017;4975.676581022222;4977.925331119964;4982.925256121233;5007.023630392038;4639.32729754177;4748.430188377417;4918.213085906238;4932.164005696667;4959.578435832995;4924.778384972613;5037.262144560121;5046;5055.368078990126;5066.9746651266505;4899.265110233494;4914.557689807934;4924.778384972613;4929.260610908393;4949.307097006494 01:47:10 INFO - PROCESS | 21821 | |5;yui.html;594.4573830908791;659.4065341192926;756.1757684124303;761.8057395364182;786.7600381883523;11849.526018959243;12048.939755301222;12222.755544889096;12242.755144897097;12254;10897.727556811084;10944.945275273632;10950;10971.615993440231;10991.120710343173;622.862970146567;767.4359345880802;785.77998160515;796.0566728426833;799.4084377560622;788.5347644889514;789.8104454930804;796.382803327423;797.4258533855643;801.3629164813987;839.4459656626627;839.7438781171741;840.1346612988601;840.6385254340631;840.9663613455455;656.1044174701522;819.901611806584;837.1252041616525;843.8607629741147;844.15162761425;609.439315829438;612.7671484835779;614.735663664624;614.9631022138641;615.1664494609829;11882.524699012029;12002.939985300018;12040.036797056215;12063.698407539794;12073.879261207363;11876.16866819323;12086.697832554168;12379.62861114168;12557.05822063349;12887.548935787296;9836.3606365586;9955.751106222402;10032.849507257397;10454.68635940923;10455.58177672892;3272.836358182105;3358.345122701074;3376.932461350784;3384.2047118927035;3453.5855697316233;44497.55502444999;44911.326330105076;44985.325220121726;45472.317915231295;47386.763066184794;9910.256730745079;9927.305088643725;10131.696049118538;10147.644832430977;10159.593616255415;16281.430149944696;16721.080340581386;16805.07572083547;16868.746968795476;16928;6192.504599632019;6221.346758590374;6221.9377806222265;6828.795136145924;6900.068490753784;3725.3666876631037;3762.774233545996;3803.391457366808;3856.0552664597353;3933.6853051755793;2798.664160300777;2883.855807209631;2885.0623547346777;2886.105307354727;2888.870000849967;524.4676653197008;528.3448523830499;530.1755769778032;530.4218401941902;536.4528181255098;473.3987835449029;523.6517715719004;537.6021743909479;621.2234706616729;624.1075262374757;7745;7897.328727058264;8054.879176812353;8197.139300373494;8250.504969701837;618.9659568723673;637.7512770019696;648.9459574425925;656.4780999105723;666.5500786968777;3736.981315093407;3820.7325487216185;3897.376419772823;3911.902202444962;4055.2497787909333;48762.268565971535;52916.73541632267;53941.73029134908;53949;53965.460345396044;45545.544544554796;47054.76472617615;47326.29010564844;48290.75854620704;49043.509564904605;43801.342979855326;43882.341764873556;43977.56022439799;44768.77615611901;45395.77302113534;7849.3328067114935;7946.404019698662;7972.681092756225;8043;8060.556669383241;26416;26531.469370612867;27232.319192020357;29567.408651826412;29778.255543611584;36913.44629830501;37291.44062839114;37982.62017379901;38134.618653814214;38781.6121838778;10749.462526873782;11095.389753563632;11147.72130696739;11188.944055279671;11285.492152852978;9507.477088759908;11398.829017564578;11841.348725820162;12161.574344897886;12348.691282718004;11383.146264030065;11411.486483108447;11504.194706370474;11689.766204676029;11745.88254117482;10962.177836662122;11018.779624407307;11264.0425563828;11304.378259195822;11304.773904522028;10853.131749459866;10868.891311087104;11502;11752.823707644564;11813.173077884465;9690.806183876424;9888.901110989085;10064.899351006396;10372.688819335432;10585.682429527127;9540.904590954002;9959;10196.214448518424;10205.642802501878;10236.232282578985 01:47:10 INFO - PROCESS | 21821 | __end_tp_report 01:47:10 INFO - PROCESS | 21821 | __start_cc_report 01:47:10 INFO - PROCESS | 21821 | _x_x_mozilla_cycle_collect,1071 01:47:10 INFO - PROCESS | 21821 | __end_cc_report 01:47:10 INFO - PROCESS | 21821 | __startTimestamp1461833230403__endTimestamp 01:47:10 INFO - PROCESS | 21821 | 01:47:10 INFO - PROCESS | 21821 | ------- Summary: start ------- 01:47:10 INFO - PROCESS | 21821 | Number of tests: 6 01:47:10 INFO - PROCESS | 21821 | 01:47:10 INFO - PROCESS | 21821 | [#0] dojo.html Cycles:165 Average:4686.57 Median:4843.32 stddev:515.08 (10.6%) stddev-sans-first:491.03 01:47:10 INFO - PROCESS | 21821 | Values: 2640.9 2712.8 2714.5 2720.7 2750.2 4559.3 4724.8 4728.6 4734.5 4746.2 4747.6 4775.3 4844.6 4845.9 4856.1 4350.2 4388.7 4405.3 4465.0 4509.5 4442.4 4484.5 4500.8 4507.5 4529.1 4254.7 4351.8 4385.8 4419.6 4484.3 4403.3 4422.8 4437.7 4439.7 4479.4 4384.0 4389.8 4413.7 4421.0 4454.8 4496.9 4636.2 4642.7 4682.3 4725.6 5032.7 5053.8 5055.4 5058.9 5102.7 5097.5 5128.9 5135.6 5143.2 5168.6 4622.3 4727.0 4755.7 4843.3 4854.0 5188.2 5193.9 5200.3 5201.1 5208.0 4982.5 4985.0 4988.5 4991.3 5028.1 4957.0 5069.5 5163.4 5168.5 5172.2 5068.6 5084.2 5113.7 5115.8 5125.0 5105.8 5111.8 5119.0 5120.2 5155.4 3869.6 3893.6 3895.8 3901.4 3971.6 3510.3 3515.2 3544.2 3560.0 3588.3 4323.3 4333.5 4338.5 4379.5 4380.3 5002.9 5087.2 5097.7 5127.2 5206.6 4282.9 4293.1 4296.7 4325.9 4341.3 4549.1 4558.8 4560.3 4564.7 4596.8 4795.3 4826.3 4829.4 4885.6 4935.3 5111.1 5123.4 5144.6 5147.6 5187.7 4872.6 4895.9 4907.1 4910.3 4958.2 4852.9 5008.1 5036.1 5067.0 5095.8 5065.6 5101.7 5105.6 5106.7 5155.2 4743.8 4958.5 4965.4 4965.9 4969.8 4859.2 4869.9 4888.4 4911.3 4952.2 4822.6 4824.2 4828.5 4831.3 4864.2 4784.4 4874.9 4916.2 4927.6 4971.3 4764.0 4800.3 4810.1 4871.5 4879.5 01:47:10 INFO - PROCESS | 21821 | 01:47:10 INFO - PROCESS | 21821 | [#1] ext.html Cycles:180 Average:40324.22 Median:34649.98 stddev:63019.11 (181.9%) stddev-sans-first:63125.22 01:47:10 INFO - PROCESS | 21821 | Values: 575.7 584.6 599.7 609.2 627.0 28217.6 29890.9 33314.8 34038.1 34473.5 34817.3 35373.0 35475.0 35497.5 35595.0 7463.6 7657.0 7659.8 7675.7 7684.0 7093.4 9240.1 9544.8 9554.2 9557.1 9483.4 9659.9 9664.8 9667.7 9680.2 9356.5 9493.5 9507.1 9513.6 9516.3 9444.2 9545.8 9563.7 9572.0 9575.5 35978.3 36588.8 36651.6 36653.5 36664.8 3112.9 3317.9 3589.9 3692.2 3734.0 28225.7 28822.2 28949.6 29124.4 29344.3 3142.9 3143.9 3161.6 3179.2 3251.5 200217.0 200237.0 200281.0 200400.0 200685.0 49764.0 50172.5 50467.5 50556.7 50560.2 53960.7 54322.2 54590.5 54677.0 54718.7 14148.3 14555.2 14579.9 14587.6 14596.5 11492.0 11531.0 11544.5 11547.1 11548.3 16090.8 16358.9 16378.8 16462.4 16487.0 5674.3 5777.3 5816.9 5890.4 5898.8 907.3 937.8 990.4 1022.7 1065.7 27279.9 27497.5 27914.4 28298.7 28410.7 960.9 1037.4 1061.0 1110.5 1129.8 14300.5 14740.0 14740.6 14860.7 14961.9 267160.0 269584.0 272694.0 272721.0 273010.0 46923.5 47167.3 47269.3 47356.0 47510.8 1036.4 1236.2 1252.2 1256.3 1258.7 24487.2 26519.7 26976.6 27020.6 28463.1 40953.4 42016.2 42025.0 42064.2 42100.8 242588.0 251306.0 252500.0 252583.0 252983.0 28730.0 32754.8 33292.0 33714.3 33773.8 36527.8 36869.3 37206.3 37464.1 38019.8 31540.2 33540.5 35313.6 35495.8 36012.0 34919.8 35049.3 35146.8 35221.6 35253.3 34482.7 34850.1 35475.8 35806.3 35978.5 30287.5 30557.1 31471.7 31693.4 31871.4 24025.0 24246.2 24461.3 24477.6 24610.6 01:47:10 INFO - PROCESS | 21821 | 01:47:10 INFO - PROCESS | 21821 | [#2] jquery.html Cycles:180 Average:21681.58 Median:4987.46 stddev:57850.04 (1159.9%) stddev-sans-first:57990.22 01:47:10 INFO - PROCESS | 21821 | Values: 383.2 389.8 390.1 395.2 395.8 15025.4 15300.3 15477.0 15490.8 15497.6 14646.0 14750.2 15253.9 15374.3 15395.5 5032.7 5172.1 5203.7 5213.5 5216.4 5014.9 5015.0 5096.0 5112.6 5141.1 4972.4 5081.9 5083.0 5111.3 5124.1 5002.5 5077.2 5092.5 5095.6 5124.7 4472.7 4525.0 4574.2 4586.9 4616.3 18226.4 18256.8 18262.2 18510.9 18565.5 1739.6 1890.2 1956.3 1972.5 1985.6 8763.9 8784.0 8845.9 9093.7 9104.6 1757.4 1837.6 1867.0 1889.2 1889.9 57253.7 58682.4 60172.0 60358.1 61210.1 9873.5 9894.4 9970.5 9989.4 10156.3 13764.5 13821.2 13833.7 13834.0 13856.2 6887.7 7023.9 7081.5 7215.6 7239.9 6707.7 6731.3 6746.8 6876.3 6892.6 4385.8 4435.5 4440.2 4444.4 4484.3 1798.2 1837.6 1855.9 1859.0 1860.6 890.1 916.8 918.2 923.1 985.4 14739.6 14807.8 15074.4 15399.3 15835.9 848.4 852.2 853.9 889.7 952.8 8594.6 8842.9 8880.7 8905.3 9188.7 345593.9 346603.0 355729.0 356662.0 357008.0 44331.8 64783.7 66406.3 67035.0 67767.3 877.9 882.7 903.7 913.6 915.1 13942.8 14279.9 14354.9 14405.3 14636.2 29431.3 31141.2 31149.2 31761.5 31963.4 38100.2 38932.0 39114.4 41662.6 41895.6 7390.2 7438.7 7463.8 7560.9 7658.8 10873.2 10977.7 11085.9 11118.3 11216.8 9525.3 9614.7 9761.1 10031.2 10152.9 9176.7 9671.1 9797.8 9814.4 10050.1 6005.0 6423.6 9851.6 10018.2 10320.7 7269.6 7273.1 7354.2 7440.1 7764.5 8167.0 9906.6 10104.5 10161.9 10162.8 01:47:10 INFO - PROCESS | 21821 | 01:47:10 INFO - PROCESS | 21821 | [#3] mootools.html Cycles:180 Average:5012.57 Median:5360.65 stddev:2690.94 (50.2%) stddev-sans-first:2683.36 01:47:10 INFO - PROCESS | 21821 | Values: 1216.1 1424.5 1482.7 1568.5 1731.8 6370.3 7037.6 7171.2 7196.0 7199.6 6873.1 6994.6 7004.2 7005.4 7018.9 1892.4 1948.7 2220.8 2221.8 2245.6 2277.6 2280.2 2280.3 2281.2 2281.2 2180.9 2191.7 2252.3 2259.1 2259.4 1902.7 2154.6 2188.6 2221.4 2224.5 2249.2 2251.6 2272.3 2275.7 2278.1 7456.7 7476.0 7534.3 7537.7 7543.9 4566.8 4762.1 4772.0 4772.8 4774.7 2882.8 2935.6 2998.7 3064.4 3065.8 882.5 894.5 895.2 906.8 920.5 10118.2 10130.4 10137.6 10149.6 10153.9 4245.9 4388.8 4410.1 4477.8 4486.2 8713.5 8717.8 8783.8 8806.1 8812.8 4606.9 4608.9 4621.7 4624.8 4625.3 3774.8 4185.6 4355.3 4357.3 4362.7 3614.8 3712.6 3743.1 3761.0 3780.2 1251.1 1257.3 1273.2 1276.7 1280.9 732.4 773.7 818.4 821.5 838.7 4960.4 5079.5 5144.7 5247.8 5396.0 835.1 841.4 872.6 884.5 901.8 3739.9 3758.2 3780.8 3804.3 3878.0 8853.0 9182.6 9433.5 9450.1 9594.9 9287.6 9380.9 9482.6 9488.6 9516.4 7048.0 7127.2 7166.4 7195.0 7195.1 5306.6 5325.3 5492.5 5552.9 5724.6 8156.6 8392.4 8428.6 8474.2 8506.3 8092.7 8376.6 8472.1 8475.8 8540.2 6003.8 6235.2 6237.3 6591.8 6737.6 6591.5 7000.3 7206.0 7272.9 7286.7 6450.0 6461.4 6532.6 6706.0 6911.6 6393.7 6410.9 6415.6 6421.7 6458.3 6165.1 6208.6 6236.9 6252.8 6259.9 4444.8 4578.2 4601.9 4647.5 4713.0 4578.5 4633.6 4661.9 4730.3 4758.8 01:47:10 INFO - PROCESS | 21821 | 01:47:10 INFO - PROCESS | 21821 | [#4] prototype.html Cycles:180 Average:4220.71 Median:4707.91 stddev:1212.62 (25.8%) stddev-sans-first:1179.86 01:47:10 INFO - PROCESS | 21821 | Values: 304.6 317.9 320.0 320.1 322.3 4686.1 4701.9 4720.3 4738.8 4770.9 4396.3 4505.4 4608.2 4714.0 4723.3 3780.6 3785.9 3788.9 3805.6 3810.8 3756.2 3779.9 3796.2 3810.4 3839.8 3561.5 3658.4 3753.5 3762.6 3799.6 3741.7 3752.8 3758.8 3772.2 3778.2 3340.7 3367.8 3379.4 3387.7 3395.8 4388.9 4532.8 4589.3 4591.8 4603.9 4288.7 4299.7 4303.6 4314.2 4324.8 4876.0 4908.2 4909.0 4916.2 4941.0 3665.2 3676.8 3684.0 3690.2 3722.3 5001.8 5157.0 5161.6 5178.8 5204.6 3780.5 3788.2 3790.0 3790.4 3807.7 3837.6 3840.1 3849.5 3853.0 3870.7 3983.8 4224.1 4262.8 4298.2 4303.1 5001.5 5013.8 5021.3 5023.9 5027.7 1263.2 1289.3 1297.9 1339.9 1359.9 852.5 883.4 894.9 914.9 935.2 4571.5 4612.6 4616.8 4625.0 4629.9 5327.4 5426.2 5457.7 5461.3 5465.9 4571.6 4598.6 4600.0 4617.5 4627.7 2841.6 2890.1 2894.7 2897.0 2905.4 4976.2 5182.2 5187.6 5211.3 5214.5 5458.2 5529.5 5561.7 5570.3 5572.8 5152.1 5175.2 5188.9 5194.9 5201.8 4921.8 5123.4 5170.6 5407.9 5432.5 5048.8 5061.1 5065.8 5068.7 5072.6 4933.0 4965.3 4986.9 4988.9 5007.2 3639.3 3646.8 3706.4 3707.8 3725.7 5110.3 5125.5 5138.6 5147.7 5162.8 4983.5 4993.3 5019.9 5025.1 5049.8 4740.8 4975.7 4977.9 4982.9 5007.0 4639.3 4748.4 4918.2 4932.2 4959.6 4924.8 5037.3 5046.0 5055.4 5067.0 4899.3 4914.6 4924.8 4929.3 4949.3 01:47:10 INFO - PROCESS | 21821 | 01:47:10 INFO - PROCESS | 21821 | [#5] yui.html Cycles:180 Average:12763.85 Median:23928.30 stddev:14507.58 (60.6%) stddev-sans-first:14519.49 01:47:10 INFO - PROCESS | 21821 | Values: 594.5 659.4 756.2 761.8 786.8 11849.5 12048.9 12222.8 12242.8 12254.0 10897.7 10944.9 10950.0 10971.6 10991.1 622.9 767.4 785.8 796.1 799.4 788.5 789.8 796.4 797.4 801.4 839.4 839.7 840.1 840.6 841.0 656.1 819.9 837.1 843.9 844.2 609.4 612.8 614.7 615.0 615.2 11882.5 12002.9 12040.0 12063.7 12073.9 11876.2 12086.7 12379.6 12557.1 12887.5 9836.4 9955.8 10032.8 10454.7 10455.6 3272.8 3358.3 3376.9 3384.2 3453.6 44497.6 44911.3 44985.3 45472.3 47386.8 9910.3 9927.3 10131.7 10147.6 10159.6 16281.4 16721.1 16805.1 16868.7 16928.0 6192.5 6221.3 6221.9 6828.8 6900.1 3725.4 3762.8 3803.4 3856.1 3933.7 2798.7 2883.9 2885.1 2886.1 2888.9 524.5 528.3 530.2 530.4 536.5 473.4 523.7 537.6 621.2 624.1 7745.0 7897.3 8054.9 8197.1 8250.5 619.0 637.8 648.9 656.5 666.6 3737.0 3820.7 3897.4 3911.9 4055.2 48762.3 52916.7 53941.7 53949.0 53965.5 45545.5 47054.8 47326.3 48290.8 49043.5 43801.3 43882.3 43977.6 44768.8 45395.8 7849.3 7946.4 7972.7 8043.0 8060.6 26416.0 26531.5 27232.3 29567.4 29778.3 36913.4 37291.4 37982.6 38134.6 38781.6 10749.5 11095.4 11147.7 11188.9 11285.5 9507.5 11398.8 11841.3 12161.6 12348.7 11383.1 11411.5 11504.2 11689.8 11745.9 10962.2 11018.8 11264.0 11304.4 11304.8 10853.1 10868.9 11502.0 11752.8 11813.2 9690.8 9888.9 10064.9 10372.7 10585.7 9540.9 9959.0 10196.2 10205.6 10236.2 01:47:10 INFO - PROCESS | 21821 | -------- Summary: end -------- 01:47:10 INFO - PROCESS | 21821 | 01:47:11 INFO - TEST-INFO | 21821: exit 0 01:47:11 INFO - TEST-OK | dromaeo_css | took 1118955ms 01:47:11 INFO - TEST-START | kraken 01:47:11 INFO - operating with platform_type : linux_ 01:47:11 INFO - Initialising browser for kraken test... 01:47:11 INFO - TEST-INFO | started process 22000 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAP5G9v/profile http://localhost:52425/getInfo.html) 01:47:15 INFO - PROCESS | 22000 | __metrics Screen width/height:1600/1200 01:47:15 INFO - PROCESS | 22000 | colorDepth:24 01:47:15 INFO - PROCESS | 22000 | Browser inner width/height: 1024/697 01:47:15 INFO - PROCESS | 22000 | __metrics 01:47:16 ERROR - PROCESS | 22000 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 01:47:17 INFO - TEST-INFO | 22000: exit 0 01:47:17 INFO - Browser initialized. 01:47:17 INFO - Running cycle 1/1 for kraken test... 01:47:17 INFO - TEST-INFO | started process 22082 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAP5G9v/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:47:29 INFO - PROCESS | 22082 | RSS: Main: 156622848 01:47:29 INFO - PROCESS | 22082 | 01:47:32 INFO - PROCESS | 22082 | Cycle 1(1): loaded http://localhost:52425/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52425/tests/kraken/driver.html?testName=audio-beat-detection) 01:47:33 INFO - PROCESS | 22082 | RSS: Main: 211046400 01:47:33 INFO - PROCESS | 22082 | 01:47:35 INFO - PROCESS | 22082 | Cycle 1(1): loaded http://localhost:52425/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52425/tests/kraken/driver.html?testName=audio-dft) 01:47:36 INFO - PROCESS | 22082 | RSS: Main: 196943872 01:47:36 INFO - PROCESS | 22082 | 01:47:39 INFO - PROCESS | 22082 | Cycle 1(1): loaded http://localhost:52425/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52425/tests/kraken/driver.html?testName=audio-fft) 01:47:40 INFO - PROCESS | 22082 | RSS: Main: 266260480 01:47:40 INFO - PROCESS | 22082 | 01:47:42 INFO - PROCESS | 22082 | Cycle 1(1): loaded http://localhost:52425/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52425/tests/kraken/driver.html?testName=audio-oscillator) 01:47:43 INFO - PROCESS | 22082 | RSS: Main: 175665152 01:47:43 INFO - PROCESS | 22082 | 01:47:45 INFO - PROCESS | 22082 | Cycle 1(1): loaded http://localhost:52425/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52425/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:47:45 INFO - PROCESS | 22082 | RSS: Main: 180420608 01:47:45 INFO - PROCESS | 22082 | 01:47:49 INFO - PROCESS | 22082 | Cycle 1(1): loaded http://localhost:52425/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52425/tests/kraken/driver.html?testName=imaging-darkroom) 01:47:49 INFO - PROCESS | 22082 | RSS: Main: 215949312 01:47:49 INFO - PROCESS | 22082 | 01:47:53 INFO - PROCESS | 22082 | Cycle 1(1): loaded http://localhost:52425/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52425/tests/kraken/driver.html?testName=imaging-desaturate) 01:47:53 INFO - PROCESS | 22082 | RSS: Main: 213434368 01:47:53 INFO - PROCESS | 22082 | 01:47:56 INFO - PROCESS | 22082 | Cycle 1(1): loaded http://localhost:52425/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52425/tests/kraken/driver.html?testName=json-parse-financial) 01:47:57 INFO - PROCESS | 22082 | RSS: Main: 214827008 01:47:57 INFO - PROCESS | 22082 | 01:47:59 INFO - PROCESS | 22082 | Cycle 1(1): loaded http://localhost:52425/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52425/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:47:59 INFO - PROCESS | 22082 | RSS: Main: 203161600 01:47:59 INFO - PROCESS | 22082 | 01:48:01 INFO - PROCESS | 22082 | Cycle 1(1): loaded http://localhost:52425/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52425/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:48:02 INFO - PROCESS | 22082 | RSS: Main: 204419072 01:48:02 INFO - PROCESS | 22082 | 01:48:04 INFO - PROCESS | 22082 | Cycle 1(1): loaded http://localhost:52425/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52425/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:48:04 INFO - PROCESS | 22082 | RSS: Main: 216981504 01:48:04 INFO - PROCESS | 22082 | 01:48:07 INFO - PROCESS | 22082 | Cycle 1(1): loaded http://localhost:52425/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52425/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:48:08 INFO - PROCESS | 22082 | RSS: Main: 225386496 01:48:08 INFO - PROCESS | 22082 | 01:48:11 INFO - PROCESS | 22082 | Cycle 1(1): loaded http://localhost:52425/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52425/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:48:12 INFO - PROCESS | 22082 | RSS: Main: 219897856 01:48:12 INFO - PROCESS | 22082 | 01:48:14 INFO - PROCESS | 22082 | Cycle 1(1): loaded http://localhost:52425/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52425/tests/kraken/driver.html?testName=ai-astar) 01:48:14 INFO - PROCESS | 22082 | RSS: Main: 283082752 01:48:14 INFO - PROCESS | 22082 | 01:48:14 INFO - PROCESS | 22082 | __start_tp_report 01:48:14 INFO - PROCESS | 22082 | _x_x_mozilla_page_load 01:48:14 INFO - PROCESS | 22082 | _x_x_mozilla_page_load_details 01:48:14 INFO - PROCESS | 22082 | |i|pagename|runs| 01:48:14 INFO - PROCESS | 22082 | |0;ai-astar;111;114;109;113;113;114;101;112;113;113 01:48:14 INFO - PROCESS | 22082 | |1;audio-beat-detection;157;132;156;182;137;157;158;140;198;143 01:48:14 INFO - PROCESS | 22082 | |2;audio-dft;162;163;162;161;162;163;164;162;163;162 01:48:14 INFO - PROCESS | 22082 | |3;audio-fft;76;75;110;116;74;73;75;120;107;73 01:48:14 INFO - PROCESS | 22082 | |4;audio-oscillator;94;95;147;93;94;95;139;93;94;153 01:48:14 INFO - PROCESS | 22082 | |5;imaging-gaussian-blur;118;117;116;117;117;117;117;117;129;117 01:48:14 INFO - PROCESS | 22082 | |6;imaging-darkroom;147;145;146;146;146;146;145;146;145;146 01:48:14 INFO - PROCESS | 22082 | |7;imaging-desaturate;94;95;95;94;95;94;95;94;95;94 01:48:14 INFO - PROCESS | 22082 | |8;json-parse-financial;63;64;64;64;63;63;62;77;72;60 01:48:14 INFO - PROCESS | 22082 | |9;json-stringify-tinderbox;63;65;64;64;66;64;65;64;65;65 01:48:14 INFO - PROCESS | 22082 | |10;stanford-crypto-aes;80;79;78;80;79;80;80;80;79;78 01:48:14 INFO - PROCESS | 22082 | |11;stanford-crypto-ccm;135;137;135;134;134;134;135;139;168;145 01:48:14 INFO - PROCESS | 22082 | |12;stanford-crypto-pbkdf2;212;221;216;214;216;214;217;217;212;215 01:48:14 INFO - PROCESS | 22082 | |13;stanford-crypto-sha256-iterative;74;73;74;74;75;74;75;75;74;72 01:48:14 INFO - PROCESS | 22082 | __end_tp_report 01:48:14 INFO - PROCESS | 22082 | __start_cc_report 01:48:14 INFO - PROCESS | 22082 | _x_x_mozilla_cycle_collect,1886 01:48:14 INFO - PROCESS | 22082 | __end_cc_report 01:48:14 INFO - PROCESS | 22082 | __startTimestamp1461833294371__endTimestamp 01:48:14 INFO - PROCESS | 22082 | 01:48:14 INFO - PROCESS | 22082 | ------- Summary: start ------- 01:48:14 INFO - PROCESS | 22082 | Number of tests: 14 01:48:14 INFO - PROCESS | 22082 | 01:48:14 INFO - PROCESS | 22082 | [#0] ai-astar Cycles:10 Average:111.30 Median:113.00 stddev:3.92 (3.5%) stddev-sans-first:4.15 01:48:14 INFO - PROCESS | 22082 | Values: 111.0 114.0 109.0 113.0 113.0 114.0 101.0 112.0 113.0 113.0 01:48:14 INFO - PROCESS | 22082 | 01:48:14 INFO - PROCESS | 22082 | [#1] audio-beat-detection Cycles:10 Average:156.00 Median:157.00 stddev:20.57 (13.1%) stddev-sans-first:21.81 01:48:14 INFO - PROCESS | 22082 | Values: 157.0 132.0 156.0 182.0 137.0 157.0 158.0 140.0 198.0 143.0 01:48:14 INFO - PROCESS | 22082 | 01:48:14 INFO - PROCESS | 22082 | [#2] audio-dft Cycles:10 Average:162.40 Median:162.50 stddev:0.84 (0.5%) stddev-sans-first:0.88 01:48:14 INFO - PROCESS | 22082 | Values: 162.0 163.0 162.0 161.0 162.0 163.0 164.0 162.0 163.0 162.0 01:48:14 INFO - PROCESS | 22082 | 01:48:14 INFO - PROCESS | 22082 | [#3] audio-fft Cycles:10 Average:89.90 Median:73.50 stddev:20.40 (27.8%) stddev-sans-first:21.01 01:48:14 INFO - PROCESS | 22082 | Values: 76.0 75.0 110.0 116.0 74.0 73.0 75.0 120.0 107.0 73.0 01:48:14 INFO - PROCESS | 22082 | 01:48:14 INFO - PROCESS | 22082 | [#4] audio-oscillator Cycles:10 Average:109.70 Median:94.00 stddev:25.50 (27.1%) stddev-sans-first:26.41 01:48:14 INFO - PROCESS | 22082 | Values: 94.0 95.0 147.0 93.0 94.0 95.0 139.0 93.0 94.0 153.0 01:48:14 INFO - PROCESS | 22082 | 01:48:14 INFO - PROCESS | 22082 | [#5] imaging-gaussian-blur Cycles:10 Average:118.20 Median:117.00 stddev:3.82 (3.3%) stddev-sans-first:4.06 01:48:14 INFO - PROCESS | 22082 | Values: 118.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 129.0 117.0 01:48:14 INFO - PROCESS | 22082 | 01:48:14 INFO - PROCESS | 22082 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.50 01:48:14 INFO - PROCESS | 22082 | Values: 147.0 145.0 146.0 146.0 146.0 146.0 145.0 146.0 145.0 146.0 01:48:14 INFO - PROCESS | 22082 | 01:48:14 INFO - PROCESS | 22082 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:95.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 01:48:14 INFO - PROCESS | 22082 | Values: 94.0 95.0 95.0 94.0 95.0 94.0 95.0 94.0 95.0 94.0 01:48:14 INFO - PROCESS | 22082 | 01:48:14 INFO - PROCESS | 22082 | [#8] json-parse-financial Cycles:10 Average:65.20 Median:64.00 stddev:5.18 (8.1%) stddev-sans-first:5.43 01:48:14 INFO - PROCESS | 22082 | Values: 63.0 64.0 64.0 64.0 63.0 63.0 62.0 77.0 72.0 60.0 01:48:14 INFO - PROCESS | 22082 | 01:48:14 INFO - PROCESS | 22082 | [#9] json-stringify-tinderbox Cycles:10 Average:64.50 Median:65.00 stddev:0.85 (1.3%) stddev-sans-first:0.71 01:48:14 INFO - PROCESS | 22082 | Values: 63.0 65.0 64.0 64.0 66.0 64.0 65.0 64.0 65.0 65.0 01:48:14 INFO - PROCESS | 22082 | 01:48:14 INFO - PROCESS | 22082 | [#10] stanford-crypto-aes Cycles:10 Average:79.30 Median:80.00 stddev:0.82 (1.0%) stddev-sans-first:0.83 01:48:14 INFO - PROCESS | 22082 | Values: 80.0 79.0 78.0 80.0 79.0 80.0 80.0 80.0 79.0 78.0 01:48:14 INFO - PROCESS | 22082 | 01:48:14 INFO - PROCESS | 22082 | [#11] stanford-crypto-ccm Cycles:10 Average:139.60 Median:136.00 stddev:10.54 (7.8%) stddev-sans-first:11.05 01:48:14 INFO - PROCESS | 22082 | Values: 135.0 137.0 135.0 134.0 134.0 134.0 135.0 139.0 168.0 145.0 01:48:14 INFO - PROCESS | 22082 | 01:48:14 INFO - PROCESS | 22082 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:215.40 Median:216.00 stddev:2.67 (1.2%) stddev-sans-first:2.54 01:48:14 INFO - PROCESS | 22082 | Values: 212.0 221.0 216.0 214.0 216.0 214.0 217.0 217.0 212.0 215.0 01:48:14 INFO - PROCESS | 22082 | 01:48:14 INFO - PROCESS | 22082 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.00 Median:74.00 stddev:0.94 (1.3%) stddev-sans-first:1.00 01:48:14 INFO - PROCESS | 22082 | Values: 74.0 73.0 74.0 74.0 75.0 74.0 75.0 75.0 74.0 72.0 01:48:14 INFO - PROCESS | 22082 | -------- Summary: end -------- 01:48:14 INFO - PROCESS | 22082 | 01:48:15 INFO - TEST-INFO | 22082: exit 0 01:48:15 INFO - TEST-OK | kraken | took 64216ms 01:48:15 INFO - SUITE-END | took 1183s 01:48:15 INFO - Completed test suite (00:19:43) 01:48:15 INFO - javascript benchmark 01:48:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2640.8811603477848, 2712.7694145997602, 2714.457108578285, 2720.7415295546916, 2750.202441292025, 4559.338895860106, 4724.763761811909, 4728.598069164121, 4734.479207287204, 4746.193147164978, 4747.572718455347, 4775.2598347256235, 4844.61243100552, 4845.927311090337, 4856.05306965142, 4350.173467041268, 4388.692791504596, 4405.317175837734, 4465.040016396474, 4509.458864936212, 4442.378067070596, 4484.461864576239, 4500.819967201308, 4507.504174540798, 4529.094181163764, 4254.702170848011, 4351.804168812411, 4385.846495372647, 4419.602235798761, 4484.349769283468, 4403.3174857897075, 4422.823087076546, 4437.711548749321, 4439.66702497314, 4479.372887795711, 4383.978080109611, 4389.758563279051, 4413.668974826901, 4420.977895110536, 4454.754988475633, 4496.910061798779, 4636.211843986531, 4642.698224615423, 4682.29765535169, 4725.5510726480925, 5032.748362581856, 5053.797848086072, 5055.393352797688, 5058.924116138261, 5102.69383836971, 5097.541221290102, 5128.9230661540105, 5135.563477104451, 5143.177091665353, 5168.586513078944, 4622.329762184464, 4726.952730472685, 4755.714657120515, 4843.321934929113, 4854.029194161182, 5188.195829646411, 5193.870153246199, 5200.2979597754575, 5201.08980928336, 5207.973960130251, 4982.451930287665, 4985.027919555724, 4988.501149884983, 4991.276264941564, 5028.120078986236, 4957.0, 5069.5437410632485, 5163.432022477525, 5168.457311982263, 5172.19830926207, 5068.594918528042, 5084.237364395371, 5113.74431278442, 5115.846524604268, 5125.0, 5105.846824595268, 5111.846644600668, 5118.97440512795, 5120.155174396183, 5155.38135423744, 3869.5743468218475, 3893.649571538575, 3895.824687889052, 3901.4342920276968, 3971.5631280559114, 3510.315488479722, 3515.226650136966, 3544.167120726627, 3560.0, 3588.3361578108133, 4323.308270676676, 4333.458317710286, 4338.522762496123, 4379.474463064453, 4380.342948557678, 5002.949970500321, 5087.186050231945, 5097.745112744422, 5127.1540195867265, 5206.635535512478, 4282.935755963663, 4293.141371725667, 4296.677749168824, 4325.9134817303475, 4341.261985462479, 4549.112922980054, 4558.772061396983, 4560.315952607069, 4564.7032942858605, 4596.7931443085145, 4795.328653988375, 4826.276058591239, 4829.396325459317, 4885.609151267961, 4935.259711043373, 5111.080005599028, 5123.359580052494, 5144.6398752087, 5147.56245719118, 5187.714675692873, 4872.585830204331, 4895.902081958269, 4907.116718990616, 4910.263460480814, 4958.206686930074, 4852.902941941071, 5008.123578373843, 5036.093503169464, 5066.974665126798, 5095.77069031887, 5065.594752419724, 5101.69389836611, 5105.617078719037, 5106.7446627669215, 5155.175171972616, 4743.762811859324, 4958.454569997225, 4965.4041515018425, 4965.875853103701, 4969.776360063734, 4859.222524396079, 4869.853904382732, 4888.437829649493, 4911.26331050331, 4952.207646776643, 4822.638302127284, 4824.179889418878, 4828.493008234085, 4831.251156070814, 4864.197407427876, 4784.425868895755, 4874.902501950012, 4916.213405855046, 4927.605791536596, 4971.328870602567, 4764.0, 4800.3279540865005, 4810.062037902575, 4871.48849370811, 4879.4876537963], "value": 4652.720741527439, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [575.7006356694519, 584.6024703201824, 599.7181324777354, 609.2293249039964, 627.031236739238, 28217.576736348972, 29890.850545747267, 33314.83342583287, 34038.14904627379, 34473.48289775649, 34817.30365392691, 35373.0, 35475.0, 35497.46753798695, 35595.0, 7463.589502577356, 7657.042869641295, 7659.770206893802, 7675.654595543186, 7684.0, 7093.3970612498, 9240.122188392092, 9544.761380965461, 9554.187894029015, 9557.092076252746, 9483.383580067308, 9659.903400966006, 9664.75838104046, 9667.661631842888, 9680.177184939253, 9356.532173391337, 9493.477858717803, 9507.096825801538, 9513.571889265, 9516.286278529138, 9444.197243234334, 9545.761355966157, 9563.665271715456, 9571.952140239255, 9575.521223938775, 35978.280434391425, 36588.81705591481, 36651.633483665355, 36653.45019824705, 36664.816675916714, 3112.859921303547, 3317.93364132716, 3589.94615080774, 3692.2061756722164, 3734.0, 28225.717742822515, 28822.186068033057, 28949.565756513668, 29124.41751164986, 29344.266393340124, 3142.9371412571622, 3143.8899638512544, 3161.573187619665, 3179.1734149121394, 3251.4960181171955, 200217.0, 200237.0, 200281.0, 200400.0, 200685.0, 49764.01415915057, 50172.49827501751, 50467.49532504701, 50556.74721626442, 50560.24159637609, 53960.73019634877, 54322.185167222524, 54590.45409545933, 54677.0, 54718.726406367714, 14148.292585370691, 14555.199464029369, 14579.854201457849, 14587.635309117144, 14596.489122880861, 11492.023178029962, 11531.0, 11544.538218471334, 11547.133964952662, 11548.307101573933, 16090.839091608934, 16358.918205408896, 16378.836211637969, 16462.42381516641, 16487.0, 5674.347450043216, 5777.277840269966, 5816.88366232673, 5890.352061273256, 5898.793542226002, 907.3331101640289, 937.7702462896498, 990.3661656539821, 1022.6880801355658, 1065.6909496246158, 27279.863600682267, 27497.45005099887, 27914.44171116607, 28298.71701283002, 28410.71589284122, 960.9327347085776, 1037.3516552154904, 1061.0053149890668, 1110.5169251375678, 1129.7966366054025, 14300.499482518062, 14740.0, 14740.631484212767, 14860.70278594422, 14961.850381496046, 267160.0, 269584.0, 272694.0, 272721.0, 273010.0, 46923.53076469192, 47167.29249061267, 47269.29096063562, 47356.0, 47510.762446187546, 1036.4247842447514, 1236.1655882279426, 1252.2111070026008, 1256.2839181666363, 1258.6979125009932, 24487.247370051024, 26519.7348026525, 26976.595351069358, 27020.59469108004, 28463.145716664858, 40953.385699215134, 42016.159676805684, 42025.0, 42064.15871682488, 42100.789496052326, 242588.0, 251306.0, 252500.0, 252583.0, 252983.0, 28729.994450194143, 32754.83622581872, 33292.0, 33714.3257134851, 33773.83113084419, 36527.81736091409, 36869.26261474809, 37206.25587488181, 37464.06339841526, 38019.80990095032, 31540.211494712818, 33540.49689254712, 35313.64686353104, 35495.82252088723, 36012.0, 34919.82540087283, 35049.29901401907, 35146.82426587851, 35221.647783522865, 35253.29493410169, 34482.65517344794, 34850.128746781535, 35475.82262088673, 35806.283874321845, 35978.4603230957, 30287.545686815156, 30557.08328750141, 31471.685283146875, 31693.36613267768, 31871.362572747952, 24025.0, 24246.15138470145, 24461.266162015167, 24477.632835507124, 24610.630840537764], "value": 17198.803221471935, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [383.1780830119393, 389.7647769571067, 390.0657924271372, 395.19972056585414, 395.82385838301957, 15025.39898404064, 15300.31148598313, 15477.0, 15490.845091549081, 15497.612559686013, 14646.048006879546, 14750.188739619343, 15253.92373038136, 15374.308156132973, 15395.538133855975, 5032.67287626304, 5172.09488339541, 5203.661761985478, 5213.478652134775, 5216.400113986883, 5014.924776128361, 5014.974925125388, 5096.0, 5112.565431938289, 5141.126008578532, 4972.378452693413, 5081.898362032757, 5083.0, 5111.335526381584, 5124.103281925667, 5002.549770520671, 5077.213031980049, 5092.541671249587, 5095.643304968654, 5124.666896651705, 4472.686911916167, 4524.977375113103, 4574.19951508488, 4586.931196032062, 4616.330632058366, 18226.36207732723, 18256.817431825646, 18262.178201980943, 18510.907445462686, 18565.535861603432, 1739.6433731085096, 1890.1872194956163, 1956.3055115434101, 1972.5068732816796, 1985.6227316809905, 8763.912360876373, 8784.0, 8845.911540884574, 9093.726878237052, 9104.63581456741, 1757.4376199616129, 1837.5865430278081, 1866.962660746791, 1889.2065332560358, 1889.9244030238774, 57253.71373143149, 58682.413175868125, 60172.0, 60358.094628580606, 61210.08184877275, 9873.50632468388, 9894.356866803635, 9970.50147492637, 9989.350692204984, 10156.289059765746, 13764.518241861486, 13821.239831809145, 13833.654158646114, 13834.031617786859, 13856.237906915216, 6887.7244910203035, 7023.89464158038, 7081.46888983318, 7215.567065976058, 7239.89140162898, 6707.731690732316, 6731.259561448237, 6746.797596072126, 6876.277990810993, 6892.586444813327, 4385.846495372647, 4435.467743870756, 4440.158298688842, 4444.377787109807, 4484.327350897326, 1798.1728404933876, 1837.5773572078228, 1855.8564857589236, 1858.9721154182698, 1860.553467167897, 890.1009979920327, 916.8349697054595, 918.2424499787568, 923.1460898668839, 985.3644399362371, 14739.557813265405, 14807.777883331759, 15074.397024118913, 15399.307031183624, 15835.920820395824, 848.3764433141636, 852.1691350932915, 853.9402241843011, 889.7375274294099, 952.842780941137, 8594.613242404106, 8842.867356989651, 8880.73357799267, 8905.332100092519, 9188.724338269863, 345593.9271356146, 346603.0, 355729.0, 356662.0, 357008.0, 44331.77834110809, 64783.67608161929, 66406.33593664099, 67035.0, 67767.32232677708, 877.9165979231963, 882.7049670855852, 903.746950853762, 913.5614904845711, 915.0940568836936, 13942.790858136934, 14279.928600356932, 14354.85645143577, 14405.279736013366, 14636.195009274592, 29431.26421839471, 31141.22146946254, 31149.221269467536, 31761.523577146825, 31963.36073278475, 38100.237995240495, 38932.0, 39114.4132838002, 41662.58337416708, 41895.58104419039, 7390.187079421367, 7438.739644112647, 7463.776086717407, 7560.924390756242, 7658.846823063619, 10873.238873278795, 10977.725556861142, 11085.889141108486, 11118.277311974696, 11216.831747523956, 9525.285603579621, 9614.71155865325, 9761.121499065119, 10031.247656425652, 10152.949235253776, 9176.6788162414, 9671.129598336183, 9797.804043919225, 9814.362066465657, 10050.145737612092, 6005.009173486325, 6423.614583125028, 9851.605935762776, 10018.1985441166, 10320.690379288633, 7269.60017199038, 7273.127224733066, 7354.1910389856, 7440.144383395762, 7764.534127952341, 8167.0, 9906.603735850485, 10104.49477526106, 10161.949190254298, 10162.847557286794], "value": 7737.013882635504, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1216.0818581970611, 1424.4515861393363, 1482.6664000599862, 1568.5451219146448, 1731.7575539424474, 6370.331115232903, 7037.577745335277, 7171.247019063001, 7196.028536147618, 7199.640017999092, 6873.072135261738, 6994.580325180493, 7004.229534751174, 7005.369516743504, 7018.929810701891, 1892.441729689738, 1948.704111765674, 2220.7779222077825, 2221.7889300516426, 2245.595792757303, 2277.646964720471, 2280.247518318951, 2280.327303445479, 2281.1559722902466, 2281.155972290255, 2180.869147851134, 2191.660292654633, 2252.3017864461985, 2259.107652477279, 2259.3899647095354, 1902.6765449873556, 2154.6121698094335, 2188.5732282204976, 2221.44463884029, 2224.477247846755, 2249.246502421691, 2251.594712951668, 2272.2955883676113, 2275.6586512023164, 2278.0773786616446, 7456.664450099758, 7476.028116344894, 7534.284242996907, 7537.698492060311, 7543.924560754377, 4566.794494247767, 4762.09520191166, 4772.045590881838, 4772.80908763649, 4774.7135171889795, 2882.769378449719, 2935.5596660501096, 2998.7301142897027, 3064.417760625474, 3065.846707664608, 882.496976723268, 894.49461054504, 895.1853813030176, 906.7733066733317, 920.5121285718579, 10118.190544756402, 10130.392176469435, 10137.594496220143, 10149.594016239342, 10153.89846101537, 4245.893852653709, 4388.846390376321, 4410.140022695544, 4477.843275485342, 4486.1924853526025, 8713.52075635846, 8717.782055448537, 8783.780405489913, 8806.119388061143, 8812.779680508038, 4606.930896036562, 4608.907821843544, 4621.676482646182, 4624.815007399667, 4625.32932724753, 3774.8112594370173, 4185.560516145822, 4355.2813785725, 4357.281048627005, 4362.738235705868, 3614.8192590370377, 3712.6472985066375, 3743.082944678571, 3761.0409345616695, 3780.243951209714, 1251.1429670675616, 1257.251935098615, 1273.1978853322348, 1276.6616846535676, 1280.8975281977418, 732.3774791427351, 773.7330620935768, 818.3984771193168, 821.5070957425617, 838.7316058861106, 4960.429550601655, 5079.492050794891, 5144.71704056273, 5247.842564723064, 5396.0, 835.1356346181673, 841.4026041510596, 872.6247713483136, 884.4869975414244, 901.7790641292794, 3739.9439008414897, 3758.210775737126, 3780.8487660493824, 3804.334241507725, 3877.9529527027544, 8852.955735221283, 9182.63269469227, 9433.528323583794, 9450.149486546106, 9594.904050959402, 9287.628494860264, 9380.9361940373, 9482.620695172254, 9488.620455181715, 9516.38143520669, 7048.0, 7127.180374256923, 7166.355028047501, 7195.02867112933, 7195.136583609896, 5306.575473961997, 5325.307709997831, 5492.5331346835965, 5552.888942221052, 5724.570657200643, 8156.632951517077, 8392.412531122764, 8428.620712067848, 8474.1949514796, 8506.319494440553, 8092.6762929482165, 8376.623051962555, 8472.110428405174, 8475.788105297417, 8540.188682075193, 6003.7898673546215, 6235.220597425322, 6237.251529816451, 6591.802245932629, 6737.59574425536, 6591.5056370773345, 7000.334968178015, 7206.0, 7272.927270727437, 7286.7085316586745, 6449.96775016122, 6461.353864613501, 6532.5753826001155, 6705.994100884906, 6911.619860907698, 6393.680315984089, 6410.871782564416, 6415.582987105823, 6421.743130274924, 6458.321876202931, 6165.075238714049, 6208.596441231305, 6236.875262494816, 6252.812415627538, 6259.874802504016, 4444.8444304449185, 4578.198815207259, 4601.918549141016, 4647.488776234544, 4713.010267843792, 4578.5421457853945, 4633.559811817872, 4661.86014419568, 4730.314104454904, 4758.833440829554], "value": 4093.000386192644, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [304.593367853915, 317.89827255278306, 320.03668956441106, 320.0670046813538, 322.3086479501471, 4686.086213188425, 4701.85894423167, 4720.291956206566, 4738.8104475820965, 4770.928436073453, 4396.27461468858, 4505.43682039745, 4608.21660317746, 4713.952860471394, 4723.338732577433, 3780.60303668115, 3785.8642407277844, 3788.9431658525145, 3805.56236032857, 3810.7523011004337, 3756.192418629994, 3779.8866034019024, 3796.2407518496275, 3810.40938654509, 3839.7504162229366, 3561.519194908693, 3658.396364599851, 3753.493278407421, 3762.6136477170494, 3799.6010418905894, 3741.681957033655, 3752.774833509998, 3758.849646014156, 3772.1701225730294, 3778.1876896467115, 3340.7160391366765, 3367.848446819899, 3379.4086034943784, 3387.7120444762227, 3395.779274347184, 4388.934165987513, 4532.79602417892, 4589.334546490773, 4591.770411479412, 4603.884902877421, 4288.721233119837, 4299.742015479082, 4303.591158839905, 4314.201872653569, 4324.848630297956, 4875.951240487585, 4908.214685650279, 4909.0, 4916.237983112587, 4940.950590494085, 3665.157013886794, 3676.8161591920298, 3684.0, 3690.1881586051027, 3722.3113723960882, 5001.8499445016705, 5156.9742151289, 5161.561267292247, 5178.766955487012, 5204.635675502678, 3780.5085338906315, 3788.242351529705, 3789.957761615578, 3790.374588192917, 3807.7334586579227, 3837.6354246346555, 3840.135969406861, 3849.538055433366, 3853.0, 3870.7096967727534, 3983.820728067186, 4224.134052519226, 4262.808173632194, 4298.2263192625005, 4303.1393721255245, 5001.524855138756, 5013.799448022039, 5021.347224860818, 5023.899522009612, 5027.723475208899, 1263.197869352949, 1289.2586762611536, 1297.8767017133357, 1339.8995075369387, 1359.8572149924314, 852.4885068958575, 883.4478450968145, 894.9463032217958, 914.9085091490798, 935.2331088507494, 4571.474280457724, 4612.584867361954, 4616.76916154191, 4625.0, 4629.930551041737, 5327.440618735054, 5426.158945363475, 5457.727113644302, 5461.2627295315415, 5465.890682186334, 4571.634269258451, 4598.586127248564, 4599.977000114978, 4617.468991066004, 4627.745473998963, 2841.6447944007, 2890.1474065150833, 2894.6671132819997, 2896.9710302897124, 2905.4043920996146, 4976.2038073908, 5182.222666599965, 5187.610929180327, 5211.270422140903, 5214.478552144831, 5458.181272809111, 5529.502344788988, 5561.749721262553, 5570.303712035996, 5572.777088916479, 5152.124138896322, 5175.223716442564, 5188.886667999171, 5194.92207616886, 5201.765920533585, 4921.753912304299, 5123.359580052494, 5170.6380553360905, 5407.86480337979, 5432.483914028161, 5048.7728052237, 5061.114304996685, 5065.797368105382, 5068.695878247317, 5072.5796776902525, 4932.950670493249, 4965.255211718127, 4986.8753281168265, 4988.8752781180765, 5007.198848184273, 3639.2721455708433, 3646.817659117087, 3706.425504046877, 3707.796071216109, 3725.7086891562035, 5110.259012443249, 5125.513076257749, 5138.614603904797, 5147.742612869416, 5162.845114646567, 4983.526564976321, 4993.300937868774, 5019.899602008012, 5025.145725226647, 5049.813293875863, 4740.78666460017, 4975.676581022222, 4977.925331119964, 4982.925256121233, 5007.023630392038, 4639.32729754177, 4748.430188377417, 4918.213085906238, 4932.164005696667, 4959.578435832995, 4924.778384972613, 5037.262144560121, 5046.0, 5055.368078990126, 5066.9746651266505, 4899.265110233494, 4914.557689807934, 4924.778384972613, 4929.260610908393, 4949.307097006494], "value": 3842.981401181374, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [594.4573830908791, 659.4065341192926, 756.1757684124303, 761.8057395364182, 786.7600381883523, 11849.526018959243, 12048.939755301222, 12222.755544889096, 12242.755144897097, 12254.0, 10897.727556811084, 10944.945275273632, 10950.0, 10971.615993440231, 10991.120710343173, 622.862970146567, 767.4359345880802, 785.77998160515, 796.0566728426833, 799.4084377560622, 788.5347644889514, 789.8104454930804, 796.382803327423, 797.4258533855643, 801.3629164813987, 839.4459656626627, 839.7438781171741, 840.1346612988601, 840.6385254340631, 840.9663613455455, 656.1044174701522, 819.901611806584, 837.1252041616525, 843.8607629741147, 844.15162761425, 609.439315829438, 612.7671484835779, 614.735663664624, 614.9631022138641, 615.1664494609829, 11882.524699012029, 12002.939985300018, 12040.036797056215, 12063.698407539794, 12073.879261207363, 11876.16866819323, 12086.697832554168, 12379.62861114168, 12557.05822063349, 12887.548935787296, 9836.3606365586, 9955.751106222402, 10032.849507257397, 10454.68635940923, 10455.58177672892, 3272.836358182105, 3358.345122701074, 3376.932461350784, 3384.2047118927035, 3453.5855697316233, 44497.55502444999, 44911.326330105076, 44985.325220121726, 45472.317915231295, 47386.763066184794, 9910.256730745079, 9927.305088643725, 10131.696049118538, 10147.644832430977, 10159.593616255415, 16281.430149944696, 16721.080340581386, 16805.07572083547, 16868.746968795476, 16928.0, 6192.504599632019, 6221.346758590374, 6221.9377806222265, 6828.795136145924, 6900.068490753784, 3725.3666876631037, 3762.774233545996, 3803.391457366808, 3856.0552664597353, 3933.6853051755793, 2798.664160300777, 2883.855807209631, 2885.0623547346777, 2886.105307354727, 2888.870000849967, 524.4676653197008, 528.3448523830499, 530.1755769778032, 530.4218401941902, 536.4528181255098, 473.3987835449029, 523.6517715719004, 537.6021743909479, 621.2234706616729, 624.1075262374757, 7745.0, 7897.328727058264, 8054.879176812353, 8197.139300373494, 8250.504969701837, 618.9659568723673, 637.7512770019696, 648.9459574425925, 656.4780999105723, 666.5500786968777, 3736.981315093407, 3820.7325487216185, 3897.376419772823, 3911.902202444962, 4055.2497787909333, 48762.268565971535, 52916.73541632267, 53941.73029134908, 53949.0, 53965.460345396044, 45545.544544554796, 47054.76472617615, 47326.29010564844, 48290.75854620704, 49043.509564904605, 43801.342979855326, 43882.341764873556, 43977.56022439799, 44768.77615611901, 45395.77302113534, 7849.3328067114935, 7946.404019698662, 7972.681092756225, 8043.0, 8060.556669383241, 26416.0, 26531.469370612867, 27232.319192020357, 29567.408651826412, 29778.255543611584, 36913.44629830501, 37291.44062839114, 37982.62017379901, 38134.618653814214, 38781.6121838778, 10749.462526873782, 11095.389753563632, 11147.72130696739, 11188.944055279671, 11285.492152852978, 9507.477088759908, 11398.829017564578, 11841.348725820162, 12161.574344897886, 12348.691282718004, 11383.146264030065, 11411.486483108447, 11504.194706370474, 11689.766204676029, 11745.88254117482, 10962.177836662122, 11018.779624407307, 11264.0425563828, 11304.378259195822, 11304.773904522028, 10853.131749459866, 10868.891311087104, 11502.0, 11752.823707644564, 11813.173077884465, 9690.806183876424, 9888.901110989085, 10064.899351006396, 10372.688819335432, 10585.682429527127, 9540.904590954002, 9959.0, 10196.214448518424, 10205.642802501878, 10236.232282578985], "value": 5930.68103215699, "unit": "score"}], "name": "dromaeo_css", "value": 6217.372126496561, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 114.0, 109.0, 113.0, 113.0, 114.0, 101.0, 112.0, 113.0, 113.0], "value": 111.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 132.0, 156.0, 182.0, 137.0, 157.0, 158.0, 140.0, 198.0, 143.0], "value": 156.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 162.0, 161.0, 162.0, 163.0, 164.0, 162.0, 163.0, 162.0], "value": 162.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 110.0, 116.0, 74.0, 73.0, 75.0, 120.0, 107.0, 73.0], "value": 89.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 147.0, 93.0, 94.0, 95.0, 139.0, 93.0, 94.0, 153.0], "value": 109.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 129.0, 117.0], "value": 118.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 145.0, 146.0, 146.0, 146.0, 146.0, 145.0, 146.0, 145.0, 146.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 94.0, 95.0, 94.0, 95.0, 94.0, 95.0, 94.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 64.0, 64.0, 63.0, 63.0, 62.0, 77.0, 72.0, 60.0], "value": 65.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 65.0, 64.0, 64.0, 66.0, 64.0, 65.0, 64.0, 65.0, 65.0], "value": 64.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 78.0, 80.0, 79.0, 80.0, 80.0, 80.0, 79.0, 78.0], "value": 79.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 137.0, 135.0, 134.0, 134.0, 134.0, 135.0, 139.0, 168.0, 145.0], "value": 139.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [212.0, 221.0, 216.0, 214.0, 216.0, 214.0, 217.0, 217.0, 212.0, 215.0], "value": 215.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 74.0, 74.0, 75.0, 74.0, 75.0, 75.0, 74.0, 72.0], "value": 74.0, "unit": "score"}], "name": "kraken", "value": 1625.8000000000002, "alertThreshold": 2.0}]} 01:48:15 INFO - Return code: 0 01:48:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 01:48:15 ERROR - # TBPL SUCCESS # 01:48:15 INFO - Running post-action listener: _resource_record_post_action 01:48:15 INFO - Running post-run listener: _resource_record_post_run 01:48:16 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 4096; Write bytes: 530554880; Read time: 8; Write time: 576116 01:48:16 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 190058496; Read time: 0; Write time: 328196 01:48:16 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 4096; Write bytes: 278372352; Read time: 8; Write time: 177764 01:48:16 INFO - Running post-run listener: _upload_blobber_files 01:48:16 INFO - Blob upload gear active. 01:48:16 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:48: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 01:48: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'] 01:48: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 01:48:17 INFO - (blobuploader) - INFO - Open directory for files ... 01:48:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 01:48:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:48:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:48:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 01:48:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:48:17 INFO - (blobuploader) - INFO - Done attempting. 01:48:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 01:48:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:48:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:48:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 01:48:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:48:18 INFO - (blobuploader) - INFO - Done attempting. 01:48:18 INFO - (blobuploader) - INFO - Iteration through files over. 01:48:18 INFO - Return code: 0 01:48:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:48:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:48:18 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/839b79c3984147807e46244c882d63f1749bc5cbb02c32d2b89ef74c6411f4abef207ec6f5ca793948aaf8eb5a56010ec156c0c2666af1887711f40820a61474", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2b125c7bab86fd220a180262a2bc5942d5741f6f68de9ad770b8ddde71c7e8da3af41873b1d5dec420c3024a5529f6e1bb5e83a522b11e6cc5891ad0c32af95c"} 01:48:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:48:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:48:18 INFO - Contents: 01:48:18 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/839b79c3984147807e46244c882d63f1749bc5cbb02c32d2b89ef74c6411f4abef207ec6f5ca793948aaf8eb5a56010ec156c0c2666af1887711f40820a61474", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2b125c7bab86fd220a180262a2bc5942d5741f6f68de9ad770b8ddde71c7e8da3af41873b1d5dec420c3024a5529f6e1bb5e83a522b11e6cc5891ad0c32af95c"} 01:48:18 INFO - Running post-run listener: copy_logs_to_upload_dir 01:48:18 INFO - Copying logs to upload dir... 01:48:18 INFO - mkdir: /builds/slave/test/build/upload/logs 01:48:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.881214 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-04-28 01:48:18.545327) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-28 01:48:18.551010) ========= 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=d2a8c569965ab8367867b893000001a1-1461831939.134167-1763156482 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/839b79c3984147807e46244c882d63f1749bc5cbb02c32d2b89ef74c6411f4abef207ec6f5ca793948aaf8eb5a56010ec156c0c2666af1887711f40820a61474", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2b125c7bab86fd220a180262a2bc5942d5741f6f68de9ad770b8ddde71c7e8da3af41873b1d5dec420c3024a5529f6e1bb5e83a522b11e6cc5891ad0c32af95c"} build_url:https://queue.taskcluster.net/v1/task/HWS_gDzuSMaCvWCPzhCglA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011436 build_url: 'https://queue.taskcluster.net/v1/task/HWS_gDzuSMaCvWCPzhCglA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/839b79c3984147807e46244c882d63f1749bc5cbb02c32d2b89ef74c6411f4abef207ec6f5ca793948aaf8eb5a56010ec156c0c2666af1887711f40820a61474", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2b125c7bab86fd220a180262a2bc5942d5741f6f68de9ad770b8ddde71c7e8da3af41873b1d5dec420c3024a5529f6e1bb5e83a522b11e6cc5891ad0c32af95c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-28 01:48:18.575648) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 01:48:18.576033) ========= 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=d2a8c569965ab8367867b893000001a1-1461831939.134167-1763156482 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004402 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 01:48:18.658999) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-28 01:48:18.659317) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-28 01:48:18.659599) ========= ========= Total master_lag: 1.02 =========