builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-039 starttime: 1462493492.93 results: success (0) buildid: 20160505165542 builduid: 54cccca5540141cfbc662dd54cafc05f revision: 8000d7a6ff44b128850bd4d08e0d1867f6df557d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-05 17:11:32.929380) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-05 17:11:32.929810) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-05 17:11:32.930194) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-05 17:11:32.962928) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 17:11:32.963206) ========= 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=5bd038846534b2fdfa68eeae000001e2-1462492486.754280-869052492 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-05 17:11:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 221M=0s 2016-05-05 17:11:33 (221 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.103059 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 17:11:33.083263) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 17:11:33.083800) ========= 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=5bd038846534b2fdfa68eeae000001e2-1462492486.754280-869052492 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015280 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 17:11:33.133070) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 17:11:33.133408) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 8000d7a6ff44b128850bd4d08e0d1867f6df557d --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 8000d7a6ff44b128850bd4d08e0d1867f6df557d --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=5bd038846534b2fdfa68eeae000001e2-1462492486.754280-869052492 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-05 17:11:33,243 truncating revision to first 12 chars 2016-05-05 17:11:33,243 Setting DEBUG logging. 2016-05-05 17:11:33,243 attempt 1/10 2016-05-05 17:11:33,243 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/8000d7a6ff44?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-05 17:11:33,496 unpacking tar archive at: fx-team-8000d7a6ff44/testing/mozharness/ program finished with exit code 0 elapsedTime=0.706376 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 17:11:33.854970) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-05 17:11:33.855348) ========= script_repo_revision: 8000d7a6ff44b128850bd4d08e0d1867f6df557d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-05 17:11:33.855901) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-05 17:11:33.856268) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-05 17:11:34.110567) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-05-05 17:11:34.111382) ========= /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=5bd038846534b2fdfa68eeae000001e2-1462492486.754280-869052492 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:11:34 INFO - MultiFileLogger online at 20160505 17:11:34 in /builds/slave/test 17:11:34 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 17:11:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:11:34 INFO - {'append_to_log': False, 17:11:34 INFO - 'base_work_dir': '/builds/slave/test', 17:11:34 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 17:11:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:11:34 INFO - 'branch': 'Fx-Team-Non-PGO', 17:11:34 INFO - 'buildbot_json_path': 'buildprops.json', 17:11:34 INFO - 'config_files': ('talos/linux_config.py',), 17:11:34 INFO - 'default_actions': ('clobber', 17:11:34 INFO - 'read-buildbot-config', 17:11:34 INFO - 'download-and-extract', 17:11:34 INFO - 'populate-webroot', 17:11:34 INFO - 'create-virtualenv', 17:11:34 INFO - 'install', 17:11:34 INFO - 'run-tests'), 17:11:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:11:34 INFO - 'download_minidump_stackwalk': True, 17:11:34 INFO - 'download_symbols': 'ondemand', 17:11:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:11:34 INFO - 'tooltool.py': '/tools/tooltool.py', 17:11:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:11:34 INFO - '/tools/misc-python/virtualenv.py')}, 17:11:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:11:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:11:34 INFO - 'installer_path': 'installer.exe', 17:11:34 INFO - 'log_level': 'info', 17:11:34 INFO - 'log_name': 'talos', 17:11:34 INFO - 'log_to_console': True, 17:11:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:11:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:11:34 INFO - 'opt_config_files': (), 17:11:34 INFO - 'pip_index': False, 17:11:34 INFO - 'sps_profile': False, 17:11:34 INFO - 'sps_profile_interval': 0, 17:11:34 INFO - 'suite': 'dromaeojs', 17:11:34 INFO - 'system_bits': '32', 17:11:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:11:34 INFO - 'title': 'talos-linux64-ix-039', 17:11:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:11:34 INFO - 'use_talos_json': True, 17:11:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:11:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:11:34 INFO - 'work_dir': 'build'} 17:11:34 INFO - ##### 17:11:34 INFO - ##### Running clobber step. 17:11:34 INFO - ##### 17:11:34 INFO - Running pre-action listener: _resource_record_pre_action 17:11:34 INFO - Running main action method: clobber 17:11:34 INFO - rmtree: /builds/slave/test/build 17:11:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:11:35 INFO - Running post-action listener: _resource_record_post_action 17:11:35 INFO - ##### 17:11:35 INFO - ##### Running read-buildbot-config step. 17:11:35 INFO - ##### 17:11:35 INFO - Running pre-action listener: _resource_record_pre_action 17:11:35 INFO - Running main action method: read_buildbot_config 17:11:35 INFO - Using buildbot properties: 17:11:35 INFO - { 17:11:35 INFO - "project": "", 17:11:35 INFO - "product": "firefox", 17:11:35 INFO - "script_repo_revision": "production", 17:11:35 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 17:11:35 INFO - "repository": "", 17:11:35 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 17:11:35 INFO - "buildid": "20160505165542", 17:11:35 INFO - "pgo_build": "False", 17:11:35 INFO - "basedir": "/builds/slave/test", 17:11:35 INFO - "buildnumber": 1653, 17:11:35 INFO - "slavename": "talos-linux64-ix-039", 17:11:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 17:11:35 INFO - "platform": "ubuntu64_hw", 17:11:35 INFO - "scheduler": "tests-fx-team-linux64-talos", 17:11:35 INFO - "branch": "fx-team", 17:11:35 INFO - "repo_path": "integration/fx-team", 17:11:35 INFO - "revision": "8000d7a6ff44b128850bd4d08e0d1867f6df557d", 17:11:35 INFO - "stage_platform": "linux64", 17:11:35 INFO - "builduid": "54cccca5540141cfbc662dd54cafc05f", 17:11:35 INFO - "slavebuilddir": "test" 17:11:35 INFO - } 17:11:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/HdG1fKWxQu-exyv9YPiN5Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 17:11:35 INFO - Running post-action listener: _resource_record_post_action 17:11:35 INFO - ##### 17:11:35 INFO - ##### Running download-and-extract step. 17:11:35 INFO - ##### 17:11:35 INFO - Running pre-action listener: _resource_record_pre_action 17:11:35 INFO - Running main action method: download_and_extract 17:11:35 INFO - mkdir: /builds/slave/test/build/tests 17:11:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:11:35 INFO - https://queue.taskcluster.net/v1/task/HdG1fKWxQu-exyv9YPiN5Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 17:11:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HdG1fKWxQu-exyv9YPiN5Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 17:11:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HdG1fKWxQu-exyv9YPiN5Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 17:11:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HdG1fKWxQu-exyv9YPiN5Q/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 17:11:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HdG1fKWxQu-exyv9YPiN5Q/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 17:11:37 INFO - Downloaded 1361 bytes. 17:11:37 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 17:11:37 INFO - Using the following test package requirements: 17:11:37 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 17:11:37 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:11:37 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:11:37 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:11:37 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:11:37 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:11:37 INFO - u'jsshell-linux-x86_64.zip'], 17:11:37 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:11:37 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:11:37 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 17:11:37 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:11:37 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:11:37 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:11:37 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:11:37 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:11:37 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:11:37 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:11:37 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:11:37 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:11:37 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')]} 17:11:37 INFO - https://queue.taskcluster.net/v1/task/HdG1fKWxQu-exyv9YPiN5Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:11:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HdG1fKWxQu-exyv9YPiN5Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:11:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HdG1fKWxQu-exyv9YPiN5Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:11:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HdG1fKWxQu-exyv9YPiN5Q/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 17:11:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HdG1fKWxQu-exyv9YPiN5Q/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 17:11:39 INFO - Downloaded 22321773 bytes. 17:11:39 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'] 17:11:39 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 17:11:40 INFO - Return code: 0 17:11:40 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 17:11:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:11:40 INFO - https://queue.taskcluster.net/v1/task/HdG1fKWxQu-exyv9YPiN5Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:11:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HdG1fKWxQu-exyv9YPiN5Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:11:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HdG1fKWxQu-exyv9YPiN5Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:11:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HdG1fKWxQu-exyv9YPiN5Q/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 17:11:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HdG1fKWxQu-exyv9YPiN5Q/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 17:11:53 INFO - Downloaded 22321773 bytes. 17:11:53 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'] 17:11:53 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 17:11:54 INFO - Return code: 0 17:11:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:11:54 INFO - https://queue.taskcluster.net/v1/task/HdG1fKWxQu-exyv9YPiN5Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:11:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HdG1fKWxQu-exyv9YPiN5Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 17:11:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HdG1fKWxQu-exyv9YPiN5Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 17:11:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HdG1fKWxQu-exyv9YPiN5Q/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 17:11:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HdG1fKWxQu-exyv9YPiN5Q/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 17:11:55 INFO - Downloaded 10840152 bytes. 17:11:55 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'] 17:11:55 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 17:11:55 INFO - Return code: 0 17:11:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:11:55 INFO - https://queue.taskcluster.net/v1/task/HdG1fKWxQu-exyv9YPiN5Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:11:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HdG1fKWxQu-exyv9YPiN5Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:11:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HdG1fKWxQu-exyv9YPiN5Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:11:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HdG1fKWxQu-exyv9YPiN5Q/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 17:11:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HdG1fKWxQu-exyv9YPiN5Q/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 17:11:57 INFO - Downloaded 54836789 bytes. 17:11:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HdG1fKWxQu-exyv9YPiN5Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:11:57 INFO - mkdir: /builds/slave/test/properties 17:11:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:11:57 INFO - Writing to file /builds/slave/test/properties/build_url 17:11:57 INFO - Contents: 17:11:57 INFO - build_url:https://queue.taskcluster.net/v1/task/HdG1fKWxQu-exyv9YPiN5Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:11:58 INFO - Running post-action listener: _resource_record_post_action 17:11:58 INFO - Running post-action listener: set_extra_try_arguments 17:11:58 INFO - ##### 17:11:58 INFO - ##### Running populate-webroot step. 17:11:58 INFO - ##### 17:11:58 INFO - Running pre-action listener: _resource_record_pre_action 17:11:58 INFO - Running main action method: populate_webroot 17:11:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:11:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:11:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:11:58 INFO - '--tppagecycles', 17:11:58 INFO - '7'], 17:11:58 INFO - 'tests': ['tsvgm']}}, 17:11:58 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:11:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:11:58 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:11:58 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:11:58 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:11:58 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:11:58 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:11:58 INFO - 'talos_options': ['--disable-e10s'], 17:11:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:11:58 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:11:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:11:58 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:11:58 INFO - 'talos_options': ['--disable-e10s'], 17:11:58 INFO - 'tests': ['damp', 'tps']}, 17:11:58 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:11:58 INFO - 'tests': ['damp', 'tps']}, 17:11:58 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:11:58 INFO - 'tests': ['dromaeo_dom']}, 17:11:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:11:58 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:11:58 INFO - 'tests': ['a11yr', 17:11:58 INFO - 'ts_paint', 17:11:58 INFO - 'tpaint', 17:11:58 INFO - 'sessionrestore', 17:11:58 INFO - 'sessionrestore_no_auto_restore', 17:11:58 INFO - 'tabpaint']}, 17:11:58 INFO - 'other-e10s': {'tests': ['a11yr', 17:11:58 INFO - 'ts_paint', 17:11:58 INFO - 'tpaint', 17:11:58 INFO - 'sessionrestore', 17:11:58 INFO - 'sessionrestore_no_auto_restore', 17:11:58 INFO - 'tabpaint']}, 17:11:58 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:11:58 INFO - 'ts_paint', 17:11:58 INFO - 'tpaint', 17:11:58 INFO - 'sessionrestore', 17:11:58 INFO - 'sessionrestore_no_auto_restore', 17:11:58 INFO - 'tabpaint']}, 17:11:58 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:11:58 INFO - 'ts_paint', 17:11:58 INFO - 'tpaint', 17:11:58 INFO - 'sessionrestore', 17:11:58 INFO - 'sessionrestore_no_auto_restore', 17:11:58 INFO - 'tabpaint']}, 17:11:58 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:11:58 INFO - 'tests': ['a11yr', 17:11:58 INFO - 'ts_paint', 17:11:58 INFO - 'tpaint', 17:11:58 INFO - 'sessionrestore', 17:11:58 INFO - 'sessionrestore_no_auto_restore', 17:11:58 INFO - 'tabpaint']}, 17:11:58 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:11:58 INFO - 'tests': ['a11yr', 17:11:58 INFO - 'ts_paint', 17:11:58 INFO - 'tpaint', 17:11:58 INFO - 'sessionrestore', 17:11:58 INFO - 'sessionrestore_no_auto_restore', 17:11:58 INFO - 'tabpaint']}, 17:11:58 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:11:58 INFO - 'tests': ['tsvgx', 17:11:58 INFO - 'tsvgr_opacity', 17:11:58 INFO - 'tart', 17:11:58 INFO - 'tscrollx', 17:11:58 INFO - 'cart']}, 17:11:58 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:11:58 INFO - 'tsvgr_opacity', 17:11:58 INFO - 'tart', 17:11:58 INFO - 'tscrollx', 17:11:58 INFO - 'cart']}, 17:11:58 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:11:58 INFO - 'talos_options': ['--disable-e10s'], 17:11:58 INFO - 'tests': ['tp5o']}, 17:11:58 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:11:58 INFO - 'tests': ['tp5o']}, 17:11:58 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:11:58 INFO - 'talos_options': ['--disable-e10s', 17:11:58 INFO - '--xperf_path', 17:11:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:11:58 INFO - 'tests': ['tp5n']}, 17:11:58 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:11:58 INFO - 'talos_options': ['--xperf_path', 17:11:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:11:58 INFO - 'tests': ['tp5n']}}, 17:11:58 INFO - 'talos.zip': {'path': '', 17:11:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:11:58 INFO - Running post-action listener: _resource_record_post_action 17:11:58 INFO - ##### 17:11:58 INFO - ##### Running create-virtualenv step. 17:11:58 INFO - ##### 17:11:58 INFO - Running pre-action listener: _resource_record_pre_action 17:11:58 INFO - Running main action method: create_virtualenv 17:11:58 INFO - Creating virtualenv /builds/slave/test/build/venv 17:11:58 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 17:11:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:11:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:11:58 INFO - Using real prefix '/usr' 17:11:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:11:58 INFO - Installing distribute.............................................................................................................................................................................................done. 17:12:00 INFO - Installing pip.................done. 17:12:00 INFO - Return code: 0 17:12:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:12:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:12:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:12:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:12:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:12:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1617e19f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d7f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e0e410>, '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 0x1e0f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e0f7a0>, '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': '5bd038846534b2fdfa68eeae000001e2-1462492486.754280-869052492', '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 17:12:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:12:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:12:00 INFO - Using env: {'DISPLAY': ':0', 17:12:00 INFO - 'HOME': '/home/cltbld', 17:12:00 INFO - 'LANG': 'en_US.UTF-8', 17:12:00 INFO - 'LANGUAGE': 'en_US:en', 17:12:00 INFO - 'LOGNAME': 'cltbld', 17:12:00 INFO - 'MAIL': '/var/mail/cltbld', 17:12:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:12:00 INFO - 'MOZ_NO_REMOTE': '1', 17:12:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:12:00 INFO - 'NO_EM_RESTART': '1', 17:12:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:12:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:12:00 INFO - 'PWD': '/builds/slave/test', 17:12:00 INFO - 'SHELL': '/bin/bash', 17:12:00 INFO - 'SHLVL': '1', 17:12:00 INFO - 'TERM': 'linux', 17:12:00 INFO - 'TMOUT': '86400', 17:12:00 INFO - 'USER': 'cltbld', 17:12:00 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1462492486.754280-869052492', 17:12:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:12:00 INFO - '_': '/tools/buildbot/bin/python'} 17:12:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:12:01 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 17:12:01 INFO - Cleaning up... 17:12:01 INFO - Return code: 0 17:12:01 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 17:12:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:12:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:12:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:12:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:12:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f1617e19f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d7f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e0e410>, '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 0x1e0f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e0f7a0>, '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': '5bd038846534b2fdfa68eeae000001e2-1462492486.754280-869052492', '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 17:12:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 17:12:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 17:12:01 INFO - Using env: {'DISPLAY': ':0', 17:12:01 INFO - 'HOME': '/home/cltbld', 17:12:01 INFO - 'LANG': 'en_US.UTF-8', 17:12:01 INFO - 'LANGUAGE': 'en_US:en', 17:12:01 INFO - 'LOGNAME': 'cltbld', 17:12:01 INFO - 'MAIL': '/var/mail/cltbld', 17:12:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:12:01 INFO - 'MOZ_NO_REMOTE': '1', 17:12:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:12:01 INFO - 'NO_EM_RESTART': '1', 17:12:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:12:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:12:01 INFO - 'PWD': '/builds/slave/test', 17:12:01 INFO - 'SHELL': '/bin/bash', 17:12:01 INFO - 'SHLVL': '1', 17:12:01 INFO - 'TERM': 'linux', 17:12:01 INFO - 'TMOUT': '86400', 17:12:01 INFO - 'USER': 'cltbld', 17:12:01 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1462492486.754280-869052492', 17:12:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:12:01 INFO - '_': '/tools/buildbot/bin/python'} 17:12:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:12:01 INFO - Downloading/unpacking psutil>=0.7.1 17:12: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 17:12: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 17:12: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 17:12: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 17:12: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 17:12: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 17:12:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:12:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:12:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:12:03 INFO - Installing collected packages: psutil 17:12:03 INFO - Running setup.py install for psutil 17:12:03 INFO - building 'psutil._psutil_linux' extension 17:12:03 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 17:12:03 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 17:12:03 INFO - building 'psutil._psutil_posix' extension 17:12:03 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 17:12:03 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 17:12:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:12:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:12:03 INFO - Successfully installed psutil 17:12:03 INFO - Cleaning up... 17:12:03 INFO - Return code: 0 17:12:03 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 17:12:03 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')]} 17:12:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:12:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:03 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')]} 17:12:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:12:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:03 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 0x7f1617e19f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d7f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e0e410>, '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 0x1e0f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e0f7a0>, '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': '5bd038846534b2fdfa68eeae000001e2-1462492486.754280-869052492', '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 17:12:03 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 17:12:03 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 17:12:03 INFO - Using env: {'DISPLAY': ':0', 17:12:03 INFO - 'HOME': '/home/cltbld', 17:12:03 INFO - 'LANG': 'en_US.UTF-8', 17:12:03 INFO - 'LANGUAGE': 'en_US:en', 17:12:03 INFO - 'LOGNAME': 'cltbld', 17:12:03 INFO - 'MAIL': '/var/mail/cltbld', 17:12:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:12:03 INFO - 'MOZ_NO_REMOTE': '1', 17:12:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:12:03 INFO - 'NO_EM_RESTART': '1', 17:12:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:12:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:12:03 INFO - 'PWD': '/builds/slave/test', 17:12:03 INFO - 'SHELL': '/bin/bash', 17:12:03 INFO - 'SHLVL': '1', 17:12:03 INFO - 'TERM': 'linux', 17:12:03 INFO - 'TMOUT': '86400', 17:12:03 INFO - 'USER': 'cltbld', 17:12:03 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1462492486.754280-869052492', 17:12:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:12:03 INFO - '_': '/tools/buildbot/bin/python'} 17:12:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:12:03 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:12:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:12:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:12:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:12:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:12:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:12:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:12:05 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:12:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:12:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 17:12:05 INFO - Installing collected packages: mozsystemmonitor 17:12:05 INFO - Running setup.py install for mozsystemmonitor 17:12:06 INFO - Successfully installed mozsystemmonitor 17:12:06 INFO - Cleaning up... 17:12:06 INFO - Return code: 0 17:12:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:12:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:12:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:12:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:12:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:12:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:06 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 0x7f1617e19f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d7f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e0e410>, '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 0x1e0f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e0f7a0>, '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': '5bd038846534b2fdfa68eeae000001e2-1462492486.754280-869052492', '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 17:12:06 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 17:12:06 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 17:12:06 INFO - Using env: {'DISPLAY': ':0', 17:12:06 INFO - 'HOME': '/home/cltbld', 17:12:06 INFO - 'LANG': 'en_US.UTF-8', 17:12:06 INFO - 'LANGUAGE': 'en_US:en', 17:12:06 INFO - 'LOGNAME': 'cltbld', 17:12:06 INFO - 'MAIL': '/var/mail/cltbld', 17:12:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:12:06 INFO - 'MOZ_NO_REMOTE': '1', 17:12:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:12:06 INFO - 'NO_EM_RESTART': '1', 17:12:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:12:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:12:06 INFO - 'PWD': '/builds/slave/test', 17:12:06 INFO - 'SHELL': '/bin/bash', 17:12:06 INFO - 'SHLVL': '1', 17:12:06 INFO - 'TERM': 'linux', 17:12:06 INFO - 'TMOUT': '86400', 17:12:06 INFO - 'USER': 'cltbld', 17:12:06 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1462492486.754280-869052492', 17:12:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:12:06 INFO - '_': '/tools/buildbot/bin/python'} 17:12:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:12:06 INFO - Downloading/unpacking blobuploader==1.2.4 17:12: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 17:12: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 17:12: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 17:12: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 17:12: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 17:12: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 17:12:08 INFO - Downloading blobuploader-1.2.4.tar.gz 17:12:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:12:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:12:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:12:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:12:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:12:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:12:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:12:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:12:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:12:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:12:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:12:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:12:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:12:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:12:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:12:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:12:08 INFO - Downloading docopt-0.6.1.tar.gz 17:12:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:12:09 INFO - Installing collected packages: blobuploader, requests, docopt 17:12:09 INFO - Running setup.py install for blobuploader 17:12:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:12:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:12:09 INFO - Running setup.py install for requests 17:12:09 INFO - Running setup.py install for docopt 17:12:09 INFO - Successfully installed blobuploader requests docopt 17:12:09 INFO - Cleaning up... 17:12:09 INFO - Return code: 0 17:12:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:12: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')]} 17:12:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:12:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12: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')]} 17:12:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:12:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:09 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 0x7f1617e19f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d7f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e0e410>, '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 0x1e0f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e0f7a0>, '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': '5bd038846534b2fdfa68eeae000001e2-1462492486.754280-869052492', '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 17:12:09 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 17:12:09 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 17:12:09 INFO - Using env: {'DISPLAY': ':0', 17:12:09 INFO - 'HOME': '/home/cltbld', 17:12:09 INFO - 'LANG': 'en_US.UTF-8', 17:12:09 INFO - 'LANGUAGE': 'en_US:en', 17:12:09 INFO - 'LOGNAME': 'cltbld', 17:12:09 INFO - 'MAIL': '/var/mail/cltbld', 17:12:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:12:09 INFO - 'MOZ_NO_REMOTE': '1', 17:12:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:12:09 INFO - 'NO_EM_RESTART': '1', 17:12:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:12:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:12:09 INFO - 'PWD': '/builds/slave/test', 17:12:09 INFO - 'SHELL': '/bin/bash', 17:12:09 INFO - 'SHLVL': '1', 17:12:09 INFO - 'TERM': 'linux', 17:12:09 INFO - 'TMOUT': '86400', 17:12:09 INFO - 'USER': 'cltbld', 17:12:09 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1462492486.754280-869052492', 17:12:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:12:09 INFO - '_': '/tools/buildbot/bin/python'} 17:12:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:12:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:12:09 INFO - Running setup.py (path:/tmp/pip-SQJKr4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:12:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:12:09 INFO - Running setup.py (path:/tmp/pip-rSYF9P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:12:10 INFO - Running setup.py (path:/tmp/pip-KhoFBW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:12:10 INFO - Running setup.py (path:/tmp/pip-UZLTCC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:12:10 INFO - Running setup.py (path:/tmp/pip-8SK876-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:12:10 INFO - Running setup.py (path:/tmp/pip-05lvre-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:12:10 INFO - Running setup.py (path:/tmp/pip-VGbRoL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:12:10 INFO - Running setup.py (path:/tmp/pip-ji6bZ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:12:10 INFO - Running setup.py (path:/tmp/pip-7lMEkD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:12:10 INFO - Running setup.py (path:/tmp/pip-OQBiwA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:12:10 INFO - Running setup.py (path:/tmp/pip-YxYY2A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:12:10 INFO - Running setup.py (path:/tmp/pip-8femRC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:12:10 INFO - Running setup.py (path:/tmp/pip-BM8gPT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:12:10 INFO - Running setup.py (path:/tmp/pip-HpvY_Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:12:10 INFO - Running setup.py (path:/tmp/pip-f5CQ7D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:12:10 INFO - Running setup.py (path:/tmp/pip-5WlZ5k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:12:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:12:11 INFO - Running setup.py (path:/tmp/pip-8RMf0y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:12:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:12:11 INFO - Running setup.py install for manifestparser 17:12:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:12:11 INFO - Running setup.py install for mozcrash 17:12:11 INFO - Running setup.py install for mozdebug 17:12:11 INFO - Running setup.py install for mozdevice 17:12:11 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:12:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:12:11 INFO - Running setup.py install for mozfile 17:12:11 INFO - Running setup.py install for mozhttpd 17:12:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:12:11 INFO - Running setup.py install for mozinfo 17:12:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:12:11 INFO - Running setup.py install for mozInstall 17:12:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:12:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:12:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:12:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:12:11 INFO - Running setup.py install for mozleak 17:12:11 INFO - Running setup.py install for mozlog 17:12:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:12:12 INFO - Running setup.py install for moznetwork 17:12:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:12:12 INFO - Running setup.py install for mozprocess 17:12:12 INFO - Running setup.py install for mozprofile 17:12:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:12:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:12:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:12:12 INFO - Running setup.py install for mozrunner 17:12:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:12:12 INFO - Running setup.py install for mozscreenshot 17:12:12 INFO - Running setup.py install for moztest 17:12:12 INFO - Running setup.py install for mozversion 17:12:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:12:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:12:12 INFO - Cleaning up... 17:12:12 INFO - Return code: 0 17:12:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:12:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:12:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:12:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:12:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:12:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:12 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 0x7f1617e19f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d7f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e0e410>, '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 0x1e0f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e0f7a0>, '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': '5bd038846534b2fdfa68eeae000001e2-1462492486.754280-869052492', '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 17:12:12 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 17:12:12 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 17:12:12 INFO - Using env: {'DISPLAY': ':0', 17:12:12 INFO - 'HOME': '/home/cltbld', 17:12:12 INFO - 'LANG': 'en_US.UTF-8', 17:12:12 INFO - 'LANGUAGE': 'en_US:en', 17:12:12 INFO - 'LOGNAME': 'cltbld', 17:12:12 INFO - 'MAIL': '/var/mail/cltbld', 17:12:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:12:12 INFO - 'MOZ_NO_REMOTE': '1', 17:12:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:12:12 INFO - 'NO_EM_RESTART': '1', 17:12:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:12:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:12:12 INFO - 'PWD': '/builds/slave/test', 17:12:12 INFO - 'SHELL': '/bin/bash', 17:12:12 INFO - 'SHLVL': '1', 17:12:12 INFO - 'TERM': 'linux', 17:12:12 INFO - 'TMOUT': '86400', 17:12:12 INFO - 'USER': 'cltbld', 17:12:12 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1462492486.754280-869052492', 17:12:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:12:12 INFO - '_': '/tools/buildbot/bin/python'} 17:12:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:12:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:12:13 INFO - Running setup.py (path:/tmp/pip-GNOtyt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:12:13 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)) 17:12:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:12:13 INFO - Running setup.py (path:/tmp/pip-DFX6DG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:12:13 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)) 17:12:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:12:13 INFO - Running setup.py (path:/tmp/pip-ZTvn3Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:12:13 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)) 17:12:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:12:13 INFO - Running setup.py (path:/tmp/pip-yPnAub-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:12:13 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)) 17:12:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:12:13 INFO - Running setup.py (path:/tmp/pip-zFVgox-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:12:13 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)) 17:12:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:12:13 INFO - Running setup.py (path:/tmp/pip-if64Nh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:12:13 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)) 17:12:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:12:13 INFO - Running setup.py (path:/tmp/pip-TAbKYV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:12:13 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)) 17:12:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:12:13 INFO - Running setup.py (path:/tmp/pip-RuEOJ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:12:13 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)) 17:12:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:12:13 INFO - Running setup.py (path:/tmp/pip-I8IfG0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:12:13 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)) 17:12:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:12:13 INFO - Running setup.py (path:/tmp/pip-7zJRSu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:12:13 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)) 17:12:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:12:13 INFO - Running setup.py (path:/tmp/pip-HlNsOF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:12:13 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)) 17:12:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:12:13 INFO - Running setup.py (path:/tmp/pip-pMeUQL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:12:13 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)) 17:12:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:12:13 INFO - Running setup.py (path:/tmp/pip-I9N0VM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:12:14 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)) 17:12:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:12:14 INFO - Running setup.py (path:/tmp/pip-7mycXw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:12:14 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)) 17:12:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:12:14 INFO - Running setup.py (path:/tmp/pip-6xIY2Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:12:14 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)) 17:12:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:12:14 INFO - Running setup.py (path:/tmp/pip-lTsPsT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:12:14 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)) 17:12:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:12:14 INFO - Running setup.py (path:/tmp/pip-_TMgs7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:12:14 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)) 17:12:14 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)) 17:12:14 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)) 17:12:14 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)) 17:12:14 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)) 17:12:14 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)) 17:12:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:12: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 17:12: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 17:12: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 17:12: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 17:12: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 17:12: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 17:12:16 INFO - Downloading blessings-1.6.tar.gz 17:12:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:12:16 INFO - Installing collected packages: blessings 17:12:16 INFO - Running setup.py install for blessings 17:12:16 INFO - Successfully installed blessings 17:12:16 INFO - Cleaning up... 17:12:16 INFO - Return code: 0 17:12:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:12:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:12:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:12:16 INFO - Reading from file tmpfile_stdout 17:12:16 INFO - Current package versions: 17:12:16 INFO - argparse == 1.2.1 17:12:16 INFO - blessings == 1.6 17:12:16 INFO - blobuploader == 1.2.4 17:12:16 INFO - docopt == 0.6.1 17:12:16 INFO - manifestparser == 1.1 17:12:16 INFO - mozInstall == 1.12 17:12:16 INFO - mozcrash == 0.17 17:12:16 INFO - mozdebug == 0.1 17:12:16 INFO - mozdevice == 0.48 17:12:16 INFO - mozfile == 1.2 17:12:16 INFO - mozhttpd == 0.7 17:12:16 INFO - mozinfo == 0.9 17:12:16 INFO - mozleak == 0.1 17:12:16 INFO - mozlog == 3.1 17:12:16 INFO - moznetwork == 0.27 17:12:16 INFO - mozprocess == 0.22 17:12:16 INFO - mozprofile == 0.28 17:12:16 INFO - mozrunner == 6.11 17:12:16 INFO - mozscreenshot == 0.1 17:12:16 INFO - mozsystemmonitor == 0.0 17:12:16 INFO - moztest == 0.7 17:12:16 INFO - mozversion == 1.4 17:12:16 INFO - psutil == 3.1.1 17:12:16 INFO - requests == 1.2.3 17:12:16 INFO - wsgiref == 0.1.2 17:12:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:12:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:12:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:12:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:12:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:12:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:16 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 0x7f1617e19f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d7f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e0e410>, '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 0x1e0f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e0f7a0>, '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': '5bd038846534b2fdfa68eeae000001e2-1462492486.754280-869052492', '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 17:12:16 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 17:12:16 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 17:12:16 INFO - Using env: {'DISPLAY': ':0', 17:12:16 INFO - 'HOME': '/home/cltbld', 17:12:16 INFO - 'LANG': 'en_US.UTF-8', 17:12:16 INFO - 'LANGUAGE': 'en_US:en', 17:12:16 INFO - 'LOGNAME': 'cltbld', 17:12:16 INFO - 'MAIL': '/var/mail/cltbld', 17:12:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:12:16 INFO - 'MOZ_NO_REMOTE': '1', 17:12:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:12:16 INFO - 'NO_EM_RESTART': '1', 17:12:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:12:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:12:16 INFO - 'PWD': '/builds/slave/test', 17:12:16 INFO - 'SHELL': '/bin/bash', 17:12:16 INFO - 'SHLVL': '1', 17:12:16 INFO - 'TERM': 'linux', 17:12:16 INFO - 'TMOUT': '86400', 17:12:16 INFO - 'USER': 'cltbld', 17:12:16 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1462492486.754280-869052492', 17:12:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:12:16 INFO - '_': '/tools/buildbot/bin/python'} 17:12:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:12:16 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)) 17:12:16 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)) 17:12:16 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)) 17:12:16 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)) 17:12:16 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)) 17:12:16 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)) 17:12:16 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)) 17:12:16 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)) 17:12:16 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)) 17:12:16 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)) 17:12:16 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)) 17:12:16 INFO - Cleaning up... 17:12:16 INFO - Return code: 0 17:12:16 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:12:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:12:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:12:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:12:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:12:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:16 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 0x7f1617e19f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d7f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e0e410>, '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 0x1e0f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e0f7a0>, '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': '5bd038846534b2fdfa68eeae000001e2-1462492486.754280-869052492', '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 17:12:16 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 17:12:16 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 17:12:16 INFO - Using env: {'DISPLAY': ':0', 17:12:16 INFO - 'HOME': '/home/cltbld', 17:12:16 INFO - 'LANG': 'en_US.UTF-8', 17:12:16 INFO - 'LANGUAGE': 'en_US:en', 17:12:16 INFO - 'LOGNAME': 'cltbld', 17:12:16 INFO - 'MAIL': '/var/mail/cltbld', 17:12:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:12:16 INFO - 'MOZ_NO_REMOTE': '1', 17:12:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:12:16 INFO - 'NO_EM_RESTART': '1', 17:12:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:12:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:12:16 INFO - 'PWD': '/builds/slave/test', 17:12:16 INFO - 'SHELL': '/bin/bash', 17:12:16 INFO - 'SHLVL': '1', 17:12:16 INFO - 'TERM': 'linux', 17:12:16 INFO - 'TMOUT': '86400', 17:12:16 INFO - 'USER': 'cltbld', 17:12:16 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1462492486.754280-869052492', 17:12:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:12:16 INFO - '_': '/tools/buildbot/bin/python'} 17:12:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:12:17 INFO - Downloading/unpacking jsonschema 17:12:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:12:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:12:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:12:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:12:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:12:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:12:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:12:19 INFO - Downloading/unpacking functools32 (from jsonschema) 17:12:19 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 17:12:19 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 17:12:19 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 17:12:19 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 17:12:19 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 17:12:19 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 17:12:19 INFO - Downloading functools32-3.2.3-2.tar.gz 17:12:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:12:19 INFO - warning: no files found matching '*.txt' 17:12:19 INFO - no previously-included directories found matching 'build' 17:12:19 INFO - no previously-included directories found matching 'dist' 17:12:19 INFO - no previously-included directories found matching '.git*' 17:12:19 INFO - Installing collected packages: jsonschema, functools32 17:12:19 INFO - Running setup.py install for functools32 17:12:19 INFO - warning: no files found matching '*.txt' 17:12:19 INFO - no previously-included directories found matching 'build' 17:12:19 INFO - no previously-included directories found matching 'dist' 17:12:19 INFO - no previously-included directories found matching '.git*' 17:12:19 INFO - Successfully installed jsonschema functools32 17:12:19 INFO - Cleaning up... 17:12:19 INFO - Return code: 0 17:12:19 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:12:19 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')]} 17:12:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:12:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:19 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')]} 17:12:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:12:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:19 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 0x7f1617e19f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d7f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e0e410>, '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 0x1e0f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e0f7a0>, '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': '5bd038846534b2fdfa68eeae000001e2-1462492486.754280-869052492', '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 17:12:19 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 17:12:19 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 17:12:19 INFO - Using env: {'DISPLAY': ':0', 17:12:19 INFO - 'HOME': '/home/cltbld', 17:12:19 INFO - 'LANG': 'en_US.UTF-8', 17:12:19 INFO - 'LANGUAGE': 'en_US:en', 17:12:19 INFO - 'LOGNAME': 'cltbld', 17:12:19 INFO - 'MAIL': '/var/mail/cltbld', 17:12:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:12:19 INFO - 'MOZ_NO_REMOTE': '1', 17:12:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:12:19 INFO - 'NO_EM_RESTART': '1', 17:12:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:12:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:12:19 INFO - 'PWD': '/builds/slave/test', 17:12:19 INFO - 'SHELL': '/bin/bash', 17:12:19 INFO - 'SHLVL': '1', 17:12:19 INFO - 'TERM': 'linux', 17:12:19 INFO - 'TMOUT': '86400', 17:12:19 INFO - 'USER': 'cltbld', 17:12:19 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1462492486.754280-869052492', 17:12:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:12:19 INFO - '_': '/tools/buildbot/bin/python'} 17:12:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:12:19 INFO - Downloading/unpacking flake8 17:12:19 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 17:12:19 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 17:12:19 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 17:12:19 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 17:12:19 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 17:12:19 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 17:12:21 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:12:21 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:12:21 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 17:12:21 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 17:12:21 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 17:12:21 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 17:12:21 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 17:12:21 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 17:12:21 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:12:21 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:12:21 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 17:12:21 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 17:12:21 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 17:12:21 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 17:12:21 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 17:12:21 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 17:12:22 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:12:22 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 17:12:22 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 17:12:22 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 17:12:22 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 17:12:22 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 17:12:22 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 17:12:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:12:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:12:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:12:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:12:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:12:22 INFO - no previously-included directories found matching 'docs/_build' 17:12:22 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:12:22 INFO - Running setup.py install for pep8 17:12:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:12:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:12:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:12:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:12:22 INFO - no previously-included directories found matching 'docs/_build' 17:12:22 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:12:22 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:12:22 INFO - Cleaning up... 17:12:22 INFO - Return code: 0 17:12:22 INFO - Running post-action listener: _resource_record_post_action 17:12:22 INFO - Running post-action listener: _start_resource_monitoring 17:12:22 INFO - Starting resource monitoring. 17:12:22 INFO - ##### 17:12:22 INFO - ##### Running install step. 17:12:22 INFO - ##### 17:12:22 INFO - Running pre-action listener: _resource_record_pre_action 17:12:22 INFO - Running main action method: install 17:12:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:12:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:12:22 INFO - Reading from file tmpfile_stdout 17:12:22 INFO - Detecting whether we're running mozinstall >=1.0... 17:12:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:12:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:12:22 INFO - Reading from file tmpfile_stdout 17:12:22 INFO - Output received: 17:12:22 INFO - Usage: mozinstall [options] installer 17:12:22 INFO - Options: 17:12:22 INFO - -h, --help show this help message and exit 17:12:22 INFO - -d DEST, --destination=DEST 17:12:22 INFO - Directory to install application into. [default: 17:12:22 INFO - "/builds/slave/test"] 17:12:22 INFO - --app=APP Application being installed. [default: firefox] 17:12:22 INFO - mkdir: /builds/slave/test/build/application 17:12:22 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'] 17:12:22 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 17:12:38 INFO - Reading from file tmpfile_stdout 17:12:38 INFO - Output received: 17:12:38 INFO - /builds/slave/test/build/application/firefox/firefox 17:12:38 INFO - Running post-action listener: _resource_record_post_action 17:12:38 INFO - ##### 17:12:38 INFO - ##### Running run-tests step. 17:12:38 INFO - ##### 17:12:38 INFO - Running pre-action listener: _resource_record_pre_action 17:12:38 INFO - Running main action method: run_tests 17:12:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:12:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:12:38 INFO - Python 2.7.3 17:12:38 INFO - Return code: 0 17:12:38 INFO - grabbing minidump binary from tooltool 17:12: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')]} 17:12:38 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 0x1e0e410>, '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 0x1e0f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e0f7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:12:38 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 17:12:38 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 17:12:38 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:12:38 INFO - Return code: 0 17:12:38 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:12:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:12:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:12:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:12:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:12:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:12:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:12:39 INFO - Return code: 0 17:12:39 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/HdG1fKWxQu-exyv9YPiN5Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--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 17:12:39 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/HdG1fKWxQu-exyv9YPiN5Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-039 --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 17:12:39 INFO - Using env: {'DISPLAY': ':0', 17:12:39 INFO - 'HOME': '/home/cltbld', 17:12:39 INFO - 'LANG': 'en_US.UTF-8', 17:12:39 INFO - 'LANGUAGE': 'en_US:en', 17:12:39 INFO - 'LOGNAME': 'cltbld', 17:12:39 INFO - 'MAIL': '/var/mail/cltbld', 17:12:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:12:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:12:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:12:39 INFO - 'MOZ_NO_REMOTE': '1', 17:12:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:12:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:12:39 INFO - 'NO_EM_RESTART': '1', 17:12:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:12:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:12:39 INFO - 'PWD': '/builds/slave/test', 17:12:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:12:39 INFO - 'SHELL': '/bin/bash', 17:12:39 INFO - 'SHLVL': '1', 17:12:39 INFO - 'TERM': 'linux', 17:12:39 INFO - 'TMOUT': '86400', 17:12:39 INFO - 'USER': 'cltbld', 17:12:39 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1462492486.754280-869052492', 17:12:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:12:39 INFO - '_': '/tools/buildbot/bin/python'} 17:12:39 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/HdG1fKWxQu-exyv9YPiN5Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--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 17:12:39 INFO - mozversion application_buildid: 20160505165542 17:12:39 INFO - mozversion application_changeset: 8000d7a6ff44b128850bd4d08e0d1867f6df557d 17:12:39 INFO - mozversion application_display_name: Nightly 17:12:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:12:39 INFO - mozversion application_name: Firefox 17:12:39 INFO - mozversion application_remotingname: firefox 17:12:39 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:12:39 INFO - mozversion application_vendor: Mozilla 17:12:39 INFO - mozversion application_version: 49.0a1 17:12:39 INFO - mozversion platform_buildid: 20160505165542 17:12:39 INFO - mozversion platform_changeset: 8000d7a6ff44b128850bd4d08e0d1867f6df557d 17:12:39 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:12:39 INFO - mozversion platform_version: 49.0a1 17:12:39 INFO - using testdate: 1462493559 17:12:39 INFO - actual date: 1462493559 17:12:39 INFO - starting webserver on 'localhost:59718' 17:12:39 INFO - SUITE-START | Running 2 tests 17:12:39 INFO - TEST-START | dromaeo_css 17:12:39 INFO - operating with platform_type : linux_ 17:12:39 INFO - Initialising browser for dromaeo_css test... 17:12:39 INFO - TEST-INFO | started process 10913 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4UQdXQ/profile http://localhost:59718/getInfo.html) 17:12:44 INFO - PROCESS | 10913 | __metrics Screen width/height:1600/1200 17:12:44 INFO - PROCESS | 10913 | colorDepth:24 17:12:44 INFO - PROCESS | 10913 | Browser inner width/height: 1024/697 17:12:44 INFO - PROCESS | 10913 | __metrics 17:12:45 ERROR - PROCESS | 10913 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 17:12:46 INFO - TEST-INFO | 10913: exit 0 17:12:46 INFO - Browser initialized. 17:12:46 INFO - Running cycle 1/1 for dromaeo_css test... 17:12:46 INFO - TEST-INFO | started process 10995 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4UQdXQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:12:58 INFO - PROCESS | 10995 | RSS: Main: 154566656 17:12:58 INFO - PROCESS | 10995 | 17:13:50 INFO - PROCESS | 10995 | 1462493630118 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] 17:16:01 INFO - PROCESS | 10995 | Cycle 1(1): loaded http://localhost:59718/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59718/tests/dromaeo/cssquery-ext.html) 17:16:02 INFO - PROCESS | 10995 | RSS: Main: 247607296 17:16:02 INFO - PROCESS | 10995 | 17:19:05 INFO - PROCESS | 10995 | Cycle 1(1): loaded http://localhost:59718/tests/dromaeo/cssquery-ext.html (next: http://localhost:59718/tests/dromaeo/cssquery-jquery.html) 17:19:06 INFO - PROCESS | 10995 | RSS: Main: 240640000 17:19:06 INFO - PROCESS | 10995 | 17:22:08 INFO - PROCESS | 10995 | Cycle 1(1): loaded http://localhost:59718/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59718/tests/dromaeo/cssquery-mootools.html) 17:22:09 INFO - PROCESS | 10995 | RSS: Main: 243281920 17:22:09 INFO - PROCESS | 10995 | 17:25:11 INFO - PROCESS | 10995 | Cycle 1(1): loaded http://localhost:59718/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59718/tests/dromaeo/cssquery-prototype.html) 17:25:11 INFO - PROCESS | 10995 | RSS: Main: 234704896 17:25:11 INFO - PROCESS | 10995 | 17:28:14 INFO - PROCESS | 10995 | Cycle 1(1): loaded http://localhost:59718/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59718/tests/dromaeo/cssquery-yui.html) 17:28:15 INFO - PROCESS | 10995 | RSS: Main: 210726912 17:28:15 INFO - PROCESS | 10995 | 17:31:18 INFO - PROCESS | 10995 | Cycle 1(1): loaded http://localhost:59718/tests/dromaeo/cssquery-yui.html (next: http://localhost:59718/tests/dromaeo/cssquery-dojo.html) 17:31:18 INFO - PROCESS | 10995 | RSS: Main: 269615104 17:31:18 INFO - PROCESS | 10995 | 17:31:18 INFO - PROCESS | 10995 | __start_tp_report 17:31:18 INFO - PROCESS | 10995 | _x_x_mozilla_page_load 17:31:18 INFO - PROCESS | 10995 | _x_x_mozilla_page_load_details 17:31:18 INFO - PROCESS | 10995 | |i|pagename|runs| 17:31:18 INFO - PROCESS | 10995 | |0;dojo.html;2697.635819164412;2699.9460010799785;2738.5070687276284;2745.327394788276;2773.875175617097;4650.325702773096;4699.0836786826585;4750.121227572897;4857.95142048579;4890.510948905107;4662.184117779392;4697.506761790014;4750.76246187691;4796.4244290685165;4811.085893680199;4274.572542745732;4319.71921825082;4358.8474403395885;4384.18892504886;4504.324351347292;4427.2695005324085;4439.933400998972;4457.84397546086;4485.0132970746545;4485.035717320776;4270.530241673413;4318.805653745558;4354.499232588261;4376.168527979674;4392.011797345604;4277.700560960734;4294.098239369736;4300.526942036374;4329.805158767863;4340.392345071693;4318.82724691012;4322.265214913441;4335.826566937319;4342.50061242958;4370.497392799837;4497.347884556721;4626.259798432268;4627.953720462786;4676.953230467686;4692.296155576657;5122.795088196468;5157.974210128926;5183.637145399824;5183.766730497136;5188.662736922126;5147.459516750725;5157.819476318311;5171.146760784466;5173.870653233662;5213.895722085575;4621.768911554443;4713.057388522241;4736.360591320196;4738.218193998021;4814.20565606671;5192.143296356135;5227.843164705065;5232.973835130876;5260.658057226268;5264;4917.65576409655;5021.949780502221;5070.8225212117395;5071.923921141186;5072.6195535335;5076.111680455905;5122.718250496184;5131.204663277198;5179.507946745129;5179.792808287626;5089.3638295213095;5091.694498330112;5093.719845408538;5095.388553373545;5147.073526765218;5071.568916642127;5073.670211436245;5075.187969924795;5076.060928728197;5083.7203953782155;4231.703780735381;4264;4271.850485233002;4321.67587430944;4329.350597410414;3800.239952009609;3828.2917660232947;3838.7504812187676;3839.462475253467;3841.769493830379;4335.176316499855;4358.5205627380965;4365.781710914442;4392.4289842320295;4432.667549933768;5045.747712614355;5049.823256186016;5100.209467532539;5106.15748401517;5149.588032957355;4209.684273679486;4315.482142142963;4327.156204540147;4337.587929146726;4382.145481631115;4602.861914142581;4652.302154676758;4655.301704744248;4678.994016286447;4703.929441058387;4832.661713680009;4840.661153719347;4842.757862106881;4845.612351011981;4888.682235654742;4908.852734417973;5012.3233363495465;5144.76848541824;5160.896782064413;5212.687238765686;4726.858194254178;4740.454847692559;4755.785989630405;4767.237242041396;4811.687240329367;4966.304717339648;4978;4979.925301120414;4987.326710893983;5040.117979353672;4944;4967.205247160437;4973.626977976739;5055.266986287042;5096.929644774639;4830.830920917751;4848.32123502717;4864.586510146536;4894.167991441393;4903.387076615423;4862.975685121552;4871.707697538159;4875.293082502946;4880.707157570557;4938.48145944685;4767.713937163781;4799.856004319876;4851.151048566558;4902.803887844446;4903.4606193317995;5000.949990500194;5016.046951079284;5021.899562008813;5071.036503064406;5071.2139618359215;4904.926426103682;4908.7300198488;4923.187674033744;4931.087748766489;4976.402831660224 17:31:18 INFO - PROCESS | 10995 | |1;ext.html;559.56074481532;591.9615225010375;595.7765837810823;596.8179705189915;603.1616053685377;26954.73045269547;40928.79535602325;42318.36522452158;42509.14981700368;47051.52948470514;42706;42872.142557148916;43254;43319;43320.13359732804;7440.66517006736;7886.250806173404;8007.399445041616;8026.157253488358;9932.851007234898;9749.463779492125;10148.695539133802;10150.898491015068;10151.035651613085;10155.187584993182;10151.289409741321;10221;10229.846552301722;10230.948845255763;10231.437270950095;7579.62101894903;7743.380529557622;7743.612819359066;9984.101430871257;10111.292209545334;9782.853257201148;10100.646477373257;10103.646372377005;10111.140553053;10116.94941525295;38032.61967380319;38468.80765596182;38739.03152421184;38756.80621596902;38828;3114;3116.9532457013165;3159.842007899596;3206.9839650801596;3440.673136052071;29380.559291610643;29393;29560.40879182426;29630.88266755569;30000.249993750112;3000.7599392048583;3012.171652795477;3035.134986528829;3049.5120780675206;3061.6172978377704;258112.18878112227;258368;259314;259546;260054;33955.66044339575;55644.443555564736;56119.43880561224;56450.71774641101;56522.71738641363;34341.31317373688;36340;36371.4544281836;36381.45427818585;36387.09032274161;14157.292135393189;14373.496927607694;14390.784138237936;14397.136171829723;14400.42398304056;10025.699229023141;11782.587609433629;11938.880611193777;11948.402579870972;12180.512779488898;8368.623411946477;8371.079181290053;8400.663973441116;8458.069612342637;8458.74623761288;2686.4358484718427;2699.5545734953907;2723.183045086506;2724.0738149029426;2736.0423851652163;855.4525103933488;931.4923366765129;1022.2282176956498;1036.533559898049;1054.2198772907993;28936.565951510744;28999.42001159965;29210.620954207385;29266.85366573196;29489.262768430533;1038.948052597367;1061.1669839176209;1061.7611037516651;1089.3082892363407;1174.2191442690514;15307.46423875159;15564.143972081418;15567;15705.371785128695;15856.762148567781;369873;373089;373106;373557;374167;51222.23166652503;51923.48076519262;52011;52088.73955630273;52091;1161.5644133449957;1260.974780504403;1279.2772083772638;1300.921944683322;1312.1143228320655;28565.714342856307;30026.39947201;30480.84759576188;30720.84639576788;30828.383432331677;49236;51523.227151593506;51559.48440515547;57508;57637.71181144068;310250;316905;317306;317834;318242;34784.30431391409;35444.46833297451;35690.821545892104;35724.28551429009;38738.225235495695;39238.607613923494;44000.55999439965;44523.55476445194;44960.77519612381;45086.32370514511;36087.63912360843;38269.4259586112;38567.614323857524;38667.41998869963;38948.61051389563;36136;37912;38099.23801523899;38179.236415270985;38219;36471;37558.43662345122;37721.434178486794;37858.81070594629;38251.80874095612;32573;33452.66547334593;33889.322213556086;34417.31165376728;34417.65582344145;26016.34959125961;26157.607635885095;26249.4750104993;26285.605715913895;26575.202743917715 17:31:18 INFO - PROCESS | 10995 | |2;jquery.html;375.11472923899595;380.5794596970346;384.32742700274514;389.51310861423224;392.96659783918363;15834.604134896634;17368;17915.283388664455;18037.18832652532;18057.00686462244;15355.462558810445;15360.769588456182;16207.108609026529;16218.405055191171;16242;4620.999999999992;4732.526747325274;4773.856784296477;4800.3279540864305;4803.759812009403;3310.78479898807;5111.693298402108;5384.91922621159;5401.27082843815;5459.563234941215;5425.7287135643255;5442.700651464168;5446.891062178754;5462.562994960414;5467.6719396836115;5005.174146265862;5366.517013468768;5380.784768609251;5443.618946673734;5450.809221677222;3309.5697559317377;4868.123737727207;5210.088234558937;5212.035773381936;5235.136202526579;19817.60364792696;20015.1993920243;20025.79974200254;20530.589388212153;20534.5893082139;1863.3757691173473;1886.9056547172586;1954.6677064898859;1959.5101224693826;1975.9012049397616;8592.226699597066;8780.121987801233;8849.380543361967;9137.862932056025;9192.678256260999;1626.479526551504;1705.1985566783592;1794.5423916901236;1825.3246298869371;1832.688442964686;69954.65022674904;71114.64442677805;71564.62041191562;71670.64164679247;74097.6295118521;9689.612415503301;9963.302568820112;10097.343672661253;10201.591936322464;10231.897681023243;13835.100718453268;14001.85998140026;14004.719905602034;14010.649733756738;14017.929910350384;7526.435517336222;7554.584497852561;7637.770866874002;7654.272844079804;7723.343515801107;7335.303146201102;7354.521956072838;7483.476156668981;7527.134379546313;7533.020707308015;4277.1873344064525;4370.2570563004365;4409.669274804402;4434.091011342667;4478.977605111953;1637.909914954665;1697.2871394014544;1706.6927952968585;1736.6266252755465;1768.522498925283;806.8345989072343;875.5884734174928;891.0866361978893;964.5273815830193;1012.018342208057;16049.59876003086;16952.915235423745;16994.32022719102;17011.4053740576;17311.3941012064;897.6544030548285;897.708244820436;945.4469135555777;953.1802649721234;980.9509524523745;9544.95227523858;9560.61757529691;9659.292411126773;9703.466309352913;9876.851847222297;380151;386304;386691;386741;395455;78227;79594.20405795868;79929.60035199787;80240.59879700564;80551;950.9286803489766;986.2504496582505;993.036754348281;993.1905497019906;998.9850152247722;14689.338979746151;14930.402783888523;15006.324715388053;15015.474458393905;15315.61710957235;25096.24711258665;26042.73957260403;30330.241743956576;34407.82796086104;35670.82164589161;47968;48395;48399;48518;48562.27156592724;7587.886181707168;7641.847163056596;7657.0811502620045;7727.42044346665;7732.188120247518;10617.575296988034;10807.135429165804;10905.127589792639;11191.552337906392;11431.314121152758;9323.347365684609;9379.484128372733;9637.855432168382;9824.55789489489;9853.359531630422;7895.460385224826;9533.854882651349;9783.755406114904;10104.191664666956;10164.44095574721;9656.32405731592;10007.949960250153;10084.092431681183;10116.898831011596;10216.744581385525;7399.630018499161;7401.740939067106;7478.887816682863;7559.848803024019;7688.154303026551;9631.08504692053;9827.950860245654;9868.358556694078;10038.799224015625;10124.544395502073 17:31:18 INFO - PROCESS | 10995 | |3;mootools.html;1263.6461790698609;1522.6802371501983;1541.3064121145485;1746.4935168801048;1892.403892773777;7255.528390654604;7498.662560184791;7508.587027713474;7514.81212969676;7666.271704188107;7211.927880721191;7427.814304642373;7595.620218989042;7596.582187979659;7603.315701586856;2172.945676358088;2250.932472025842;2251.5722012817596;2252.40311317501;2257.7064981552458;2195.6047911375945;2236.2620335289316;2241.1035585765662;2242.887855607213;2245.5845668551287;2148.430665873545;2163.048258766146;2175.695402643631;2182.050807898569;2195.7365116186;2124.925627603034;2137.5190582119053;2143.014213461802;2144.2709478777215;2144.656854903208;2168.186929901287;2196.626573482496;2199.7690242524463;2200.7469141048664;2201.8018378345864;7211.711531538732;7371.37343325818;7587.886181707278;7635.847283054308;7659.7319093832;4310.245707001262;4382.035952090535;4384.7369157850635;4387.736735795863;4405.22908491016;2762.7651649609807;2777.3056735816044;2809.311718628949;2814.6481689788775;2896;886.5124181700039;891.6255172827427;917.0508523677961;935.2658163341812;964.7636329099346;9996.800063998751;10253.948730256376;10256;10288.69133925976;10307.433091179983;4126.236646220459;4223.429836972031;4233.322668373045;4309.332053531708;4315.568443155659;9011.594478248495;9098.363114581916;9104.635814567344;9107.043760405195;9107.089291070972;4516.909661806745;4534.954650453519;4543.091381723669;4545.38637283969;4553.931691024637;3453.671901169385;4021.1153546219784;4158.251514727318;4182.372644103409;4264.744115353089;3672.1186915140706;3713.795741234258;3784.7161462890394;3791.374423220138;3824.4454554089502;1165.1610840195046;1193.164784650748;1206.2882899089404;1218.3786269002694;1232.6979889926845;769.707511145761;876.4828751036919;917.9632814687471;922.9676961306322;927.3937856689928;5236.214567814858;5251.6061295403;5332.680039197583;5347.839564813062;5388.515033646991;396.1423518083375;937.0629370629371;943.2077055273465;1022.3610243597751;1041.796849614333;3668.614795446493;3688.6495782900583;3735.3649879520003;3735.869244576481;3830.693544516432;9170.08299170091;9589.472579008081;9603.807923841623;9621.759456013655;9676.032396760267;8759.474431534129;9436.575354109082;9566.234701223886;9580.377275477073;9592.472414017297;7108.928910710827;7266.564006159648;7281.854362912712;7389.187189409161;7392.334689877936;5288.9735551322;5424;5518.668879867221;5572.554195664418;5698.344690360662;8373.33013358942;8409.075001749681;8554.657813687632;8605.397622166389;8614.396992210484;8749.562521874008;8846;8868.201861832466;8906.599203036008;8965.731028069169;5858.531317494505;6280.717367718372;6456.741730330734;6540.771073012422;6718.428933540704;7344.48588598793;7373.262673732584;7399.8150046249275;7424.331810137113;7430.3684186842565;6619.50353723463;6744.763933262312;6771.932280677327;6838.555493892881;6845.863082738417;6638.9668051661365;6642.900356494753;6668.599884006975;6714.362135597111;6776.932230677828;6214.627122372672;6225.906611400742;6296.905546416899;6301.054841773771;6302.432781049728;4722.456917454537;4745.169595320874;4827.300041493893;4831.9275210871165;4852.1508735971765;4794.664373493822;4818.71087734737;4840.467548569725;4905.166121759238;4929.704217746947 17:31:18 INFO - PROCESS | 10995 | |4;prototype.html;291.2921600510758;293.470286133529;298.5298155405237;303.6204744069913;303.6978206684348;4788.976055119724;4810.567048965592;4813.422389313283;4844.563989240967;4901.166801643721;4780.211265141247;4788.952110478895;4818.445878723948;4824.565789078983;4833.468318484964;3577.209776374419;3687.612800655933;3733.1040550268012;3787.3561494545993;3823.9426408603895;3787.905302367449;3793.9241215175816;3813.31360355136;3823.808809559525;3844.461775351453;3568.6788189062977;3762.830672619725;3765.2469506098755;3789.2610940866543;3803.4484999675033;3717.8326975286177;3760.435934609803;3774.622537746231;3779.244151169777;3786.659200671953;3341.231516751161;3341.63242043375;3344.6488118747666;3347;3351.631320554737;4620.914085189977;4623.8209256639675;4632.837850675244;4639.559241872017;4646.512116227781;4219.135077309175;4280.700350975433;4281.100968796556;4316.805743741539;4368.825246990116;5012.298278241049;5039.748012599355;5044.445111037783;5058.1537738725465;5059.772310246048;3611.765235259726;3613.1870329175986;3624.4563315502623;3631.6005239423644;3636.254567813592;4994.925076123861;5301.151815709468;5316.3354580677415;5321.201819727072;5337;3554.87557935471;3555.1823080691584;3558.09268636496;3567.090391950036;3571.2143328467696;3616.4213725803747;3620.2759448110482;3623.166671665532;3623.3477973964414;3639.4358874374516;4177;4234.534201237861;4237.940514871282;4241.031278105339;4247.426597409372;4809.567138957511;5031.735718926498;5039.874003149877;5060.873478163076;5098.643094983389;1218.8171774233936;1223.8409006829056;1228;1232.8150777383464;1234.950601975911;777.0908037596026;808.7343307723512;831.3723139030114;833.9874901876477;840.878072679458;4343.893211792279;4344.826206951687;4345.543717909637;4346.891327716832;4362.367456718758;5052.56002039417;5057.873553161126;5058.849988754764;5082.974585127051;5119.210030533368;4164.104717485695;4212.136512015029;4320.65434765218;4321.870343889688;4341.739495630272;2662.8002899782596;2668.893244270246;2671.452352267819;2685.6374389457565;2696.555068413729;4783.928241076386;4784.564630610803;4798.328234047236;4801.51984801517;4813.253945638362;4891.461939186686;5142.871428214325;5152.871178220499;5156.143788236232;5174.31834653739;4744.881377965578;4775.445136851837;4778.689385189951;4797.040591881638;4802.567768900815;4990.6506544541535;5068.391792984866;5069.9746501267255;5070.847874563769;5092.541671249605;4797.856064318076;4954.696066329174;4968.552830245295;4970.850874473772;5145.768440420115;4989.151844186425;4995.350604421547;4996.750162491933;5002.2496625506465;5027.64806463544;3663.3405986922608;3674.118211629136;3681.5950245473514;3685.7972811495624;3692.9446058309686;5072.82245121419;5266.368035835724;5291.206319052173;5305.363356397257;5324.61559994412;5050.671706339076;5058.924116138334;5097.158968770112;5098.745062746922;5114.309568208244;5053.418856831365;5075.949240507695;5077.1876499759865;5099.6685215460875;5133.2300154975555;4792.2092854678585;5018.573421259088;5030.723310217973;5048.7728052237;5058.468860769566;4926.285688575208;4993;5126.564242039469;5135.281060651587;5136.666116702402;4999.925001124913;5016.974915125401;5033.697978121324;5035.697858128524;5041.974790126026 17:31:18 INFO - PROCESS | 10995 | |5;yui.html;698.6087790837131;793.3018943329869;797.1988151907336;798.7603718884333;803.3332334162644;10691.83962240567;10704.036636702695;10767.138628909688;10779.08377787888;12405.131640785148;11810.58662946797;11832.40837958103;11838.7632247355;11853.7629247415;11868.821967670492;667.4726965697093;829.9626516806758;859.2438653984485;863.1023735315265;871.7864123289803;849.6346570974479;851.0340763233743;854.6752234151045;856.4518708026836;856.4946681457939;920.769807548113;921.3642586615248;921.755734730297;922.197688011431;922.5295099499236;704.3766266853845;861.3625916821507;903.6295119001244;903.814717982812;917.9724608261763;667.1893649216225;669.6082791566939;670.0552221367897;671.7380221713536;672.2034389248756;12017;12025.579104731292;12048.638540843702;12052.156349055569;12061.396930153458;11759.588414405454;11902.34537100459;12001.279923204636;12177.208481448677;12410.007199424024;10580.629677961235;10705.678829635124;10798.352098874015;10895.673129806119;11038.44807759617;4085.6935729820384;4130.56629053948;4136.379543068534;4177.707560470768;4225.176090662322;43698.781506092586;43787.562124378666;44061;44139;44163.11673766539;9413.670521531714;9820.901790982141;10156.187504999582;10232.437215953045;10264.692059238234;15968.520944371456;16978.405755798736;17014.659706806044;17020.48938531846;17034.14829258532;6618.503612229102;6652.534322597372;6679.76620818269;6735.8989615155815;6827.69275382609;3676.742628016013;3722.8324725387424;3744.1575645479547;3760.304343696425;3872.1481274119647;2695.056730144434;2764.847933363644;2766.1839757271655;2766.847823369734;2768.169549135251;465.77875509133565;494.5598417408509;511.22038890691994;523.0402211941131;526.7576914619318;505.3935277666741;534.121370345779;556.4546744190716;632.2065807411669;634.1502386801708;7519.285667861544;7835.960820195863;7840.725574604861;7861.449698521049;8080.797980050428;517.6298946253447;590.099225928658;622.4900595187893;632.6488798716664;646.4634353486595;3507.309789214191;3577.606463289036;3625.3655610268097;3675.3016926783826;3762.266358060152;52879.47120528745;53327.466725333026;53674;53852.730736346064;54108.45891541113;48251.75874120607;49333.50666493361;50365.496345036816;50584.494155057975;50935.7453212739;40317.39523907085;43123.13753724908;43265.783671081444;44187.337189942176;44605.985461308635;7644.847103058019;7793.298603125746;7980;8047.798805029687;8078.515289082674;29443.263918401353;29550.55674164932;29723.70276297296;30118.69881301159;30189.547156793105;35268.823655881555;37115.81442092772;37773.81113094417;38269.617303826606;38415.807920960215;11039.260740748145;11254;11289.830652540382;11321.660350189508;11331.943340283246;10620.415877126832;10778;11134;11193.328400296008;11394.601188958346;10474.476276186313;10519.894801052198;11009.559617615205;11467.483963221508;11657.941710291394;10623.681289561326;10809.459527023775;10885.836712449161;11148.386838723947;11319.151063670422;9942;10776.137908967421;10964.122870170208;11045.94477027642;11540.134489913122;9361.81276374455;9388.202002829836;9758.072983066597;9995.100440960348;10264.435456049989;8738.169873861973;8852.911470885208;9331;9414.462696612518;9519.333646644669 17:31:18 INFO - PROCESS | 10995 | __end_tp_report 17:31:18 INFO - PROCESS | 10995 | __start_cc_report 17:31:18 INFO - PROCESS | 10995 | _x_x_mozilla_cycle_collect,935 17:31:18 INFO - PROCESS | 10995 | __end_cc_report 17:31:18 INFO - PROCESS | 10995 | __startTimestamp1462494678391__endTimestamp 17:31:18 INFO - PROCESS | 10995 | 17:31:18 INFO - PROCESS | 10995 | ------- Summary: start ------- 17:31:18 INFO - PROCESS | 10995 | Number of tests: 6 17:31:18 INFO - PROCESS | 10995 | 17:31:18 INFO - PROCESS | 10995 | [#0] dojo.html Cycles:165 Average:4701.44 Median:4840.66 stddev:488.18 (10.1%) stddev-sans-first:463.68 17:31:18 INFO - PROCESS | 10995 | Values: 2697.6 2699.9 2738.5 2745.3 2773.9 4650.3 4699.1 4750.1 4858.0 4890.5 4662.2 4697.5 4750.8 4796.4 4811.1 4274.6 4319.7 4358.8 4384.2 4504.3 4427.3 4439.9 4457.8 4485.0 4485.0 4270.5 4318.8 4354.5 4376.2 4392.0 4277.7 4294.1 4300.5 4329.8 4340.4 4318.8 4322.3 4335.8 4342.5 4370.5 4497.3 4626.3 4628.0 4677.0 4692.3 5122.8 5158.0 5183.6 5183.8 5188.7 5147.5 5157.8 5171.1 5173.9 5213.9 4621.8 4713.1 4736.4 4738.2 4814.2 5192.1 5227.8 5233.0 5260.7 5264.0 4917.7 5021.9 5070.8 5071.9 5072.6 5076.1 5122.7 5131.2 5179.5 5179.8 5089.4 5091.7 5093.7 5095.4 5147.1 5071.6 5073.7 5075.2 5076.1 5083.7 4231.7 4264.0 4271.9 4321.7 4329.4 3800.2 3828.3 3838.8 3839.5 3841.8 4335.2 4358.5 4365.8 4392.4 4432.7 5045.7 5049.8 5100.2 5106.2 5149.6 4209.7 4315.5 4327.2 4337.6 4382.1 4602.9 4652.3 4655.3 4679.0 4703.9 4832.7 4840.7 4842.8 4845.6 4888.7 4908.9 5012.3 5144.8 5160.9 5212.7 4726.9 4740.5 4755.8 4767.2 4811.7 4966.3 4978.0 4979.9 4987.3 5040.1 4944.0 4967.2 4973.6 5055.3 5096.9 4830.8 4848.3 4864.6 4894.2 4903.4 4863.0 4871.7 4875.3 4880.7 4938.5 4767.7 4799.9 4851.2 4902.8 4903.5 5000.9 5016.0 5021.9 5071.0 5071.2 4904.9 4908.7 4923.2 4931.1 4976.4 17:31:18 INFO - PROCESS | 10995 | 17:31:18 INFO - PROCESS | 10995 | [#1] ext.html Cycles:180 Average:47627.00 Median:34148.49 stddev:83906.43 (245.7%) stddev-sans-first:84067.39 17:31:18 INFO - PROCESS | 10995 | Values: 559.6 592.0 595.8 596.8 603.2 26954.7 40928.8 42318.4 42509.1 47051.5 42706.0 42872.1 43254.0 43319.0 43320.1 7440.7 7886.3 8007.4 8026.2 9932.9 9749.5 10148.7 10150.9 10151.0 10155.2 10151.3 10221.0 10229.8 10230.9 10231.4 7579.6 7743.4 7743.6 9984.1 10111.3 9782.9 10100.6 10103.6 10111.1 10116.9 38032.6 38468.8 38739.0 38756.8 38828.0 3114.0 3117.0 3159.8 3207.0 3440.7 29380.6 29393.0 29560.4 29630.9 30000.2 3000.8 3012.2 3035.1 3049.5 3061.6 258112.2 258368.0 259314.0 259546.0 260054.0 33955.7 55644.4 56119.4 56450.7 56522.7 34341.3 36340.0 36371.5 36381.5 36387.1 14157.3 14373.5 14390.8 14397.1 14400.4 10025.7 11782.6 11938.9 11948.4 12180.5 8368.6 8371.1 8400.7 8458.1 8458.7 2686.4 2699.6 2723.2 2724.1 2736.0 855.5 931.5 1022.2 1036.5 1054.2 28936.6 28999.4 29210.6 29266.9 29489.3 1038.9 1061.2 1061.8 1089.3 1174.2 15307.5 15564.1 15567.0 15705.4 15856.8 369873.0 373089.0 373106.0 373557.0 374167.0 51222.2 51923.5 52011.0 52088.7 52091.0 1161.6 1261.0 1279.3 1300.9 1312.1 28565.7 30026.4 30480.8 30720.8 30828.4 49236.0 51523.2 51559.5 57508.0 57637.7 310250.0 316905.0 317306.0 317834.0 318242.0 34784.3 35444.5 35690.8 35724.3 38738.2 39238.6 44000.6 44523.6 44960.8 45086.3 36087.6 38269.4 38567.6 38667.4 38948.6 36136.0 37912.0 38099.2 38179.2 38219.0 36471.0 37558.4 37721.4 37858.8 38251.8 32573.0 33452.7 33889.3 34417.3 34417.7 26016.3 26157.6 26249.5 26285.6 26575.2 17:31:18 INFO - PROCESS | 10995 | 17:31:18 INFO - PROCESS | 10995 | [#2] jquery.html Cycles:180 Average:23987.74 Median:48397.00 stddev:64021.71 (132.3%) stddev-sans-first:64176.76 17:31:18 INFO - PROCESS | 10995 | Values: 375.1 380.6 384.3 389.5 393.0 15834.6 17368.0 17915.3 18037.2 18057.0 15355.5 15360.8 16207.1 16218.4 16242.0 4621.0 4732.5 4773.9 4800.3 4803.8 3310.8 5111.7 5384.9 5401.3 5459.6 5425.7 5442.7 5446.9 5462.6 5467.7 5005.2 5366.5 5380.8 5443.6 5450.8 3309.6 4868.1 5210.1 5212.0 5235.1 19817.6 20015.2 20025.8 20530.6 20534.6 1863.4 1886.9 1954.7 1959.5 1975.9 8592.2 8780.1 8849.4 9137.9 9192.7 1626.5 1705.2 1794.5 1825.3 1832.7 69954.7 71114.6 71564.6 71670.6 74097.6 9689.6 9963.3 10097.3 10201.6 10231.9 13835.1 14001.9 14004.7 14010.6 14017.9 7526.4 7554.6 7637.8 7654.3 7723.3 7335.3 7354.5 7483.5 7527.1 7533.0 4277.2 4370.3 4409.7 4434.1 4479.0 1637.9 1697.3 1706.7 1736.6 1768.5 806.8 875.6 891.1 964.5 1012.0 16049.6 16952.9 16994.3 17011.4 17311.4 897.7 897.7 945.4 953.2 981.0 9545.0 9560.6 9659.3 9703.5 9876.9 380151.0 386304.0 386691.0 386741.0 395455.0 78227.0 79594.2 79929.6 80240.6 80551.0 950.9 986.3 993.0 993.2 999.0 14689.3 14930.4 15006.3 15015.5 15315.6 25096.2 26042.7 30330.2 34407.8 35670.8 47968.0 48395.0 48399.0 48518.0 48562.3 7587.9 7641.8 7657.1 7727.4 7732.2 10617.6 10807.1 10905.1 11191.6 11431.3 9323.3 9379.5 9637.9 9824.6 9853.4 7895.5 9533.9 9783.8 10104.2 10164.4 9656.3 10007.9 10084.1 10116.9 10216.7 7399.6 7401.7 7478.9 7559.8 7688.2 9631.1 9828.0 9868.4 10038.8 10124.5 17:31:18 INFO - PROCESS | 10995 | 17:31:18 INFO - PROCESS | 10995 | [#3] mootools.html Cycles:180 Average:5089.60 Median:5340.26 stddev:2780.98 (52.1%) stddev-sans-first:2773.91 17:31:18 INFO - PROCESS | 10995 | Values: 1263.6 1522.7 1541.3 1746.5 1892.4 7255.5 7498.7 7508.6 7514.8 7666.3 7211.9 7427.8 7595.6 7596.6 7603.3 2172.9 2250.9 2251.6 2252.4 2257.7 2195.6 2236.3 2241.1 2242.9 2245.6 2148.4 2163.0 2175.7 2182.1 2195.7 2124.9 2137.5 2143.0 2144.3 2144.7 2168.2 2196.6 2199.8 2200.7 2201.8 7211.7 7371.4 7587.9 7635.8 7659.7 4310.2 4382.0 4384.7 4387.7 4405.2 2762.8 2777.3 2809.3 2814.6 2896.0 886.5 891.6 917.1 935.3 964.8 9996.8 10253.9 10256.0 10288.7 10307.4 4126.2 4223.4 4233.3 4309.3 4315.6 9011.6 9098.4 9104.6 9107.0 9107.1 4516.9 4535.0 4543.1 4545.4 4553.9 3453.7 4021.1 4158.3 4182.4 4264.7 3672.1 3713.8 3784.7 3791.4 3824.4 1165.2 1193.2 1206.3 1218.4 1232.7 769.7 876.5 918.0 923.0 927.4 5236.2 5251.6 5332.7 5347.8 5388.5 396.1 937.1 943.2 1022.4 1041.8 3668.6 3688.6 3735.4 3735.9 3830.7 9170.1 9589.5 9603.8 9621.8 9676.0 8759.5 9436.6 9566.2 9580.4 9592.5 7108.9 7266.6 7281.9 7389.2 7392.3 5289.0 5424.0 5518.7 5572.6 5698.3 8373.3 8409.1 8554.7 8605.4 8614.4 8749.6 8846.0 8868.2 8906.6 8965.7 5858.5 6280.7 6456.7 6540.8 6718.4 7344.5 7373.3 7399.8 7424.3 7430.4 6619.5 6744.8 6771.9 6838.6 6845.9 6639.0 6642.9 6668.6 6714.4 6776.9 6214.6 6225.9 6296.9 6301.1 6302.4 4722.5 4745.2 4827.3 4831.9 4852.2 4794.7 4818.7 4840.5 4905.2 4929.7 17:31:18 INFO - PROCESS | 10995 | 17:31:18 INFO - PROCESS | 10995 | [#4] prototype.html Cycles:180 Average:4163.81 Median:4786.76 stddev:1218.68 (25.5%) stddev-sans-first:1186.93 17:31:18 INFO - PROCESS | 10995 | Values: 291.3 293.5 298.5 303.6 303.7 4789.0 4810.6 4813.4 4844.6 4901.2 4780.2 4789.0 4818.4 4824.6 4833.5 3577.2 3687.6 3733.1 3787.4 3823.9 3787.9 3793.9 3813.3 3823.8 3844.5 3568.7 3762.8 3765.2 3789.3 3803.4 3717.8 3760.4 3774.6 3779.2 3786.7 3341.2 3341.6 3344.6 3347.0 3351.6 4620.9 4623.8 4632.8 4639.6 4646.5 4219.1 4280.7 4281.1 4316.8 4368.8 5012.3 5039.7 5044.4 5058.2 5059.8 3611.8 3613.2 3624.5 3631.6 3636.3 4994.9 5301.2 5316.3 5321.2 5337.0 3554.9 3555.2 3558.1 3567.1 3571.2 3616.4 3620.3 3623.2 3623.3 3639.4 4177.0 4234.5 4237.9 4241.0 4247.4 4809.6 5031.7 5039.9 5060.9 5098.6 1218.8 1223.8 1228.0 1232.8 1235.0 777.1 808.7 831.4 834.0 840.9 4343.9 4344.8 4345.5 4346.9 4362.4 5052.6 5057.9 5058.8 5083.0 5119.2 4164.1 4212.1 4320.7 4321.9 4341.7 2662.8 2668.9 2671.5 2685.6 2696.6 4783.9 4784.6 4798.3 4801.5 4813.3 4891.5 5142.9 5152.9 5156.1 5174.3 4744.9 4775.4 4778.7 4797.0 4802.6 4990.7 5068.4 5070.0 5070.8 5092.5 4797.9 4954.7 4968.6 4970.9 5145.8 4989.2 4995.4 4996.8 5002.2 5027.6 3663.3 3674.1 3681.6 3685.8 3692.9 5072.8 5266.4 5291.2 5305.4 5324.6 5050.7 5058.9 5097.2 5098.7 5114.3 5053.4 5075.9 5077.2 5099.7 5133.2 4792.2 5018.6 5030.7 5048.8 5058.5 4926.3 4993.0 5126.6 5135.3 5136.7 4999.9 5017.0 5033.7 5035.7 5042.0 17:31:18 INFO - PROCESS | 10995 | 17:31:18 INFO - PROCESS | 10995 | [#5] yui.html Cycles:180 Average:12767.55 Median:43482.28 stddev:14605.65 (33.6%) stddev-sans-first:14618.50 17:31:18 INFO - PROCESS | 10995 | Values: 698.6 793.3 797.2 798.8 803.3 10691.8 10704.0 10767.1 10779.1 12405.1 11810.6 11832.4 11838.8 11853.8 11868.8 667.5 830.0 859.2 863.1 871.8 849.6 851.0 854.7 856.5 856.5 920.8 921.4 921.8 922.2 922.5 704.4 861.4 903.6 903.8 918.0 667.2 669.6 670.1 671.7 672.2 12017.0 12025.6 12048.6 12052.2 12061.4 11759.6 11902.3 12001.3 12177.2 12410.0 10580.6 10705.7 10798.4 10895.7 11038.4 4085.7 4130.6 4136.4 4177.7 4225.2 43698.8 43787.6 44061.0 44139.0 44163.1 9413.7 9820.9 10156.2 10232.4 10264.7 15968.5 16978.4 17014.7 17020.5 17034.1 6618.5 6652.5 6679.8 6735.9 6827.7 3676.7 3722.8 3744.2 3760.3 3872.1 2695.1 2764.8 2766.2 2766.8 2768.2 465.8 494.6 511.2 523.0 526.8 505.4 534.1 556.5 632.2 634.2 7519.3 7836.0 7840.7 7861.4 8080.8 517.6 590.1 622.5 632.6 646.5 3507.3 3577.6 3625.4 3675.3 3762.3 52879.5 53327.5 53674.0 53852.7 54108.5 48251.8 49333.5 50365.5 50584.5 50935.7 40317.4 43123.1 43265.8 44187.3 44606.0 7644.8 7793.3 7980.0 8047.8 8078.5 29443.3 29550.6 29723.7 30118.7 30189.5 35268.8 37115.8 37773.8 38269.6 38415.8 11039.3 11254.0 11289.8 11321.7 11331.9 10620.4 10778.0 11134.0 11193.3 11394.6 10474.5 10519.9 11009.6 11467.5 11657.9 10623.7 10809.5 10885.8 11148.4 11319.2 9942.0 10776.1 10964.1 11045.9 11540.1 9361.8 9388.2 9758.1 9995.1 10264.4 8738.2 8852.9 9331.0 9414.5 9519.3 17:31:18 INFO - PROCESS | 10995 | -------- Summary: end -------- 17:31:18 INFO - PROCESS | 10995 | 17:31:19 INFO - TEST-INFO | 10995: exit 0 17:31:19 INFO - TEST-OK | dromaeo_css | took 1119334ms 17:31:19 INFO - TEST-START | kraken 17:31:19 INFO - operating with platform_type : linux_ 17:31:19 INFO - Initialising browser for kraken test... 17:31:19 INFO - TEST-INFO | started process 11175 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBuDy3k/profile http://localhost:59718/getInfo.html) 17:31:23 INFO - PROCESS | 11175 | __metrics Screen width/height:1600/1200 17:31:23 INFO - PROCESS | 11175 | colorDepth:24 17:31:23 INFO - PROCESS | 11175 | Browser inner width/height: 1024/697 17:31:23 INFO - PROCESS | 11175 | __metrics 17:31:24 ERROR - PROCESS | 11175 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 17:31:25 INFO - TEST-INFO | 11175: exit 0 17:31:25 INFO - Browser initialized. 17:31:25 INFO - Running cycle 1/1 for kraken test... 17:31:25 INFO - TEST-INFO | started process 11258 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBuDy3k/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:31:37 INFO - PROCESS | 11258 | RSS: Main: 154873856 17:31:37 INFO - PROCESS | 11258 | 17:31:40 INFO - PROCESS | 11258 | Cycle 1(1): loaded http://localhost:59718/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59718/tests/kraken/driver.html?testName=audio-beat-detection) 17:31:40 INFO - PROCESS | 11258 | RSS: Main: 211001344 17:31:40 INFO - PROCESS | 11258 | 17:31:43 INFO - PROCESS | 11258 | Cycle 1(1): loaded http://localhost:59718/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59718/tests/kraken/driver.html?testName=audio-dft) 17:31:44 INFO - PROCESS | 11258 | RSS: Main: 199421952 17:31:44 INFO - PROCESS | 11258 | 17:31:47 INFO - PROCESS | 11258 | Cycle 1(1): loaded http://localhost:59718/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59718/tests/kraken/driver.html?testName=audio-fft) 17:31:48 INFO - PROCESS | 11258 | RSS: Main: 267378688 17:31:48 INFO - PROCESS | 11258 | 17:31:50 INFO - PROCESS | 11258 | Cycle 1(1): loaded http://localhost:59718/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59718/tests/kraken/driver.html?testName=audio-oscillator) 17:31:50 INFO - PROCESS | 11258 | RSS: Main: 176271360 17:31:50 INFO - PROCESS | 11258 | 17:31:53 INFO - PROCESS | 11258 | Cycle 1(1): loaded http://localhost:59718/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59718/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:31:53 INFO - PROCESS | 11258 | RSS: Main: 180178944 17:31:53 INFO - PROCESS | 11258 | 17:31:56 INFO - PROCESS | 11258 | Cycle 1(1): loaded http://localhost:59718/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59718/tests/kraken/driver.html?testName=imaging-darkroom) 17:31:57 INFO - PROCESS | 11258 | RSS: Main: 216010752 17:31:57 INFO - PROCESS | 11258 | 17:32:00 INFO - PROCESS | 11258 | Cycle 1(1): loaded http://localhost:59718/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59718/tests/kraken/driver.html?testName=imaging-desaturate) 17:32:01 INFO - PROCESS | 11258 | RSS: Main: 217202688 17:32:01 INFO - PROCESS | 11258 | 17:32:04 INFO - PROCESS | 11258 | Cycle 1(1): loaded http://localhost:59718/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59718/tests/kraken/driver.html?testName=json-parse-financial) 17:32:05 INFO - PROCESS | 11258 | RSS: Main: 216772608 17:32:05 INFO - PROCESS | 11258 | 17:32:06 INFO - PROCESS | 11258 | Cycle 1(1): loaded http://localhost:59718/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59718/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:32:07 INFO - PROCESS | 11258 | RSS: Main: 203673600 17:32:07 INFO - PROCESS | 11258 | 17:32:09 INFO - PROCESS | 11258 | Cycle 1(1): loaded http://localhost:59718/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59718/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:32:09 INFO - PROCESS | 11258 | RSS: Main: 207855616 17:32:09 INFO - PROCESS | 11258 | 17:32:12 INFO - PROCESS | 11258 | Cycle 1(1): loaded http://localhost:59718/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59718/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:32:12 INFO - PROCESS | 11258 | RSS: Main: 218177536 17:32:12 INFO - PROCESS | 11258 | 17:32:15 INFO - PROCESS | 11258 | Cycle 1(1): loaded http://localhost:59718/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59718/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:32:16 INFO - PROCESS | 11258 | RSS: Main: 225660928 17:32:16 INFO - PROCESS | 11258 | 17:32:19 INFO - PROCESS | 11258 | Cycle 1(1): loaded http://localhost:59718/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59718/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:32:19 INFO - PROCESS | 11258 | RSS: Main: 222171136 17:32:19 INFO - PROCESS | 11258 | 17:32:21 INFO - PROCESS | 11258 | Cycle 1(1): loaded http://localhost:59718/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59718/tests/kraken/driver.html?testName=ai-astar) 17:32:21 INFO - PROCESS | 11258 | RSS: Main: 267321344 17:32:21 INFO - PROCESS | 11258 | 17:32:21 INFO - PROCESS | 11258 | __start_tp_report 17:32:21 INFO - PROCESS | 11258 | _x_x_mozilla_page_load 17:32:21 INFO - PROCESS | 11258 | _x_x_mozilla_page_load_details 17:32:21 INFO - PROCESS | 11258 | |i|pagename|runs| 17:32:21 INFO - PROCESS | 11258 | |0;ai-astar;115;108;114;113;114;114;114;115;113;114 17:32:21 INFO - PROCESS | 11258 | |1;audio-beat-detection;157;130;161;178;130;157;156;135;193;132 17:32:21 INFO - PROCESS | 11258 | |2;audio-dft;159;161;162;162;160;162;160;161;160;160 17:32:21 INFO - PROCESS | 11258 | |3;audio-fft;76;76;75;126;76;76;76;76;130;76 17:32:21 INFO - PROCESS | 11258 | |4;audio-oscillator;93;94;119;92;93;94;126;93;93;118 17:32:21 INFO - PROCESS | 11258 | |5;imaging-gaussian-blur;116;117;117;117;117;117;118;117;118;117 17:32:21 INFO - PROCESS | 11258 | |6;imaging-darkroom;146;146;146;146;146;146;146;147;147;146 17:32:21 INFO - PROCESS | 11258 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;95 17:32:21 INFO - PROCESS | 11258 | |8;json-parse-financial;66;68;66;64;66;65;65;82;66;64 17:32:21 INFO - PROCESS | 11258 | |9;json-stringify-tinderbox;64;63;64;64;64;63;64;64;63;64 17:32:21 INFO - PROCESS | 11258 | |10;stanford-crypto-aes;83;82;83;89;82;89;82;84;83;82 17:32:21 INFO - PROCESS | 11258 | |11;stanford-crypto-ccm;132;143;131;130;136;128;130;129;190;149 17:32:21 INFO - PROCESS | 11258 | |12;stanford-crypto-pbkdf2;173;176;176;174;179;179;177;182;176;175 17:32:21 INFO - PROCESS | 11258 | |13;stanford-crypto-sha256-iterative;68;68;69;69;68;67;69;67;67;68 17:32:21 INFO - PROCESS | 11258 | __end_tp_report 17:32:21 INFO - PROCESS | 11258 | __start_cc_report 17:32:21 INFO - PROCESS | 11258 | _x_x_mozilla_cycle_collect,1900 17:32:21 INFO - PROCESS | 11258 | __end_cc_report 17:32:21 INFO - PROCESS | 11258 | __startTimestamp1462494741735__endTimestamp 17:32:21 INFO - PROCESS | 11258 | 17:32:21 INFO - PROCESS | 11258 | ------- Summary: start ------- 17:32:21 INFO - PROCESS | 11258 | Number of tests: 14 17:32:21 INFO - PROCESS | 11258 | 17:32:21 INFO - PROCESS | 11258 | [#0] ai-astar Cycles:10 Average:113.40 Median:114.00 stddev:2.01 (1.8%) stddev-sans-first:2.05 17:32:21 INFO - PROCESS | 11258 | Values: 115.0 108.0 114.0 113.0 114.0 114.0 114.0 115.0 113.0 114.0 17:32:21 INFO - PROCESS | 11258 | 17:32:21 INFO - PROCESS | 11258 | [#1] audio-beat-detection Cycles:10 Average:152.90 Median:157.00 stddev:21.48 (13.7%) stddev-sans-first:22.73 17:32:21 INFO - PROCESS | 11258 | Values: 157.0 130.0 161.0 178.0 130.0 157.0 156.0 135.0 193.0 132.0 17:32:21 INFO - PROCESS | 11258 | 17:32:21 INFO - PROCESS | 11258 | [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:1.06 (0.7%) stddev-sans-first:0.93 17:32:21 INFO - PROCESS | 11258 | Values: 159.0 161.0 162.0 162.0 160.0 162.0 160.0 161.0 160.0 160.0 17:32:21 INFO - PROCESS | 11258 | 17:32:21 INFO - PROCESS | 11258 | [#3] audio-fft Cycles:10 Average:86.30 Median:76.00 stddev:22.00 (28.9%) stddev-sans-first:23.02 17:32:21 INFO - PROCESS | 11258 | Values: 76.0 76.0 75.0 126.0 76.0 76.0 76.0 76.0 130.0 76.0 17:32:21 INFO - PROCESS | 11258 | 17:32:21 INFO - PROCESS | 11258 | [#4] audio-oscillator Cycles:10 Average:101.50 Median:93.00 stddev:13.62 (14.6%) stddev-sans-first:14.10 17:32:21 INFO - PROCESS | 11258 | Values: 93.0 94.0 119.0 92.0 93.0 94.0 126.0 93.0 93.0 118.0 17:32:21 INFO - PROCESS | 11258 | 17:32:21 INFO - PROCESS | 11258 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.44 17:32:21 INFO - PROCESS | 11258 | Values: 116.0 117.0 117.0 117.0 117.0 117.0 118.0 117.0 118.0 117.0 17:32:21 INFO - PROCESS | 11258 | 17:32:21 INFO - PROCESS | 11258 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 17:32:21 INFO - PROCESS | 11258 | Values: 146.0 146.0 146.0 146.0 146.0 146.0 146.0 147.0 147.0 146.0 17:32:21 INFO - PROCESS | 11258 | 17:32:21 INFO - PROCESS | 11258 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 17:32:21 INFO - PROCESS | 11258 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 17:32:21 INFO - PROCESS | 11258 | 17:32:21 INFO - PROCESS | 11258 | [#8] json-parse-financial Cycles:10 Average:67.20 Median:66.00 stddev:5.33 (8.1%) stddev-sans-first:5.63 17:32:21 INFO - PROCESS | 11258 | Values: 66.0 68.0 66.0 64.0 66.0 65.0 65.0 82.0 66.0 64.0 17:32:21 INFO - PROCESS | 11258 | 17:32:21 INFO - PROCESS | 11258 | [#9] json-stringify-tinderbox Cycles:10 Average:63.70 Median:64.00 stddev:0.48 (0.8%) stddev-sans-first:0.50 17:32:21 INFO - PROCESS | 11258 | Values: 64.0 63.0 64.0 64.0 64.0 63.0 64.0 64.0 63.0 64.0 17:32:21 INFO - PROCESS | 11258 | 17:32:21 INFO - PROCESS | 11258 | [#10] stanford-crypto-aes Cycles:10 Average:83.90 Median:83.00 stddev:2.77 (3.3%) stddev-sans-first:2.92 17:32:21 INFO - PROCESS | 11258 | Values: 83.0 82.0 83.0 89.0 82.0 89.0 82.0 84.0 83.0 82.0 17:32:21 INFO - PROCESS | 11258 | 17:32:21 INFO - PROCESS | 11258 | [#11] stanford-crypto-ccm Cycles:10 Average:139.80 Median:134.00 stddev:18.90 (14.1%) stddev-sans-first:19.84 17:32:21 INFO - PROCESS | 11258 | Values: 132.0 143.0 131.0 130.0 136.0 128.0 130.0 129.0 190.0 149.0 17:32:21 INFO - PROCESS | 11258 | 17:32:21 INFO - PROCESS | 11258 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.70 Median:176.50 stddev:2.67 (1.5%) stddev-sans-first:2.47 17:32:21 INFO - PROCESS | 11258 | Values: 173.0 176.0 176.0 174.0 179.0 179.0 177.0 182.0 176.0 175.0 17:32:21 INFO - PROCESS | 11258 | 17:32:21 INFO - PROCESS | 11258 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.00 Median:68.00 stddev:0.82 (1.2%) stddev-sans-first:0.87 17:32:21 INFO - PROCESS | 11258 | Values: 68.0 68.0 69.0 69.0 68.0 67.0 69.0 67.0 67.0 68.0 17:32:21 INFO - PROCESS | 11258 | -------- Summary: end -------- 17:32:21 INFO - PROCESS | 11258 | 17:32:22 INFO - TEST-INFO | 11258: exit 0 17:32:22 INFO - TEST-OK | kraken | took 63691ms 17:32:22 INFO - SUITE-END | took 1183s 17:32:22 INFO - Completed test suite (00:19:43) 17:32:22 INFO - javascript benchmark 17:32:22 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2697.635819164412, 2699.9460010799785, 2738.5070687276284, 2745.327394788276, 2773.875175617097, 4650.325702773096, 4699.0836786826585, 4750.121227572897, 4857.95142048579, 4890.510948905107, 4662.184117779392, 4697.506761790014, 4750.76246187691, 4796.4244290685165, 4811.085893680199, 4274.572542745732, 4319.71921825082, 4358.8474403395885, 4384.18892504886, 4504.324351347292, 4427.2695005324085, 4439.933400998972, 4457.84397546086, 4485.0132970746545, 4485.035717320776, 4270.530241673413, 4318.805653745558, 4354.499232588261, 4376.168527979674, 4392.011797345604, 4277.700560960734, 4294.098239369736, 4300.526942036374, 4329.805158767863, 4340.392345071693, 4318.82724691012, 4322.265214913441, 4335.826566937319, 4342.50061242958, 4370.497392799837, 4497.347884556721, 4626.259798432268, 4627.953720462786, 4676.953230467686, 4692.296155576657, 5122.795088196468, 5157.974210128926, 5183.637145399824, 5183.766730497136, 5188.662736922126, 5147.459516750725, 5157.819476318311, 5171.146760784466, 5173.870653233662, 5213.895722085575, 4621.768911554443, 4713.057388522241, 4736.360591320196, 4738.218193998021, 4814.20565606671, 5192.143296356135, 5227.843164705065, 5232.973835130876, 5260.658057226268, 5264.0, 4917.65576409655, 5021.949780502221, 5070.8225212117395, 5071.923921141186, 5072.6195535335, 5076.111680455905, 5122.718250496184, 5131.204663277198, 5179.507946745129, 5179.792808287626, 5089.3638295213095, 5091.694498330112, 5093.719845408538, 5095.388553373545, 5147.073526765218, 5071.568916642127, 5073.670211436245, 5075.187969924795, 5076.060928728197, 5083.7203953782155, 4231.703780735381, 4264.0, 4271.850485233002, 4321.67587430944, 4329.350597410414, 3800.239952009609, 3828.2917660232947, 3838.7504812187676, 3839.462475253467, 3841.769493830379, 4335.176316499855, 4358.5205627380965, 4365.781710914442, 4392.4289842320295, 4432.667549933768, 5045.747712614355, 5049.823256186016, 5100.209467532539, 5106.15748401517, 5149.588032957355, 4209.684273679486, 4315.482142142963, 4327.156204540147, 4337.587929146726, 4382.145481631115, 4602.861914142581, 4652.302154676758, 4655.301704744248, 4678.994016286447, 4703.929441058387, 4832.661713680009, 4840.661153719347, 4842.757862106881, 4845.612351011981, 4888.682235654742, 4908.852734417973, 5012.3233363495465, 5144.76848541824, 5160.896782064413, 5212.687238765686, 4726.858194254178, 4740.454847692559, 4755.785989630405, 4767.237242041396, 4811.687240329367, 4966.304717339648, 4978.0, 4979.925301120414, 4987.326710893983, 5040.117979353672, 4944.0, 4967.205247160437, 4973.626977976739, 5055.266986287042, 5096.929644774639, 4830.830920917751, 4848.32123502717, 4864.586510146536, 4894.167991441393, 4903.387076615423, 4862.975685121552, 4871.707697538159, 4875.293082502946, 4880.707157570557, 4938.48145944685, 4767.713937163781, 4799.856004319876, 4851.151048566558, 4902.803887844446, 4903.4606193317995, 5000.949990500194, 5016.046951079284, 5021.899562008813, 5071.036503064406, 5071.2139618359215, 4904.926426103682, 4908.7300198488, 4923.187674033744, 4931.087748766489, 4976.402831660224], "value": 4671.236686550932, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [559.56074481532, 591.9615225010375, 595.7765837810823, 596.8179705189915, 603.1616053685377, 26954.73045269547, 40928.79535602325, 42318.36522452158, 42509.14981700368, 47051.52948470514, 42706.0, 42872.142557148916, 43254.0, 43319.0, 43320.13359732804, 7440.66517006736, 7886.250806173404, 8007.399445041616, 8026.157253488358, 9932.851007234898, 9749.463779492125, 10148.695539133802, 10150.898491015068, 10151.035651613085, 10155.187584993182, 10151.289409741321, 10221.0, 10229.846552301722, 10230.948845255763, 10231.437270950095, 7579.62101894903, 7743.380529557622, 7743.612819359066, 9984.101430871257, 10111.292209545334, 9782.853257201148, 10100.646477373257, 10103.646372377005, 10111.140553053, 10116.94941525295, 38032.61967380319, 38468.80765596182, 38739.03152421184, 38756.80621596902, 38828.0, 3114.0, 3116.9532457013165, 3159.842007899596, 3206.9839650801596, 3440.673136052071, 29380.559291610643, 29393.0, 29560.40879182426, 29630.88266755569, 30000.249993750112, 3000.7599392048583, 3012.171652795477, 3035.134986528829, 3049.5120780675206, 3061.6172978377704, 258112.18878112227, 258368.0, 259314.0, 259546.0, 260054.0, 33955.66044339575, 55644.443555564736, 56119.43880561224, 56450.71774641101, 56522.71738641363, 34341.31317373688, 36340.0, 36371.4544281836, 36381.45427818585, 36387.09032274161, 14157.292135393189, 14373.496927607694, 14390.784138237936, 14397.136171829723, 14400.42398304056, 10025.699229023141, 11782.587609433629, 11938.880611193777, 11948.402579870972, 12180.512779488898, 8368.623411946477, 8371.079181290053, 8400.663973441116, 8458.069612342637, 8458.74623761288, 2686.4358484718427, 2699.5545734953907, 2723.183045086506, 2724.0738149029426, 2736.0423851652163, 855.4525103933488, 931.4923366765129, 1022.2282176956498, 1036.533559898049, 1054.2198772907993, 28936.565951510744, 28999.42001159965, 29210.620954207385, 29266.85366573196, 29489.262768430533, 1038.948052597367, 1061.1669839176209, 1061.7611037516651, 1089.3082892363407, 1174.2191442690514, 15307.46423875159, 15564.143972081418, 15567.0, 15705.371785128695, 15856.762148567781, 369873.0, 373089.0, 373106.0, 373557.0, 374167.0, 51222.23166652503, 51923.48076519262, 52011.0, 52088.73955630273, 52091.0, 1161.5644133449957, 1260.974780504403, 1279.2772083772638, 1300.921944683322, 1312.1143228320655, 28565.714342856307, 30026.39947201, 30480.84759576188, 30720.84639576788, 30828.383432331677, 49236.0, 51523.227151593506, 51559.48440515547, 57508.0, 57637.71181144068, 310250.0, 316905.0, 317306.0, 317834.0, 318242.0, 34784.30431391409, 35444.46833297451, 35690.821545892104, 35724.28551429009, 38738.225235495695, 39238.607613923494, 44000.55999439965, 44523.55476445194, 44960.77519612381, 45086.32370514511, 36087.63912360843, 38269.4259586112, 38567.614323857524, 38667.41998869963, 38948.61051389563, 36136.0, 37912.0, 38099.23801523899, 38179.236415270985, 38219.0, 36471.0, 37558.43662345122, 37721.434178486794, 37858.81070594629, 38251.80874095612, 32573.0, 33452.66547334593, 33889.322213556086, 34417.31165376728, 34417.65582344145, 26016.34959125961, 26157.607635885095, 26249.4750104993, 26285.605715913895, 26575.202743917715], "value": 17600.048080113553, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [375.11472923899595, 380.5794596970346, 384.32742700274514, 389.51310861423224, 392.96659783918363, 15834.604134896634, 17368.0, 17915.283388664455, 18037.18832652532, 18057.00686462244, 15355.462558810445, 15360.769588456182, 16207.108609026529, 16218.405055191171, 16242.0, 4620.999999999992, 4732.526747325274, 4773.856784296477, 4800.3279540864305, 4803.759812009403, 3310.78479898807, 5111.693298402108, 5384.91922621159, 5401.27082843815, 5459.563234941215, 5425.7287135643255, 5442.700651464168, 5446.891062178754, 5462.562994960414, 5467.6719396836115, 5005.174146265862, 5366.517013468768, 5380.784768609251, 5443.618946673734, 5450.809221677222, 3309.5697559317377, 4868.123737727207, 5210.088234558937, 5212.035773381936, 5235.136202526579, 19817.60364792696, 20015.1993920243, 20025.79974200254, 20530.589388212153, 20534.5893082139, 1863.3757691173473, 1886.9056547172586, 1954.6677064898859, 1959.5101224693826, 1975.9012049397616, 8592.226699597066, 8780.121987801233, 8849.380543361967, 9137.862932056025, 9192.678256260999, 1626.479526551504, 1705.1985566783592, 1794.5423916901236, 1825.3246298869371, 1832.688442964686, 69954.65022674904, 71114.64442677805, 71564.62041191562, 71670.64164679247, 74097.6295118521, 9689.612415503301, 9963.302568820112, 10097.343672661253, 10201.591936322464, 10231.897681023243, 13835.100718453268, 14001.85998140026, 14004.719905602034, 14010.649733756738, 14017.929910350384, 7526.435517336222, 7554.584497852561, 7637.770866874002, 7654.272844079804, 7723.343515801107, 7335.303146201102, 7354.521956072838, 7483.476156668981, 7527.134379546313, 7533.020707308015, 4277.1873344064525, 4370.2570563004365, 4409.669274804402, 4434.091011342667, 4478.977605111953, 1637.909914954665, 1697.2871394014544, 1706.6927952968585, 1736.6266252755465, 1768.522498925283, 806.8345989072343, 875.5884734174928, 891.0866361978893, 964.5273815830193, 1012.018342208057, 16049.59876003086, 16952.915235423745, 16994.32022719102, 17011.4053740576, 17311.3941012064, 897.6544030548285, 897.708244820436, 945.4469135555777, 953.1802649721234, 980.9509524523745, 9544.95227523858, 9560.61757529691, 9659.292411126773, 9703.466309352913, 9876.851847222297, 380151.0, 386304.0, 386691.0, 386741.0, 395455.0, 78227.0, 79594.20405795868, 79929.60035199787, 80240.59879700564, 80551.0, 950.9286803489766, 986.2504496582505, 993.036754348281, 993.1905497019906, 998.9850152247722, 14689.338979746151, 14930.402783888523, 15006.324715388053, 15015.474458393905, 15315.61710957235, 25096.24711258665, 26042.73957260403, 30330.241743956576, 34407.82796086104, 35670.82164589161, 47968.0, 48395.0, 48399.0, 48518.0, 48562.27156592724, 7587.886181707168, 7641.847163056596, 7657.0811502620045, 7727.42044346665, 7732.188120247518, 10617.575296988034, 10807.135429165804, 10905.127589792639, 11191.552337906392, 11431.314121152758, 9323.347365684609, 9379.484128372733, 9637.855432168382, 9824.55789489489, 9853.359531630422, 7895.460385224826, 9533.854882651349, 9783.755406114904, 10104.191664666956, 10164.44095574721, 9656.32405731592, 10007.949960250153, 10084.092431681183, 10116.898831011596, 10216.744581385525, 7399.630018499161, 7401.740939067106, 7478.887816682863, 7559.848803024019, 7688.154303026551, 9631.08504692053, 9827.950860245654, 9868.358556694078, 10038.799224015625, 10124.544395502073], "value": 8087.561574692699, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1263.6461790698609, 1522.6802371501983, 1541.3064121145485, 1746.4935168801048, 1892.403892773777, 7255.528390654604, 7498.662560184791, 7508.587027713474, 7514.81212969676, 7666.271704188107, 7211.927880721191, 7427.814304642373, 7595.620218989042, 7596.582187979659, 7603.315701586856, 2172.945676358088, 2250.932472025842, 2251.5722012817596, 2252.40311317501, 2257.7064981552458, 2195.6047911375945, 2236.2620335289316, 2241.1035585765662, 2242.887855607213, 2245.5845668551287, 2148.430665873545, 2163.048258766146, 2175.695402643631, 2182.050807898569, 2195.7365116186, 2124.925627603034, 2137.5190582119053, 2143.014213461802, 2144.2709478777215, 2144.656854903208, 2168.186929901287, 2196.626573482496, 2199.7690242524463, 2200.7469141048664, 2201.8018378345864, 7211.711531538732, 7371.37343325818, 7587.886181707278, 7635.847283054308, 7659.7319093832, 4310.245707001262, 4382.035952090535, 4384.7369157850635, 4387.736735795863, 4405.22908491016, 2762.7651649609807, 2777.3056735816044, 2809.311718628949, 2814.6481689788775, 2896.0, 886.5124181700039, 891.6255172827427, 917.0508523677961, 935.2658163341812, 964.7636329099346, 9996.800063998751, 10253.948730256376, 10256.0, 10288.69133925976, 10307.433091179983, 4126.236646220459, 4223.429836972031, 4233.322668373045, 4309.332053531708, 4315.568443155659, 9011.594478248495, 9098.363114581916, 9104.635814567344, 9107.043760405195, 9107.089291070972, 4516.909661806745, 4534.954650453519, 4543.091381723669, 4545.38637283969, 4553.931691024637, 3453.671901169385, 4021.1153546219784, 4158.251514727318, 4182.372644103409, 4264.744115353089, 3672.1186915140706, 3713.795741234258, 3784.7161462890394, 3791.374423220138, 3824.4454554089502, 1165.1610840195046, 1193.164784650748, 1206.2882899089404, 1218.3786269002694, 1232.6979889926845, 769.707511145761, 876.4828751036919, 917.9632814687471, 922.9676961306322, 927.3937856689928, 5236.214567814858, 5251.6061295403, 5332.680039197583, 5347.839564813062, 5388.515033646991, 396.1423518083375, 937.0629370629371, 943.2077055273465, 1022.3610243597751, 1041.796849614333, 3668.614795446493, 3688.6495782900583, 3735.3649879520003, 3735.869244576481, 3830.693544516432, 9170.08299170091, 9589.472579008081, 9603.807923841623, 9621.759456013655, 9676.032396760267, 8759.474431534129, 9436.575354109082, 9566.234701223886, 9580.377275477073, 9592.472414017297, 7108.928910710827, 7266.564006159648, 7281.854362912712, 7389.187189409161, 7392.334689877936, 5288.9735551322, 5424.0, 5518.668879867221, 5572.554195664418, 5698.344690360662, 8373.33013358942, 8409.075001749681, 8554.657813687632, 8605.397622166389, 8614.396992210484, 8749.562521874008, 8846.0, 8868.201861832466, 8906.599203036008, 8965.731028069169, 5858.531317494505, 6280.717367718372, 6456.741730330734, 6540.771073012422, 6718.428933540704, 7344.48588598793, 7373.262673732584, 7399.8150046249275, 7424.331810137113, 7430.3684186842565, 6619.50353723463, 6744.763933262312, 6771.932280677327, 6838.555493892881, 6845.863082738417, 6638.9668051661365, 6642.900356494753, 6668.599884006975, 6714.362135597111, 6776.932230677828, 6214.627122372672, 6225.906611400742, 6296.905546416899, 6301.054841773771, 6302.432781049728, 4722.456917454537, 4745.169595320874, 4827.300041493893, 4831.9275210871165, 4852.1508735971765, 4794.664373493822, 4818.71087734737, 4840.467548569725, 4905.166121759238, 4929.704217746947], "value": 4138.281416349723, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [291.2921600510758, 293.470286133529, 298.5298155405237, 303.6204744069913, 303.6978206684348, 4788.976055119724, 4810.567048965592, 4813.422389313283, 4844.563989240967, 4901.166801643721, 4780.211265141247, 4788.952110478895, 4818.445878723948, 4824.565789078983, 4833.468318484964, 3577.209776374419, 3687.612800655933, 3733.1040550268012, 3787.3561494545993, 3823.9426408603895, 3787.905302367449, 3793.9241215175816, 3813.31360355136, 3823.808809559525, 3844.461775351453, 3568.6788189062977, 3762.830672619725, 3765.2469506098755, 3789.2610940866543, 3803.4484999675033, 3717.8326975286177, 3760.435934609803, 3774.622537746231, 3779.244151169777, 3786.659200671953, 3341.231516751161, 3341.63242043375, 3344.6488118747666, 3347.0, 3351.631320554737, 4620.914085189977, 4623.8209256639675, 4632.837850675244, 4639.559241872017, 4646.512116227781, 4219.135077309175, 4280.700350975433, 4281.100968796556, 4316.805743741539, 4368.825246990116, 5012.298278241049, 5039.748012599355, 5044.445111037783, 5058.1537738725465, 5059.772310246048, 3611.765235259726, 3613.1870329175986, 3624.4563315502623, 3631.6005239423644, 3636.254567813592, 4994.925076123861, 5301.151815709468, 5316.3354580677415, 5321.201819727072, 5337.0, 3554.87557935471, 3555.1823080691584, 3558.09268636496, 3567.090391950036, 3571.2143328467696, 3616.4213725803747, 3620.2759448110482, 3623.166671665532, 3623.3477973964414, 3639.4358874374516, 4177.0, 4234.534201237861, 4237.940514871282, 4241.031278105339, 4247.426597409372, 4809.567138957511, 5031.735718926498, 5039.874003149877, 5060.873478163076, 5098.643094983389, 1218.8171774233936, 1223.8409006829056, 1228.0, 1232.8150777383464, 1234.950601975911, 777.0908037596026, 808.7343307723512, 831.3723139030114, 833.9874901876477, 840.878072679458, 4343.893211792279, 4344.826206951687, 4345.543717909637, 4346.891327716832, 4362.367456718758, 5052.56002039417, 5057.873553161126, 5058.849988754764, 5082.974585127051, 5119.210030533368, 4164.104717485695, 4212.136512015029, 4320.65434765218, 4321.870343889688, 4341.739495630272, 2662.8002899782596, 2668.893244270246, 2671.452352267819, 2685.6374389457565, 2696.555068413729, 4783.928241076386, 4784.564630610803, 4798.328234047236, 4801.51984801517, 4813.253945638362, 4891.461939186686, 5142.871428214325, 5152.871178220499, 5156.143788236232, 5174.31834653739, 4744.881377965578, 4775.445136851837, 4778.689385189951, 4797.040591881638, 4802.567768900815, 4990.6506544541535, 5068.391792984866, 5069.9746501267255, 5070.847874563769, 5092.541671249605, 4797.856064318076, 4954.696066329174, 4968.552830245295, 4970.850874473772, 5145.768440420115, 4989.151844186425, 4995.350604421547, 4996.750162491933, 5002.2496625506465, 5027.64806463544, 3663.3405986922608, 3674.118211629136, 3681.5950245473514, 3685.7972811495624, 3692.9446058309686, 5072.82245121419, 5266.368035835724, 5291.206319052173, 5305.363356397257, 5324.61559994412, 5050.671706339076, 5058.924116138334, 5097.158968770112, 5098.745062746922, 5114.309568208244, 5053.418856831365, 5075.949240507695, 5077.1876499759865, 5099.6685215460875, 5133.2300154975555, 4792.2092854678585, 5018.573421259088, 5030.723310217973, 5048.7728052237, 5058.468860769566, 4926.285688575208, 4993.0, 5126.564242039469, 5135.281060651587, 5136.666116702402, 4999.925001124913, 5016.974915125401, 5033.697978121324, 5035.697858128524, 5041.974790126026], "value": 3772.456210858847, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [698.6087790837131, 793.3018943329869, 797.1988151907336, 798.7603718884333, 803.3332334162644, 10691.83962240567, 10704.036636702695, 10767.138628909688, 10779.08377787888, 12405.131640785148, 11810.58662946797, 11832.40837958103, 11838.7632247355, 11853.7629247415, 11868.821967670492, 667.4726965697093, 829.9626516806758, 859.2438653984485, 863.1023735315265, 871.7864123289803, 849.6346570974479, 851.0340763233743, 854.6752234151045, 856.4518708026836, 856.4946681457939, 920.769807548113, 921.3642586615248, 921.755734730297, 922.197688011431, 922.5295099499236, 704.3766266853845, 861.3625916821507, 903.6295119001244, 903.814717982812, 917.9724608261763, 667.1893649216225, 669.6082791566939, 670.0552221367897, 671.7380221713536, 672.2034389248756, 12017.0, 12025.579104731292, 12048.638540843702, 12052.156349055569, 12061.396930153458, 11759.588414405454, 11902.34537100459, 12001.279923204636, 12177.208481448677, 12410.007199424024, 10580.629677961235, 10705.678829635124, 10798.352098874015, 10895.673129806119, 11038.44807759617, 4085.6935729820384, 4130.56629053948, 4136.379543068534, 4177.707560470768, 4225.176090662322, 43698.781506092586, 43787.562124378666, 44061.0, 44139.0, 44163.11673766539, 9413.670521531714, 9820.901790982141, 10156.187504999582, 10232.437215953045, 10264.692059238234, 15968.520944371456, 16978.405755798736, 17014.659706806044, 17020.48938531846, 17034.14829258532, 6618.503612229102, 6652.534322597372, 6679.76620818269, 6735.8989615155815, 6827.69275382609, 3676.742628016013, 3722.8324725387424, 3744.1575645479547, 3760.304343696425, 3872.1481274119647, 2695.056730144434, 2764.847933363644, 2766.1839757271655, 2766.847823369734, 2768.169549135251, 465.77875509133565, 494.5598417408509, 511.22038890691994, 523.0402211941131, 526.7576914619318, 505.3935277666741, 534.121370345779, 556.4546744190716, 632.2065807411669, 634.1502386801708, 7519.285667861544, 7835.960820195863, 7840.725574604861, 7861.449698521049, 8080.797980050428, 517.6298946253447, 590.099225928658, 622.4900595187893, 632.6488798716664, 646.4634353486595, 3507.309789214191, 3577.606463289036, 3625.3655610268097, 3675.3016926783826, 3762.266358060152, 52879.47120528745, 53327.466725333026, 53674.0, 53852.730736346064, 54108.45891541113, 48251.75874120607, 49333.50666493361, 50365.496345036816, 50584.494155057975, 50935.7453212739, 40317.39523907085, 43123.13753724908, 43265.783671081444, 44187.337189942176, 44605.985461308635, 7644.847103058019, 7793.298603125746, 7980.0, 8047.798805029687, 8078.515289082674, 29443.263918401353, 29550.55674164932, 29723.70276297296, 30118.69881301159, 30189.547156793105, 35268.823655881555, 37115.81442092772, 37773.81113094417, 38269.617303826606, 38415.807920960215, 11039.260740748145, 11254.0, 11289.830652540382, 11321.660350189508, 11331.943340283246, 10620.415877126832, 10778.0, 11134.0, 11193.328400296008, 11394.601188958346, 10474.476276186313, 10519.894801052198, 11009.559617615205, 11467.483963221508, 11657.941710291394, 10623.681289561326, 10809.459527023775, 10885.836712449161, 11148.386838723947, 11319.151063670422, 9942.0, 10776.137908967421, 10964.122870170208, 11045.94477027642, 11540.134489913122, 9361.81276374455, 9388.202002829836, 9758.072983066597, 9995.100440960348, 10264.435456049989, 8738.169873861973, 8852.911470885208, 9331.0, 9414.462696612518, 9519.333646644669], "value": 5981.592772812508, "unit": "score"}], "name": "dromaeo_css", "value": 6292.825945902247, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 108.0, 114.0, 113.0, 114.0, 114.0, 114.0, 115.0, 113.0, 114.0], "value": 113.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 130.0, 161.0, 178.0, 130.0, 157.0, 156.0, 135.0, 193.0, 132.0], "value": 152.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 161.0, 162.0, 162.0, 160.0, 162.0, 160.0, 161.0, 160.0, 160.0], "value": 160.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 126.0, 76.0, 76.0, 76.0, 76.0, 130.0, 76.0], "value": 86.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 119.0, 92.0, 93.0, 94.0, 126.0, 93.0, 93.0, 118.0], "value": 101.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 118.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 147.0, 147.0, 146.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 68.0, 66.0, 64.0, 66.0, 65.0, 65.0, 82.0, 66.0, 64.0], "value": 67.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 64.0, 64.0, 64.0, 63.0, 64.0, 64.0, 63.0, 64.0], "value": 63.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 83.0, 89.0, 82.0, 89.0, 82.0, 84.0, 83.0, 82.0], "value": 83.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 143.0, 131.0, 130.0, 136.0, 128.0, 130.0, 129.0, 190.0, 149.0], "value": 139.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 176.0, 176.0, 174.0, 179.0, 179.0, 177.0, 182.0, 176.0, 175.0], "value": 176.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 69.0, 69.0, 68.0, 67.0, 69.0, 67.0, 67.0, 68.0], "value": 68.0, "unit": "score"}], "name": "kraken", "value": 1572.4, "alertThreshold": 2.0}]} 17:32:22 INFO - Return code: 0 17:32:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 17:32:23 ERROR - # TBPL SUCCESS # 17:32:23 INFO - Running post-action listener: _resource_record_post_action 17:32:23 INFO - Running post-run listener: _resource_record_post_run 17:32:24 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 24576; Write bytes: 519589888; Read time: 432; Write time: 603780 17:32:24 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 4096; Write bytes: 234799104; Read time: 116; Write time: 322080 17:32:24 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 20480; Write bytes: 284790784; Read time: 316; Write time: 281700 17:32:24 INFO - Running post-run listener: _upload_blobber_files 17:32:24 INFO - Blob upload gear active. 17:32:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:32:24 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 17:32:24 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'] 17:32:24 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 17:32:24 INFO - (blobuploader) - INFO - Open directory for files ... 17:32:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:32:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:32:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:32:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:32:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:32:25 INFO - (blobuploader) - INFO - Done attempting. 17:32:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:32:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:32:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:32:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:32:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:32:26 INFO - (blobuploader) - INFO - Done attempting. 17:32:26 INFO - (blobuploader) - INFO - Iteration through files over. 17:32:26 INFO - Return code: 0 17:32:26 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:32:26 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:32:26 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4b2a4c851f2c208254a58a617cebe245de88bd8d00269b63de02058d45d03f0932b48fe91e656bcd267bf61838032ecda8d3f2451c9a5e449a024e41bf3bd57b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b2d51911d828912c24e8da29db418a0dca82cf9b8d364490b0a88746ea7b42126fe90c30fe1211c8844f6213245720d1eca148e30e78c1660c20a806be085a15"} 17:32:26 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:32:26 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:32:26 INFO - Contents: 17:32:26 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4b2a4c851f2c208254a58a617cebe245de88bd8d00269b63de02058d45d03f0932b48fe91e656bcd267bf61838032ecda8d3f2451c9a5e449a024e41bf3bd57b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b2d51911d828912c24e8da29db418a0dca82cf9b8d364490b0a88746ea7b42126fe90c30fe1211c8844f6213245720d1eca148e30e78c1660c20a806be085a15"} 17:32:26 INFO - Running post-run listener: copy_logs_to_upload_dir 17:32:26 INFO - Copying logs to upload dir... 17:32:26 INFO - mkdir: /builds/slave/test/build/upload/logs 17:32:26 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1252.034262 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-05-05 17:32:26.173473) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-05 17:32:26.176936) ========= 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=5bd038846534b2fdfa68eeae000001e2-1462492486.754280-869052492 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/4b2a4c851f2c208254a58a617cebe245de88bd8d00269b63de02058d45d03f0932b48fe91e656bcd267bf61838032ecda8d3f2451c9a5e449a024e41bf3bd57b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b2d51911d828912c24e8da29db418a0dca82cf9b8d364490b0a88746ea7b42126fe90c30fe1211c8844f6213245720d1eca148e30e78c1660c20a806be085a15"} build_url:https://queue.taskcluster.net/v1/task/HdG1fKWxQu-exyv9YPiN5Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011243 build_url: 'https://queue.taskcluster.net/v1/task/HdG1fKWxQu-exyv9YPiN5Q/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/4b2a4c851f2c208254a58a617cebe245de88bd8d00269b63de02058d45d03f0932b48fe91e656bcd267bf61838032ecda8d3f2451c9a5e449a024e41bf3bd57b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b2d51911d828912c24e8da29db418a0dca82cf9b8d364490b0a88746ea7b42126fe90c30fe1211c8844f6213245720d1eca148e30e78c1660c20a806be085a15"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-05 17:32:26.202413) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 17:32:26.202775) ========= 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=5bd038846534b2fdfa68eeae000001e2-1462492486.754280-869052492 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004409 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 17:32:26.288643) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-05 17:32:26.289359) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-05 17:32:26.290036) ========= ========= Total master_lag: 0.19 =========