builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-056 starttime: 1461170534.09 results: success (0) buildid: 20160420092238 builduid: 3d1425faf8e74db2b4c0a4a72e376369 revision: 70bbd2e42d9df60dbb792e4e225e6bd2d67097af ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-20 09:42:14.090661) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-20 09:42:14.091628) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-20 09:42:14.092178) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-20 09:42:14.111466) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 09:42:14.111882) ========= 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=52faae308a556c440401f8e5000001e8-1461168480.581075-1500704581 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-20 09:42:14-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 34.5M=0s 2016-04-20 09:42:14 (34.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.101831 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 09:42:14.227582) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 09:42:14.227917) ========= 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=52faae308a556c440401f8e5000001e8-1461168480.581075-1500704581 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018788 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 09:42:14.277503) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 09:42:14.277933) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 70bbd2e42d9df60dbb792e4e225e6bd2d67097af --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 70bbd2e42d9df60dbb792e4e225e6bd2d67097af --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=52faae308a556c440401f8e5000001e8-1461168480.581075-1500704581 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-20 09:42:14,345 truncating revision to first 12 chars 2016-04-20 09:42:14,345 Setting DEBUG logging. 2016-04-20 09:42:14,345 attempt 1/10 2016-04-20 09:42:14,345 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/70bbd2e42d9d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-20 09:42:14,604 unpacking tar archive at: fx-team-70bbd2e42d9d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.525560 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 09:42:14.816937) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-20 09:42:14.817279) ========= script_repo_revision: 70bbd2e42d9df60dbb792e4e225e6bd2d67097af ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-20 09:42:14.817709) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-20 09:42:14.817985) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-20 09:42:14.827266) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-04-20 09:42:14.827710) ========= /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=52faae308a556c440401f8e5000001e8-1461168480.581075-1500704581 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:42:14 INFO - MultiFileLogger online at 20160420 09:42:14 in /builds/slave/test 09:42:14 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 09:42:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:42:14 INFO - {'append_to_log': False, 09:42:14 INFO - 'base_work_dir': '/builds/slave/test', 09:42:14 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 09:42:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:42:14 INFO - 'branch': 'Fx-Team-Non-PGO', 09:42:14 INFO - 'buildbot_json_path': 'buildprops.json', 09:42:14 INFO - 'config_files': ('talos/linux_config.py',), 09:42:14 INFO - 'default_actions': ('clobber', 09:42:14 INFO - 'read-buildbot-config', 09:42:14 INFO - 'download-and-extract', 09:42:14 INFO - 'populate-webroot', 09:42:14 INFO - 'create-virtualenv', 09:42:14 INFO - 'install', 09:42:14 INFO - 'run-tests'), 09:42:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:42:14 INFO - 'download_minidump_stackwalk': True, 09:42:14 INFO - 'download_symbols': 'ondemand', 09:42:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:42:14 INFO - 'tooltool.py': '/tools/tooltool.py', 09:42:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:42:14 INFO - '/tools/misc-python/virtualenv.py')}, 09:42:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:42:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:42:14 INFO - 'installer_path': 'installer.exe', 09:42:14 INFO - 'log_level': 'info', 09:42:14 INFO - 'log_name': 'talos', 09:42:14 INFO - 'log_to_console': True, 09:42:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:42:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:42:14 INFO - 'opt_config_files': (), 09:42:14 INFO - 'pip_index': False, 09:42:14 INFO - 'sps_profile': False, 09:42:14 INFO - 'sps_profile_interval': 0, 09:42:14 INFO - 'suite': 'dromaeojs', 09:42:14 INFO - 'system_bits': '32', 09:42:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:42:14 INFO - 'title': 'talos-linux64-ix-056', 09:42:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:42:14 INFO - 'use_talos_json': True, 09:42:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:42:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:42:14 INFO - 'work_dir': 'build'} 09:42:14 INFO - ##### 09:42:14 INFO - ##### Running clobber step. 09:42:14 INFO - ##### 09:42:14 INFO - Running pre-action listener: _resource_record_pre_action 09:42:14 INFO - Running main action method: clobber 09:42:14 INFO - rmtree: /builds/slave/test/build 09:42:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:42:15 INFO - Running post-action listener: _resource_record_post_action 09:42:15 INFO - ##### 09:42:15 INFO - ##### Running read-buildbot-config step. 09:42:15 INFO - ##### 09:42:15 INFO - Running pre-action listener: _resource_record_pre_action 09:42:15 INFO - Running main action method: read_buildbot_config 09:42:15 INFO - Using buildbot properties: 09:42:15 INFO - { 09:42:15 INFO - "project": "", 09:42:15 INFO - "product": "firefox", 09:42:15 INFO - "script_repo_revision": "production", 09:42:15 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 09:42:15 INFO - "repository": "", 09:42:15 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 09:42:15 INFO - "buildid": "20160420092238", 09:42:15 INFO - "pgo_build": "False", 09:42:15 INFO - "basedir": "/builds/slave/test", 09:42:15 INFO - "buildnumber": 1687, 09:42:15 INFO - "slavename": "talos-linux64-ix-056", 09:42:15 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 09:42:15 INFO - "platform": "ubuntu64_hw", 09:42:15 INFO - "scheduler": "tests-fx-team-linux64-talos", 09:42:15 INFO - "branch": "fx-team", 09:42:15 INFO - "repo_path": "integration/fx-team", 09:42:15 INFO - "revision": "70bbd2e42d9df60dbb792e4e225e6bd2d67097af", 09:42:15 INFO - "stage_platform": "linux64", 09:42:15 INFO - "builduid": "3d1425faf8e74db2b4c0a4a72e376369", 09:42:15 INFO - "slavebuilddir": "test" 09:42:15 INFO - } 09:42:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/LKau8BlwT1GzWNTbDpQpIg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 09:42:15 INFO - Running post-action listener: _resource_record_post_action 09:42:15 INFO - ##### 09:42:15 INFO - ##### Running download-and-extract step. 09:42:15 INFO - ##### 09:42:15 INFO - Running pre-action listener: _resource_record_pre_action 09:42:15 INFO - Running main action method: download_and_extract 09:42:15 INFO - mkdir: /builds/slave/test/build/tests 09:42:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:42:15 INFO - https://queue.taskcluster.net/v1/task/LKau8BlwT1GzWNTbDpQpIg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 09:42:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LKau8BlwT1GzWNTbDpQpIg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 09:42:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LKau8BlwT1GzWNTbDpQpIg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 09:42:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LKau8BlwT1GzWNTbDpQpIg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 09:42:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LKau8BlwT1GzWNTbDpQpIg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 09:42:16 INFO - Downloaded 1361 bytes. 09:42:16 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 09:42:16 INFO - Using the following test package requirements: 09:42:16 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 09:42:16 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:42:16 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:42:16 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:42:16 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:42:16 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:42:16 INFO - u'jsshell-linux-x86_64.zip'], 09:42:16 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:42:16 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:42:16 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 09:42:16 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:42:16 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:42:16 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:42:16 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:42:16 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:42:16 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:42:16 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:42:16 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:42:16 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:42: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')]} 09:42:16 INFO - https://queue.taskcluster.net/v1/task/LKau8BlwT1GzWNTbDpQpIg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:42:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LKau8BlwT1GzWNTbDpQpIg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 09:42:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LKau8BlwT1GzWNTbDpQpIg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 09:42:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LKau8BlwT1GzWNTbDpQpIg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 09:42:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LKau8BlwT1GzWNTbDpQpIg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:42:18 INFO - Downloaded 22268267 bytes. 09:42:18 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:42:18 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 09:42:19 INFO - Return code: 0 09:42:19 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:42: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')]} 09:42:19 INFO - https://queue.taskcluster.net/v1/task/LKau8BlwT1GzWNTbDpQpIg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:42:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LKau8BlwT1GzWNTbDpQpIg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 09:42:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LKau8BlwT1GzWNTbDpQpIg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 09:42:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LKau8BlwT1GzWNTbDpQpIg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 09:42:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LKau8BlwT1GzWNTbDpQpIg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:42:24 INFO - Downloaded 22268267 bytes. 09:42:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:42:24 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 09:42:26 INFO - Return code: 0 09:42:26 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')]} 09:42:26 INFO - https://queue.taskcluster.net/v1/task/LKau8BlwT1GzWNTbDpQpIg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:42:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LKau8BlwT1GzWNTbDpQpIg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 09:42:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LKau8BlwT1GzWNTbDpQpIg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 09:42:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LKau8BlwT1GzWNTbDpQpIg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 09:42:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LKau8BlwT1GzWNTbDpQpIg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:42:27 INFO - Downloaded 10845952 bytes. 09:42:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:42:27 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 09:42:27 INFO - Return code: 0 09:42:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:42:27 INFO - https://queue.taskcluster.net/v1/task/LKau8BlwT1GzWNTbDpQpIg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:42:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LKau8BlwT1GzWNTbDpQpIg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 09:42:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LKau8BlwT1GzWNTbDpQpIg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 09:42:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LKau8BlwT1GzWNTbDpQpIg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 09:42:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LKau8BlwT1GzWNTbDpQpIg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:42:29 INFO - Downloaded 54608758 bytes. 09:42:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LKau8BlwT1GzWNTbDpQpIg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 09:42:29 INFO - mkdir: /builds/slave/test/properties 09:42:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:42:29 INFO - Writing to file /builds/slave/test/properties/build_url 09:42:29 INFO - Contents: 09:42:29 INFO - build_url:https://queue.taskcluster.net/v1/task/LKau8BlwT1GzWNTbDpQpIg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 09:42:31 INFO - Running post-action listener: _resource_record_post_action 09:42:31 INFO - Running post-action listener: set_extra_try_arguments 09:42:31 INFO - ##### 09:42:31 INFO - ##### Running populate-webroot step. 09:42:31 INFO - ##### 09:42:31 INFO - Running pre-action listener: _resource_record_pre_action 09:42:31 INFO - Running main action method: populate_webroot 09:42:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:42:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:42:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:42:31 INFO - '--tppagecycles', 09:42:31 INFO - '7'], 09:42:31 INFO - 'tests': ['tsvgm']}}, 09:42:31 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:42:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:42:31 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:42:31 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:42:31 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:42:31 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:42:31 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:42:31 INFO - 'talos_options': ['--disable-e10s'], 09:42:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:42:31 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:42:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:42:31 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:42:31 INFO - 'talos_options': ['--disable-e10s'], 09:42:31 INFO - 'tests': ['damp', 'tps']}, 09:42:31 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:42:31 INFO - 'tests': ['damp', 'tps']}, 09:42:31 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:42:31 INFO - 'tests': ['dromaeo_dom']}, 09:42:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:42:31 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:42:31 INFO - 'tests': ['a11yr', 09:42:31 INFO - 'ts_paint', 09:42:31 INFO - 'tpaint', 09:42:31 INFO - 'sessionrestore', 09:42:31 INFO - 'sessionrestore_no_auto_restore', 09:42:31 INFO - 'tabpaint']}, 09:42:31 INFO - 'other-e10s': {'tests': ['a11yr', 09:42:31 INFO - 'ts_paint', 09:42:31 INFO - 'tpaint', 09:42:31 INFO - 'sessionrestore', 09:42:31 INFO - 'sessionrestore_no_auto_restore', 09:42:31 INFO - 'tabpaint']}, 09:42:31 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:42:31 INFO - 'ts_paint', 09:42:31 INFO - 'tpaint', 09:42:31 INFO - 'sessionrestore', 09:42:31 INFO - 'sessionrestore_no_auto_restore', 09:42:31 INFO - 'tabpaint']}, 09:42:31 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:42:31 INFO - 'ts_paint', 09:42:31 INFO - 'tpaint', 09:42:31 INFO - 'sessionrestore', 09:42:31 INFO - 'sessionrestore_no_auto_restore', 09:42:31 INFO - 'tabpaint']}, 09:42:31 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:42:31 INFO - 'tests': ['a11yr', 09:42:31 INFO - 'ts_paint', 09:42:31 INFO - 'tpaint', 09:42:31 INFO - 'sessionrestore', 09:42:31 INFO - 'sessionrestore_no_auto_restore', 09:42:31 INFO - 'tabpaint']}, 09:42:31 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:42:31 INFO - 'tests': ['a11yr', 09:42:31 INFO - 'ts_paint', 09:42:31 INFO - 'tpaint', 09:42:31 INFO - 'sessionrestore', 09:42:31 INFO - 'sessionrestore_no_auto_restore', 09:42:31 INFO - 'tabpaint']}, 09:42:31 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:42:31 INFO - 'tests': ['tsvgx', 09:42:31 INFO - 'tsvgr_opacity', 09:42:31 INFO - 'tart', 09:42:31 INFO - 'tscrollx', 09:42:31 INFO - 'cart']}, 09:42:31 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:42:31 INFO - 'tsvgr_opacity', 09:42:31 INFO - 'tart', 09:42:31 INFO - 'tscrollx', 09:42:31 INFO - 'cart']}, 09:42:31 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:42:31 INFO - 'talos_options': ['--disable-e10s'], 09:42:31 INFO - 'tests': ['tp5o']}, 09:42:31 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:42:31 INFO - 'tests': ['tp5o']}, 09:42:31 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:42:31 INFO - 'talos_options': ['--disable-e10s', 09:42:31 INFO - '--xperf_path', 09:42:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:42:31 INFO - 'tests': ['tp5n']}, 09:42:31 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:42:31 INFO - 'talos_options': ['--xperf_path', 09:42:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:42:31 INFO - 'tests': ['tp5n']}}, 09:42:31 INFO - 'talos.zip': {'path': '', 09:42:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:42:31 INFO - Running post-action listener: _resource_record_post_action 09:42:31 INFO - ##### 09:42:31 INFO - ##### Running create-virtualenv step. 09:42:31 INFO - ##### 09:42:31 INFO - Running pre-action listener: _resource_record_pre_action 09:42:31 INFO - Running main action method: create_virtualenv 09:42:31 INFO - Creating virtualenv /builds/slave/test/build/venv 09:42:31 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 09:42:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:42:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:42:31 INFO - Using real prefix '/usr' 09:42:31 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:42:31 INFO - Installing distribute.............................................................................................................................................................................................done. 09:42:33 INFO - Installing pip.................done. 09:42:33 INFO - Return code: 0 09:42:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:42:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:42:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:42:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:42:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:42:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:42:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:42:33 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 0x7fb154121f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bcb5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c5a410>, '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 0x2c5b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c5b7a0>, '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': '52faae308a556c440401f8e5000001e8-1461168480.581075-1500704581', '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 09:42:33 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 09:42:33 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 09:42:33 INFO - Using env: {'DISPLAY': ':0', 09:42:33 INFO - 'HOME': '/home/cltbld', 09:42:33 INFO - 'LANG': 'en_US.UTF-8', 09:42:33 INFO - 'LANGUAGE': 'en_US:en', 09:42:33 INFO - 'LOGNAME': 'cltbld', 09:42:33 INFO - 'MAIL': '/var/mail/cltbld', 09:42:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:42:33 INFO - 'MOZ_NO_REMOTE': '1', 09:42:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:42:33 INFO - 'NO_EM_RESTART': '1', 09:42:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:42:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:42:33 INFO - 'PWD': '/builds/slave/test', 09:42:33 INFO - 'SHELL': '/bin/bash', 09:42:33 INFO - 'SHLVL': '1', 09:42:33 INFO - 'TERM': 'linux', 09:42:33 INFO - 'TMOUT': '86400', 09:42:33 INFO - 'USER': 'cltbld', 09:42:33 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1461168480.581075-1500704581', 09:42:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:42:33 INFO - '_': '/tools/buildbot/bin/python'} 09:42:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:42:33 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 09:42:33 INFO - Cleaning up... 09:42:33 INFO - Return code: 0 09:42:33 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 09:42:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:42:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:42:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:42:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:42:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:42:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:42:33 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 0x7fb154121f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bcb5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c5a410>, '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 0x2c5b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c5b7a0>, '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': '52faae308a556c440401f8e5000001e8-1461168480.581075-1500704581', '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 09:42:33 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 09:42:33 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 09:42:33 INFO - Using env: {'DISPLAY': ':0', 09:42:33 INFO - 'HOME': '/home/cltbld', 09:42:33 INFO - 'LANG': 'en_US.UTF-8', 09:42:33 INFO - 'LANGUAGE': 'en_US:en', 09:42:33 INFO - 'LOGNAME': 'cltbld', 09:42:33 INFO - 'MAIL': '/var/mail/cltbld', 09:42:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:42:33 INFO - 'MOZ_NO_REMOTE': '1', 09:42:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:42:33 INFO - 'NO_EM_RESTART': '1', 09:42:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:42:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:42:33 INFO - 'PWD': '/builds/slave/test', 09:42:33 INFO - 'SHELL': '/bin/bash', 09:42:33 INFO - 'SHLVL': '1', 09:42:33 INFO - 'TERM': 'linux', 09:42:33 INFO - 'TMOUT': '86400', 09:42:33 INFO - 'USER': 'cltbld', 09:42:33 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1461168480.581075-1500704581', 09:42:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:42:33 INFO - '_': '/tools/buildbot/bin/python'} 09:42:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:42:34 INFO - Downloading/unpacking psutil>=0.7.1 09:42:34 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 09:42:34 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 09:42:34 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 09:42:34 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 09:42:34 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 09:42:34 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 09:42:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:42:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:42:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:42:37 INFO - Installing collected packages: psutil 09:42:37 INFO - Running setup.py install for psutil 09:42:37 INFO - building 'psutil._psutil_linux' extension 09:42:37 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 09:42:37 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 09:42:37 INFO - building 'psutil._psutil_posix' extension 09:42:37 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 09:42:37 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 09:42:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:42:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:42:37 INFO - Successfully installed psutil 09:42:37 INFO - Cleaning up... 09:42:37 INFO - Return code: 0 09:42:37 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 09:42: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')]} 09:42:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:42:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:42: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')]} 09:42:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:42:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:42:37 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 0x7fb154121f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bcb5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c5a410>, '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 0x2c5b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c5b7a0>, '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': '52faae308a556c440401f8e5000001e8-1461168480.581075-1500704581', '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 09:42:37 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 09:42:37 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 09:42:37 INFO - Using env: {'DISPLAY': ':0', 09:42:37 INFO - 'HOME': '/home/cltbld', 09:42:37 INFO - 'LANG': 'en_US.UTF-8', 09:42:37 INFO - 'LANGUAGE': 'en_US:en', 09:42:37 INFO - 'LOGNAME': 'cltbld', 09:42:37 INFO - 'MAIL': '/var/mail/cltbld', 09:42:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:42:37 INFO - 'MOZ_NO_REMOTE': '1', 09:42:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:42:37 INFO - 'NO_EM_RESTART': '1', 09:42:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:42:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:42:37 INFO - 'PWD': '/builds/slave/test', 09:42:37 INFO - 'SHELL': '/bin/bash', 09:42:37 INFO - 'SHLVL': '1', 09:42:37 INFO - 'TERM': 'linux', 09:42:37 INFO - 'TMOUT': '86400', 09:42:37 INFO - 'USER': 'cltbld', 09:42:37 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1461168480.581075-1500704581', 09:42:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:42:37 INFO - '_': '/tools/buildbot/bin/python'} 09:42:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:42:37 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:42:37 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 09:42:37 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 09:42:37 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 09:42:37 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 09:42:37 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 09:42:37 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 09:42:39 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:42:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:42:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:42:40 INFO - Installing collected packages: mozsystemmonitor 09:42:40 INFO - Running setup.py install for mozsystemmonitor 09:42:40 INFO - Successfully installed mozsystemmonitor 09:42:40 INFO - Cleaning up... 09:42:40 INFO - Return code: 0 09:42:40 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:42: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')]} 09:42:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:42:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:42: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')]} 09:42:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:42:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:42:40 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 0x7fb154121f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bcb5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c5a410>, '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 0x2c5b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c5b7a0>, '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': '52faae308a556c440401f8e5000001e8-1461168480.581075-1500704581', '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 09:42:40 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 09:42:40 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 09:42:40 INFO - Using env: {'DISPLAY': ':0', 09:42:40 INFO - 'HOME': '/home/cltbld', 09:42:40 INFO - 'LANG': 'en_US.UTF-8', 09:42:40 INFO - 'LANGUAGE': 'en_US:en', 09:42:40 INFO - 'LOGNAME': 'cltbld', 09:42:40 INFO - 'MAIL': '/var/mail/cltbld', 09:42:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:42:40 INFO - 'MOZ_NO_REMOTE': '1', 09:42:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:42:40 INFO - 'NO_EM_RESTART': '1', 09:42:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:42:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:42:40 INFO - 'PWD': '/builds/slave/test', 09:42:40 INFO - 'SHELL': '/bin/bash', 09:42:40 INFO - 'SHLVL': '1', 09:42:40 INFO - 'TERM': 'linux', 09:42:40 INFO - 'TMOUT': '86400', 09:42:40 INFO - 'USER': 'cltbld', 09:42:40 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1461168480.581075-1500704581', 09:42:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:42:40 INFO - '_': '/tools/buildbot/bin/python'} 09:42:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:42:40 INFO - Downloading/unpacking blobuploader==1.2.4 09:42:40 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 09:42:40 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 09:42:40 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 09:42:40 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 09:42:40 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 09:42:40 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 09:42:42 INFO - Downloading blobuploader-1.2.4.tar.gz 09:42:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:42:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:42:42 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 09:42:42 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 09:42:42 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 09:42:42 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 09:42:42 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 09:42:42 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 09:42:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:42:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:42:42 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 09:42:42 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 09:42:42 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 09:42:42 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 09:42:42 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 09:42:42 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 09:42:42 INFO - Downloading docopt-0.6.1.tar.gz 09:42:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:42:43 INFO - Installing collected packages: blobuploader, requests, docopt 09:42:43 INFO - Running setup.py install for blobuploader 09:42:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:42:43 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:42:43 INFO - Running setup.py install for requests 09:42:43 INFO - Running setup.py install for docopt 09:42:43 INFO - Successfully installed blobuploader requests docopt 09:42:43 INFO - Cleaning up... 09:42:43 INFO - Return code: 0 09:42:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:42:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:42:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:42:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:42:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:42:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:42:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:42:43 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 0x7fb154121f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bcb5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c5a410>, '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 0x2c5b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c5b7a0>, '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': '52faae308a556c440401f8e5000001e8-1461168480.581075-1500704581', '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 09:42:43 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 09:42:43 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 09:42:43 INFO - Using env: {'DISPLAY': ':0', 09:42:43 INFO - 'HOME': '/home/cltbld', 09:42:43 INFO - 'LANG': 'en_US.UTF-8', 09:42:43 INFO - 'LANGUAGE': 'en_US:en', 09:42:43 INFO - 'LOGNAME': 'cltbld', 09:42:43 INFO - 'MAIL': '/var/mail/cltbld', 09:42:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:42:43 INFO - 'MOZ_NO_REMOTE': '1', 09:42:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:42:43 INFO - 'NO_EM_RESTART': '1', 09:42:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:42:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:42:43 INFO - 'PWD': '/builds/slave/test', 09:42:43 INFO - 'SHELL': '/bin/bash', 09:42:43 INFO - 'SHLVL': '1', 09:42:43 INFO - 'TERM': 'linux', 09:42:43 INFO - 'TMOUT': '86400', 09:42:43 INFO - 'USER': 'cltbld', 09:42:43 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1461168480.581075-1500704581', 09:42:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:42:43 INFO - '_': '/tools/buildbot/bin/python'} 09:42:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:42:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:42:43 INFO - Running setup.py (path:/tmp/pip-zKkkNj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:42:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:42:43 INFO - Running setup.py (path:/tmp/pip-oGi9Mg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:42:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:42:43 INFO - Running setup.py (path:/tmp/pip-XD5a4B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:42:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:42:44 INFO - Running setup.py (path:/tmp/pip-BOCCU0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:42:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:42:44 INFO - Running setup.py (path:/tmp/pip-Rl8gli-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:42:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:42:44 INFO - Running setup.py (path:/tmp/pip-vk7D1l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:42:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:42:44 INFO - Running setup.py (path:/tmp/pip-8IWhwD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:42:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:42:44 INFO - Running setup.py (path:/tmp/pip-C7m8Hc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:42:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:42:44 INFO - Running setup.py (path:/tmp/pip-4Wlx3l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:42:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:42:44 INFO - Running setup.py (path:/tmp/pip-yKVA1p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:42:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:42:44 INFO - Running setup.py (path:/tmp/pip-HGlvNQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:42:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:42:44 INFO - Running setup.py (path:/tmp/pip-qJWgq1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:42:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:42:44 INFO - Running setup.py (path:/tmp/pip-cz9wMj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:42:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:42:44 INFO - Running setup.py (path:/tmp/pip-k4xEP9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:42:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:42:44 INFO - Running setup.py (path:/tmp/pip-k18U2a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:42:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:42:44 INFO - Running setup.py (path:/tmp/pip-fP1Zqd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:42:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:42:44 INFO - Running setup.py (path:/tmp/pip-r7Neri-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:42:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:42:45 INFO - Running setup.py install for manifestparser 09:42:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:42:45 INFO - Running setup.py install for mozcrash 09:42:45 INFO - Running setup.py install for mozdebug 09:42:45 INFO - Running setup.py install for mozdevice 09:42:45 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:42:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:42:45 INFO - Running setup.py install for mozfile 09:42:45 INFO - Running setup.py install for mozhttpd 09:42:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:42:45 INFO - Running setup.py install for mozinfo 09:42:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:42:45 INFO - Running setup.py install for mozInstall 09:42:45 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:42:45 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:42:45 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:42:45 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:42:45 INFO - Running setup.py install for mozleak 09:42:45 INFO - Running setup.py install for mozlog 09:42:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:42:46 INFO - Running setup.py install for moznetwork 09:42:46 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:42:46 INFO - Running setup.py install for mozprocess 09:42:46 INFO - Running setup.py install for mozprofile 09:42:46 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:42:46 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:42:46 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:42:46 INFO - Running setup.py install for mozrunner 09:42:46 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:42:46 INFO - Running setup.py install for mozscreenshot 09:42:46 INFO - Running setup.py install for moztest 09:42:46 INFO - Running setup.py install for mozversion 09:42:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:42:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:42:46 INFO - Cleaning up... 09:42:46 INFO - Return code: 0 09:42:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:42:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:42:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:42:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:42:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:42:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:42:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:42:46 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 0x7fb154121f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bcb5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c5a410>, '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 0x2c5b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c5b7a0>, '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': '52faae308a556c440401f8e5000001e8-1461168480.581075-1500704581', '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 09:42:46 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 09:42:46 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 09:42:46 INFO - Using env: {'DISPLAY': ':0', 09:42:46 INFO - 'HOME': '/home/cltbld', 09:42:46 INFO - 'LANG': 'en_US.UTF-8', 09:42:46 INFO - 'LANGUAGE': 'en_US:en', 09:42:46 INFO - 'LOGNAME': 'cltbld', 09:42:46 INFO - 'MAIL': '/var/mail/cltbld', 09:42:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:42:46 INFO - 'MOZ_NO_REMOTE': '1', 09:42:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:42:46 INFO - 'NO_EM_RESTART': '1', 09:42:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:42:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:42:46 INFO - 'PWD': '/builds/slave/test', 09:42:46 INFO - 'SHELL': '/bin/bash', 09:42:46 INFO - 'SHLVL': '1', 09:42:46 INFO - 'TERM': 'linux', 09:42:46 INFO - 'TMOUT': '86400', 09:42:46 INFO - 'USER': 'cltbld', 09:42:46 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1461168480.581075-1500704581', 09:42:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:42:46 INFO - '_': '/tools/buildbot/bin/python'} 09:42:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:42:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:42:47 INFO - Running setup.py (path:/tmp/pip-FDwuJx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:42:47 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)) 09:42:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:42:47 INFO - Running setup.py (path:/tmp/pip-faQ1yT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:42:47 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)) 09:42:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:42:47 INFO - Running setup.py (path:/tmp/pip-NG8hR9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:42:47 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)) 09:42:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:42:47 INFO - Running setup.py (path:/tmp/pip-Vb_jyX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:42:47 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)) 09:42:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:42:47 INFO - Running setup.py (path:/tmp/pip-OakOmk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:42:47 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)) 09:42:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:42:47 INFO - Running setup.py (path:/tmp/pip-DAic5M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:42:47 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)) 09:42:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:42:47 INFO - Running setup.py (path:/tmp/pip-vJzK_V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:42:47 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)) 09:42:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:42:47 INFO - Running setup.py (path:/tmp/pip-YnYfnM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:42:47 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)) 09:42:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:42:47 INFO - Running setup.py (path:/tmp/pip-yuJ7ax-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:42:47 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)) 09:42:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:42:47 INFO - Running setup.py (path:/tmp/pip-Fh4K2i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:42:47 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)) 09:42:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:42:47 INFO - Running setup.py (path:/tmp/pip-tBVH7j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:42:47 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)) 09:42:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:42:47 INFO - Running setup.py (path:/tmp/pip-wIlveo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:42:47 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)) 09:42:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:42:47 INFO - Running setup.py (path:/tmp/pip-OQJopl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:42:48 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)) 09:42:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:42:48 INFO - Running setup.py (path:/tmp/pip-Ql91BQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:42:48 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)) 09:42:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:42:48 INFO - Running setup.py (path:/tmp/pip-aGgeTI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:42:48 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)) 09:42:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:42:48 INFO - Running setup.py (path:/tmp/pip-02nhyU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:42:48 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)) 09:42:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:42:48 INFO - Running setup.py (path:/tmp/pip-9gYtRS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:42:48 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)) 09:42:48 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)) 09:42:48 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)) 09:42:48 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)) 09:42:48 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)) 09:42:48 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)) 09:42:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:42:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:42:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:42:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:42:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:42:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:42:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:42:50 INFO - Downloading blessings-1.6.tar.gz 09:42:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:42:50 INFO - Installing collected packages: blessings 09:42:50 INFO - Running setup.py install for blessings 09:42:50 INFO - Successfully installed blessings 09:42:50 INFO - Cleaning up... 09:42:50 INFO - Return code: 0 09:42:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:42:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:42:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:42:50 INFO - Reading from file tmpfile_stdout 09:42:50 INFO - Current package versions: 09:42:50 INFO - argparse == 1.2.1 09:42:50 INFO - blessings == 1.6 09:42:50 INFO - blobuploader == 1.2.4 09:42:50 INFO - docopt == 0.6.1 09:42:50 INFO - manifestparser == 1.1 09:42:50 INFO - mozInstall == 1.12 09:42:50 INFO - mozcrash == 0.17 09:42:50 INFO - mozdebug == 0.1 09:42:50 INFO - mozdevice == 0.48 09:42:50 INFO - mozfile == 1.2 09:42:50 INFO - mozhttpd == 0.7 09:42:50 INFO - mozinfo == 0.9 09:42:50 INFO - mozleak == 0.1 09:42:50 INFO - mozlog == 3.1 09:42:50 INFO - moznetwork == 0.27 09:42:50 INFO - mozprocess == 0.22 09:42:50 INFO - mozprofile == 0.28 09:42:50 INFO - mozrunner == 6.11 09:42:50 INFO - mozscreenshot == 0.1 09:42:50 INFO - mozsystemmonitor == 0.0 09:42:50 INFO - moztest == 0.7 09:42:50 INFO - mozversion == 1.4 09:42:50 INFO - psutil == 3.1.1 09:42:50 INFO - requests == 1.2.3 09:42:50 INFO - wsgiref == 0.1.2 09:42:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:42:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:42:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:42:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:42:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:42:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:42:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:42:50 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 0x7fb154121f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bcb5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c5a410>, '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 0x2c5b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c5b7a0>, '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': '52faae308a556c440401f8e5000001e8-1461168480.581075-1500704581', '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 09:42:50 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 09:42:50 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 09:42:50 INFO - Using env: {'DISPLAY': ':0', 09:42:50 INFO - 'HOME': '/home/cltbld', 09:42:50 INFO - 'LANG': 'en_US.UTF-8', 09:42:50 INFO - 'LANGUAGE': 'en_US:en', 09:42:50 INFO - 'LOGNAME': 'cltbld', 09:42:50 INFO - 'MAIL': '/var/mail/cltbld', 09:42:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:42:50 INFO - 'MOZ_NO_REMOTE': '1', 09:42:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:42:50 INFO - 'NO_EM_RESTART': '1', 09:42:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:42:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:42:50 INFO - 'PWD': '/builds/slave/test', 09:42:50 INFO - 'SHELL': '/bin/bash', 09:42:50 INFO - 'SHLVL': '1', 09:42:50 INFO - 'TERM': 'linux', 09:42:50 INFO - 'TMOUT': '86400', 09:42:50 INFO - 'USER': 'cltbld', 09:42:50 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1461168480.581075-1500704581', 09:42:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:42:50 INFO - '_': '/tools/buildbot/bin/python'} 09:42:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:42:50 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)) 09:42:50 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)) 09:42:50 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)) 09:42:50 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)) 09:42:50 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)) 09:42:50 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)) 09:42:50 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)) 09:42:50 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)) 09:42:50 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)) 09:42:50 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)) 09:42:50 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)) 09:42:50 INFO - Cleaning up... 09:42:50 INFO - Return code: 0 09:42:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:42:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:42:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:42:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:42:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:42:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:42:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:42:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb154121f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bcb5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c5a410>, '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 0x2c5b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c5b7a0>, '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': '52faae308a556c440401f8e5000001e8-1461168480.581075-1500704581', '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 09:42:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:42:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:42:50 INFO - Using env: {'DISPLAY': ':0', 09:42:50 INFO - 'HOME': '/home/cltbld', 09:42:50 INFO - 'LANG': 'en_US.UTF-8', 09:42:50 INFO - 'LANGUAGE': 'en_US:en', 09:42:50 INFO - 'LOGNAME': 'cltbld', 09:42:50 INFO - 'MAIL': '/var/mail/cltbld', 09:42:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:42:50 INFO - 'MOZ_NO_REMOTE': '1', 09:42:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:42:50 INFO - 'NO_EM_RESTART': '1', 09:42:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:42:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:42:50 INFO - 'PWD': '/builds/slave/test', 09:42:50 INFO - 'SHELL': '/bin/bash', 09:42:50 INFO - 'SHLVL': '1', 09:42:50 INFO - 'TERM': 'linux', 09:42:50 INFO - 'TMOUT': '86400', 09:42:50 INFO - 'USER': 'cltbld', 09:42:50 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1461168480.581075-1500704581', 09:42:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:42:50 INFO - '_': '/tools/buildbot/bin/python'} 09:42:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:42:51 INFO - Downloading/unpacking jsonschema 09:42:51 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 09:42:51 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 09:42:51 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 09:42:51 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 09:42:51 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 09:42:51 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 09:42:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:42:52 INFO - Downloading/unpacking functools32 (from jsonschema) 09:42:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:42:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:42:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:42:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:42:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:42:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:42:53 INFO - Downloading functools32-3.2.3-2.tar.gz 09:42:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:42:53 INFO - warning: no files found matching '*.txt' 09:42:53 INFO - no previously-included directories found matching 'build' 09:42:53 INFO - no previously-included directories found matching 'dist' 09:42:53 INFO - no previously-included directories found matching '.git*' 09:42:53 INFO - Installing collected packages: jsonschema, functools32 09:42:53 INFO - Running setup.py install for functools32 09:42:53 INFO - warning: no files found matching '*.txt' 09:42:53 INFO - no previously-included directories found matching 'build' 09:42:53 INFO - no previously-included directories found matching 'dist' 09:42:53 INFO - no previously-included directories found matching '.git*' 09:42:53 INFO - Successfully installed jsonschema functools32 09:42:53 INFO - Cleaning up... 09:42:53 INFO - Return code: 0 09:42:53 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:42:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:42:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:42:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:42:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:42:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:42:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:42:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb154121f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bcb5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c5a410>, '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 0x2c5b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c5b7a0>, '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': '52faae308a556c440401f8e5000001e8-1461168480.581075-1500704581', '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 09:42:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 09:42:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 09:42:53 INFO - Using env: {'DISPLAY': ':0', 09:42:53 INFO - 'HOME': '/home/cltbld', 09:42:53 INFO - 'LANG': 'en_US.UTF-8', 09:42:53 INFO - 'LANGUAGE': 'en_US:en', 09:42:53 INFO - 'LOGNAME': 'cltbld', 09:42:53 INFO - 'MAIL': '/var/mail/cltbld', 09:42:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:42:53 INFO - 'MOZ_NO_REMOTE': '1', 09:42:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:42:53 INFO - 'NO_EM_RESTART': '1', 09:42:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:42:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:42:53 INFO - 'PWD': '/builds/slave/test', 09:42:53 INFO - 'SHELL': '/bin/bash', 09:42:53 INFO - 'SHLVL': '1', 09:42:53 INFO - 'TERM': 'linux', 09:42:53 INFO - 'TMOUT': '86400', 09:42:53 INFO - 'USER': 'cltbld', 09:42:53 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1461168480.581075-1500704581', 09:42:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:42:53 INFO - '_': '/tools/buildbot/bin/python'} 09:42:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:42:53 INFO - Downloading/unpacking flake8 09:42:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:42:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:42:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:42:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:42:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:42:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:42:55 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:42:55 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:42:55 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 09:42:55 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 09:42:55 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 09:42:55 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 09:42:55 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 09:42:55 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 09:42:55 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:42:55 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:42:55 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 09:42:55 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 09:42:55 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 09:42:55 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 09:42:55 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 09:42:55 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 09:42:55 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:42:55 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 09:42:55 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 09:42:55 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 09:42:55 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 09:42:55 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 09:42:55 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 09:42:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:42:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:42:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:42:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:42:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:42:56 INFO - no previously-included directories found matching 'docs/_build' 09:42:56 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:42:56 INFO - Running setup.py install for pep8 09:42:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:42:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:42:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:42:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:42:56 INFO - no previously-included directories found matching 'docs/_build' 09:42:56 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:42:56 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:42:56 INFO - Cleaning up... 09:42:56 INFO - Return code: 0 09:42:56 INFO - Running post-action listener: _resource_record_post_action 09:42:56 INFO - Running post-action listener: _start_resource_monitoring 09:42:56 INFO - Starting resource monitoring. 09:42:56 INFO - ##### 09:42:56 INFO - ##### Running install step. 09:42:56 INFO - ##### 09:42:56 INFO - Running pre-action listener: _resource_record_pre_action 09:42:56 INFO - Running main action method: install 09:42:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:42:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:42:56 INFO - Reading from file tmpfile_stdout 09:42:56 INFO - Detecting whether we're running mozinstall >=1.0... 09:42:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:42:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:42:56 INFO - Reading from file tmpfile_stdout 09:42:56 INFO - Output received: 09:42:56 INFO - Usage: mozinstall [options] installer 09:42:56 INFO - Options: 09:42:56 INFO - -h, --help show this help message and exit 09:42:56 INFO - -d DEST, --destination=DEST 09:42:56 INFO - Directory to install application into. [default: 09:42:56 INFO - "/builds/slave/test"] 09:42:56 INFO - --app=APP Application being installed. [default: firefox] 09:42:56 INFO - mkdir: /builds/slave/test/build/application 09:42:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:42:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 09:43:12 INFO - Reading from file tmpfile_stdout 09:43:12 INFO - Output received: 09:43:12 INFO - /builds/slave/test/build/application/firefox/firefox 09:43:12 INFO - Running post-action listener: _resource_record_post_action 09:43:12 INFO - ##### 09:43:12 INFO - ##### Running run-tests step. 09:43:12 INFO - ##### 09:43:12 INFO - Running pre-action listener: _resource_record_pre_action 09:43:12 INFO - Running main action method: run_tests 09:43:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:43:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:43:12 INFO - Python 2.7.3 09:43:12 INFO - Return code: 0 09:43:12 INFO - grabbing minidump binary from tooltool 09:43: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')]} 09:43:12 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 0x2c5a410>, '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 0x2c5b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c5b7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:43:12 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 09:43:12 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 09:43:12 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:43:12 INFO - Return code: 0 09:43:12 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:43:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:43:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:43:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:43:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:43:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:43:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:43:13 INFO - Return code: 0 09:43:13 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/LKau8BlwT1GzWNTbDpQpIg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--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 09:43:13 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/LKau8BlwT1GzWNTbDpQpIg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-056 --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 09:43:13 INFO - Using env: {'DISPLAY': ':0', 09:43:13 INFO - 'HOME': '/home/cltbld', 09:43:13 INFO - 'LANG': 'en_US.UTF-8', 09:43:13 INFO - 'LANGUAGE': 'en_US:en', 09:43:13 INFO - 'LOGNAME': 'cltbld', 09:43:13 INFO - 'MAIL': '/var/mail/cltbld', 09:43:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:43:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:43:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:43:13 INFO - 'MOZ_NO_REMOTE': '1', 09:43:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:43:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:43:13 INFO - 'NO_EM_RESTART': '1', 09:43:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:43:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:43:13 INFO - 'PWD': '/builds/slave/test', 09:43:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:43:13 INFO - 'SHELL': '/bin/bash', 09:43:13 INFO - 'SHLVL': '1', 09:43:13 INFO - 'TERM': 'linux', 09:43:13 INFO - 'TMOUT': '86400', 09:43:13 INFO - 'USER': 'cltbld', 09:43:13 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1461168480.581075-1500704581', 09:43:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:43:13 INFO - '_': '/tools/buildbot/bin/python'} 09:43:13 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/LKau8BlwT1GzWNTbDpQpIg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--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 09:43:13 INFO - mozversion application_buildid: 20160420092238 09:43:13 INFO - mozversion application_changeset: 70bbd2e42d9df60dbb792e4e225e6bd2d67097af 09:43:13 INFO - mozversion application_display_name: Nightly 09:43:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:43:13 INFO - mozversion application_name: Firefox 09:43:13 INFO - mozversion application_remotingname: firefox 09:43:13 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 09:43:13 INFO - mozversion application_vendor: Mozilla 09:43:13 INFO - mozversion application_version: 48.0a1 09:43:13 INFO - mozversion platform_buildid: 20160420092238 09:43:13 INFO - mozversion platform_changeset: 70bbd2e42d9df60dbb792e4e225e6bd2d67097af 09:43:13 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 09:43:13 INFO - mozversion platform_version: 48.0a1 09:43:13 INFO - using testdate: 1461170593 09:43:13 INFO - actual date: 1461170593 09:43:13 INFO - starting webserver on 'localhost:47188' 09:43:13 INFO - SUITE-START | Running 2 tests 09:43:13 INFO - TEST-START | dromaeo_css 09:43:13 INFO - operating with platform_type : linux_ 09:43:13 INFO - Initialising browser for dromaeo_css test... 09:43:13 INFO - TEST-INFO | started process 3862 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0RM29K/profile http://localhost:47188/getInfo.html) 09:43:19 INFO - PROCESS | 3862 | __metrics Screen width/height:1600/1200 09:43:19 INFO - PROCESS | 3862 | colorDepth:24 09:43:19 INFO - PROCESS | 3862 | Browser inner width/height: 1024/697 09:43:19 INFO - PROCESS | 3862 | __metrics 09:43:20 ERROR - PROCESS | 3862 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 09:43:21 INFO - TEST-INFO | 3862: exit 0 09:43:21 INFO - Browser initialized. 09:43:21 INFO - Running cycle 1/1 for dromaeo_css test... 09:43:21 INFO - TEST-INFO | started process 3943 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0RM29K/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:43:33 INFO - PROCESS | 3943 | RSS: Main: 159490048 09:43:33 INFO - PROCESS | 3943 | 09:44:25 INFO - PROCESS | 3943 | 1461170665193 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] 09:46:36 INFO - PROCESS | 3943 | Cycle 1(1): loaded http://localhost:47188/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47188/tests/dromaeo/cssquery-ext.html) 09:46:37 INFO - PROCESS | 3943 | RSS: Main: 242868224 09:46:37 INFO - PROCESS | 3943 | 09:49:40 INFO - PROCESS | 3943 | Cycle 1(1): loaded http://localhost:47188/tests/dromaeo/cssquery-ext.html (next: http://localhost:47188/tests/dromaeo/cssquery-jquery.html) 09:49:40 INFO - PROCESS | 3943 | RSS: Main: 236818432 09:49:40 INFO - PROCESS | 3943 | 09:52:43 INFO - PROCESS | 3943 | Cycle 1(1): loaded http://localhost:47188/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47188/tests/dromaeo/cssquery-mootools.html) 09:52:43 INFO - PROCESS | 3943 | RSS: Main: 245633024 09:52:43 INFO - PROCESS | 3943 | 09:55:45 INFO - PROCESS | 3943 | Cycle 1(1): loaded http://localhost:47188/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47188/tests/dromaeo/cssquery-prototype.html) 09:55:46 INFO - PROCESS | 3943 | RSS: Main: 239079424 09:55:46 INFO - PROCESS | 3943 | 09:58:49 INFO - PROCESS | 3943 | Cycle 1(1): loaded http://localhost:47188/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47188/tests/dromaeo/cssquery-yui.html) 09:58:50 INFO - PROCESS | 3943 | RSS: Main: 209063936 09:58:50 INFO - PROCESS | 3943 | 10:01:52 INFO - PROCESS | 3943 | Cycle 1(1): loaded http://localhost:47188/tests/dromaeo/cssquery-yui.html (next: http://localhost:47188/tests/dromaeo/cssquery-dojo.html) 10:01:52 INFO - PROCESS | 3943 | RSS: Main: 270524416 10:01:52 INFO - PROCESS | 3943 | 10:01:52 INFO - PROCESS | 3943 | __start_tp_report 10:01:52 INFO - PROCESS | 3943 | _x_x_mozilla_page_load 10:01:52 INFO - PROCESS | 3943 | _x_x_mozilla_page_load_details 10:01:52 INFO - PROCESS | 3943 | |i|pagename|runs| 10:01:52 INFO - PROCESS | 3943 | |0;dojo.html;2599.428125812321;2629.6318515407834;2635.5519561674514;2659.4548117635886;2671.906483273085;4547.681662283641;4581.88545286368;4655.7439340836245;4676.602488788453;4727.385439892813;4657.301404789283;4668.113058518888;4729.8817529561775;4762.7618619069;4768.856934291968;4250.851220207293;4291.63521100706;4329.307310830268;4349.195398851207;4381.3208952612395;4253.468316460442;4318.69769116162;4338.80682812226;4344.370066340379;4408.493023302329;4145.461090058303;4214.346776249656;4252.128313695685;4293.763842988635;4294.4202532658;4293.463317085364;4345.087531618364;4349.3041113421705;4351.129774045172;4414.448193975753;4258.127083947814;4272.4445822042935;4282.421873047161;4290.69965102443;4336.6530677545725;4345.326474396474;4456.46522417312;4473.105378924228;4578.977105114486;4603.286490593963;5062.341895553592;5080.974595127038;5091.465396133427;5096.337476128117;5125.84622461323;5073.137566613685;5094.184930411154;5124.461931497213;5126.641135120543;5126.974365128188;4587.6788624795945;4683.81264749413;4764.237721964504;4770.928436073462;4777.593904518155;5150.536451719363;5154.355705536808;5159.974200129051;5172.741362931838;5214.556762675139;4953.851384458472;4956.677815941952;4960.652754307236;4966.751662416865;4998.4251811042195;4854.927176092361;4969.950300496948;5051.570616497639;5067.189249720027;5070.543651071422;4996.675216110941;5010.098182327143;5014.824481143142;5022.397312322545;5067.493250674903;5004.299398084271;5004.47805751819;5011.398632164163;5021.5229553192385;5045.142325804622;3851.268259030775;3906.0820707133803;3911.47195128654;3911.8630847920185;3914.158455931988;3460.2906404187083;3483.3729928613093;3483.407820670492;3497.755157139027;3498.352804731133;4320.071184695243;4360.280553708666;4400.075984043387;4444.200043992112;4452.065066336106;5082.085224659597;5111.821086261963;5114.923276150861;5125.308083408767;5163.741812909415;4264.7654379009455;4376.715513491613;4383.430154080013;4397.714148580332;4425.911481770411;4456.398386217819;4487.6634252431195;4490.932636010462;4529.977350113294;4539.273716205391;4774.092922344744;4780.45024822136;4782.856514304576;4785.186518291829;4820.204666230033;4885.731284779229;4976.377952755905;5059.924101138559;5073.518015788494;5106.412762532208;4797.160496912957;4816.831410900601;4824.517548245148;4840.370751802243;4889.877753056202;4992.425871024879;5001.624878134082;5005.074061298671;5005.4744251853035;5051.621128415457;4860.489648586848;5015.673981191211;5089.745512724423;5135.101357262539;5143.871403214949;4923.08922849274;4948.703077815343;4983.476734942924;4993.750312484434;5016.799328026838;4856.39295088114;4857.878553036202;4861.927071093865;4866.9269960949905;4909.386326709161;4654.837080702159;4791;4803.519648035169;4811.302361157683;4816.735079570657;4811.7834697438;4833.758312084311;4846.176150054429;4851;4880.536349046835;4776.665633405628;4785.736784476887;4796.20862557688;4798.2082956311815;4839.491853355347 10:01:52 INFO - PROCESS | 3943 | |1;ext.html;577.6736144078595;595.7587177193237;605.7637521366665;613.7790395457636;635.4884318123911;26834.731652683466;27376.86311568442;27398.72601273984;27456.588151177748;27502;27679.446411071767;33483.49774753381;33735.83132084336;35421;36017.279654406964;7610.999999999986;7804.609769511501;7810.218978102201;7817.1791961843755;7820.257075577811;7404;7580.962095189544;7708.498947568418;7709.1134519530415;7718.807029824243;9561.426314421122;10017.699469015904;10036.749081272954;10038.498075096253;10043.69868903934;9535.618575257016;9668.226541876704;9675.70972870815;9685.757856053584;9694.951525242399;9496.097870702271;9628.47043412612;9649.517524123836;9653.517324133836;9672.56473458696;34476.310473790385;34825.65174348275;34874.65125348739;37889;38005;2250.628646273363;2382.4163080045328;2724.441489494649;3198.2484116232667;3299.4390953537954;25939.610905836427;27916.720832791616;28126.437471250665;28175.577366339523;28389.858050709616;3320.169957510622;3503.877364292263;3514.841832117561;3515.0860776198115;3594.155373487228;206384;207049;207783;208207;208368.95815520978;49518.50481495139;49754.502454975714;49910.50089499058;49925;49992;52373.214401784004;52786;52800.47199528032;52857.47142528526;52946.73526632342;13802;14212.786808197885;14258.714825703635;14292.428302867977;14297.571072867831;10859.619913302997;10922.890771092187;10957.780844383067;10975;10997.900209978938;13965.301734913417;15755.763663545056;16016.359345626044;16610.50168494947;16766.161691915357;5618.460369966976;5650.208970744099;5674.432556744375;5746.109353050284;5850.0932355484965;865.1262225152641;881.991180088191;954.2747511891013;987.5407935309971;1002.0080120680474;27389.570978043215;27589.31026724308;28011.579826302623;28224.399143333136;28503.14490565286;975.858500517421;978.4080631218153;981.4356744871727;998.510729742421;1037.7301901505664;14653.413863445343;14866.554003379915;14889.255537223096;15202.239888005555;15214.923925380303;344448;489083;500313;500452;503829;45412.77293613511;45823.541764582595;45827;45832.541674582826;45946.31080533795;1196.9760604787855;1264.2161859647078;1275.6874565731455;1284.5632484954974;1307.3920626908343;26322.341941451617;26990.865045675433;27302.317442064108;27779;27808.58287125654;38915.61084389233;39395;39429.2114157721;39495.802520987214;39688.206235874546;258081;260180;260705;260785;261350;24586;24736.876315618305;25398.873005634854;25492;25516;33107.172320692174;39744.40383394309;41448.58551414568;41623.37564936589;42419.151616968105;30062;30435.391292174474;30867.65968640988;31184.22039449032;31264.21839454032;31021.844890775403;31127;31315;31492.685073148976;31576.526352105197;31202.21994450157;31308.060758177293;31681.524777128823;31718.524222137148;33037;29631;30121.849390752905;30148.24629384283;30407.84796076094;30531.847340763154;23811.76188238165;23887.52224955526;23940.83717782196;24211.273661790176;24461.266162015167 10:01:52 INFO - PROCESS | 3943 | |2;jquery.html;374.4832131658312;385.89966608681743;387.44401783440765;391.84130427176984;403.67100812837515;15642.29609667565;16728.83271167288;16850.157492125407;16856.325746970106;16906.74639880403;15538.689226215498;16260.105694186816;16435.753463698024;16446.506604801874;16472.505824825275;4568.817247310112;4706.647001474886;4735.597474214679;4738.3603213566075;4739.5497427744485;3428.588569371679;4992.800287988476;5319.867003324909;5323.281357016792;5326.813561525348;5367.087595108841;5382.165764306539;5385.3268341457315;5387.434319396466;5411.323584551931;5259.079661059319;5319.5744340452675;5356.946430535684;5357.464253574651;5368.651037682557;4957.058158949788;4963.726995015273;5175.870603234912;5176.896462070775;5184.118699821001;12426.875731242753;12476.126671133025;12573.37133143339;12580.182288151242;12596.937015314865;1840.3098837935775;1947.4547126804518;1970.8718933269292;1971.447994561525;2001.4395969128668;8920.73237802867;8974.955125224398;9260.351775375726;9406.482643454607;9653.372530785547;1727.956801079983;1741.651669666072;1746.5284373219288;1779.4572655340116;1803.323753592403;65894.3410565893;68649;69239.3076069243;70613.64693176502;73276;10145.492725363702;10216.182705383551;10294.330868493524;10308.32995855267;10533.473326333806;14584.708305833823;14712.411503539952;14715.632109197355;14746.778798318033;14760;6775.695093720795;6996.720131194696;7046.1192350956135;7159.713611455483;7164.104486939133;6560.737570497222;6599.505037122235;6626.966865165643;6735.158105236846;6742.325767423316;4474.0604473060375;4475.4181956345465;4481.775911204427;4489.236829738952;4539.863804085882;1726.4216487476585;1745.6919138232977;1752.3353384458992;1780.323477078702;1925.7303977443169;861.4099341950783;862.5126803356084;944.9133496479104;956.7368973532195;987.2792861211356;16225.756613650805;16739.414120505724;16798.244079016473;17279.91360043192;17305.134743262788;868.7176667583061;869.1438932651333;870.9777073554754;889.2663552569156;918.3158546882615;9340.159385655188;9419.387739797028;9510.38182518148;9586.185174260267;9597.616095356108;395225;405087;407066;407119;409559;77897;82245;82824;83240;83960.58019709862;886.4105369929053;906.8549032154824;909.940853844498;924;925.606617187706;14865.256737163314;14963.326650300545;15089.149615447861;15178.468753593572;15197.164155971528;33890.32219355649;34185.658143418244;34523;34687.306253875286;35109.47335790016;44985.550144498135;48534;50638.49361506338;51653.22520162276;51956.48043519516;7675.961620191863;7685.807854803675;7721;7732.265434783687;7770.766876993699;11721.531138754355;11868.82196767032;11932.28406295625;11942.104342174545;11957.76084478323;10270.33242839213;10425.635102771366;10533.578656853946;10557.52491137916;10716.285394336868;9954.900450995397;10209.74475638115;10335.896641033494;10349.586016559253;10432.739181520523;10088.092071713581;10214.846777298495;10311.22665800053;10699.144068474348;10881.401522916316;7656.69373225087;7695.384369250559;7727.729529466442;7784.182660820532;7847.764567062997;9576.138147566753;10224.834592393674;10295.485225738832;10400.427976461368;10698.946505267424 10:01:52 INFO - PROCESS | 3943 | |3;mootools.html;1268.0616343905513;1414.0949792133033;1471.051171994064;1546.4664690681718;1754.0966402302815;7129.42964562835;7358.117025956893;7384.889226661591;7398.630068496581;7403.814904627387;7183.245759195288;7272.163701174367;7276.45426593005;7282.271772822715;7377.778666639996;1889.1687657430755;2156.385430152407;2167.328128280234;2196.8901554922268;2240.3390999655057;2221.255879280435;2247.314569056437;2247.6179049561533;2249.1453247765908;2251;2188.2669305782583;2243.5737209930144;2251.144565065273;2253.853499522534;2256.6953461282683;1885.453218566614;2165.4478108082494;2222.0445208560313;2228.186711850179;2229.9665505017274;2086.426232785981;2101.0545254635476;2109;2109.789021097893;2116.534362440261;7567.583782891938;7670.7343288357915;7686.692532298702;7702.807429814244;7703;4528.479224889114;4677.6257899367965;4685.484596694361;4700.271457923993;4743.715377077387;2946.778991575619;2997.8950736724328;3042.6196725409322;3095.5820964169775;3099.0392978176837;964.6671898195111;971.9514024298757;984.7685793838442;995.5470261031213;1005.9849102263472;10667.253292269545;10679.466026698634;10683.03852653265;10693.144548436107;10697.358158510515;4195.328747400401;4210.0948296116485;4322.610965013164;4328.199283132631;4384.978075109604;8226.095129535746;8281.503109813431;8319.875201871977;8331.250187483156;8365.539895305696;4060.1067765091634;4634.351190833286;4641.744704041243;4656.604188644003;4681.485036645966;4211.831526738957;4333.631641310524;4339.305711086211;4354.9782251088545;4360.106178233455;3653.963460365362;3704.407294832814;3778.112143646241;3804.771713697187;3815.751976121543;1217.6712287682276;1255.7174635706892;1262.5896583610363;1271.7583659104741;1274.9936250318874;888.9688860889838;903.1600611431301;927.7170463008712;932.0772435289015;936.1855185988234;5383.488568585978;5580.246666700024;5585.497305242548;5603.243562119062;5697.173909783141;838.6896848166095;928.3176865004217;936.4615346175976;940;947.8957314695516;3526.206603514189;3574.4102223133414;3576.803275819855;3585.229175727231;3617.2946275476556;9314.48770317639;9685.467299298465;9811.901880981242;9819.852702209473;9842.704718858446;9643.08390702882;9653.420794752337;9691.854622180674;9701.17540009093;9721.222302215805;7217.8917316240295;7252;7277.417806575461;7401.037865077397;7413.406927445899;5223.3209682741;5296.311479507639;5307.548858347083;5309.256704061511;5440.211169380497;8781.121887811423;8859.06979767115;8938.46369217849;8947.239484643878;8980.910190898006;8381.664733410838;8633.05036445978;8634.395592308478;8752.081031491602;8991.325650576102;5839.182514447895;6321.33625969285;6445.613263204223;6790.25307216196;6902.413294869993;7344.779656610311;7382;7440.181580026301;7441.181470038399;7451;6616.338366163345;6887.965560172167;6905.654717264017;6940.930590694028;7008.088948436671;6643.069970204272;6684.665766711742;6810.761623343159;6829;6894.689738961659;6008.459238668541;6347.936520634919;6375.713092910737;6417.454516365974;6452.451541619015;4636.211843986598;4683.578477937002;4728.290756386432;4783.832565860178;4802.471728109836;4570.977145114386;4673.906521869611;4740.170470167775;4746.762661866824;4813.855584332476 10:01:52 INFO - PROCESS | 3943 | |4;prototype.html;307.970742779436;310.7622668658476;310.98134111953283;313.8493523108907;315.3267773303995;4961.20620700688;5032.622553308498;5036.798528058874;5052.141136006879;5057.418396884359;5000.324956130921;5005.224190250517;5013.14776487997;5018.749062546867;5041.571466425358;3719.5536535615697;3771.5474143102865;3922.3722155305513;3946.3883098119836;3951.4072889066583;3893.1240470894104;3915.451836742844;3923.2349691809964;3934.645881870631;3956.723029387944;3718.107654162995;3888.9222215555674;3895.7078219133537;3905.1408690088133;3911.3350730375905;3786.75386099904;3903.1413089120347;3903.551091624471;3912.2762288976487;3915.451836742858;3424.7260219182403;3465.9480107798404;3467.601225859008;3474.5656792900886;3486.337595856779;4819.156647586693;4821.54195351441;4842.273658951185;4854.878628034292;4864.537868902448;4187.14163596465;4475.328700694922;4477.50011238703;4477.507474177838;4495.303227999665;5279.577633789288;5284.154535274376;5284.313039304904;5286.788528458857;5308.256844041837;3727.7204209684382;3742.36379815432;3743.7566558173903;3745.569259535161;3749.8312575934146;5229.607779416559;5461.1262198048125;5522.723863806834;5550.361708403545;5561.77752889884;3731.7574357666663;3779.508663873734;3781.0925377909653;3819.255245227154;3821.082940094357;3851.4993050903204;3855;3862.6909847212155;3863.343231650626;3868.5357757069332;4274.914501710011;4425.911481770347;4430.623397011225;4435.401220835211;4444.422225110779;5279.208118782213;5279.630425870152;5316.76074576645;5322.175062865262;5330.38700549434;1315.6908126590245;1337.4516448256168;1346.1788309131423;1348.892088632907;1349.1230700045048;858.8668756342777;878.3236907581254;898.3397203055749;910.3263584947091;916.5279880861361;4611.608013318905;4620.376249206314;4643.303504474356;4663.930041049387;4665.370175026396;5355.3841308249275;5381.569474442035;5389.137737961907;5406.54044406222;5413.593980451482;4483.529229430928;4621.468531118897;4623.653226008063;4628.83799067031;4648.511906249795;2868.153894601098;2872.4775868789575;2873.281679580105;2887.119428574305;2889.479893619127;5084.567811736044;5095.745212739423;5097.719625420564;5108.846734597968;5115.130427827204;5304.814331498456;5518.889622207534;5532.3637781655625;5631.887362252732;5673.262475878109;5182.8963420732125;5186.247994040843;5187.714675692873;5202.271681964528;5221.242919776611;5488.506034456918;5494.340679118532;5499.862503437286;5505.834824955257;5519.530839878495;5226.764795584132;5376.56987440996;5384.973075134756;5398.031082904466;5404.54061404785;5152.098382782923;5155.664881782672;5190.403103642979;5198.142306519382;5202.323697919246;3791.4123310886857;3809.847606095836;3851.9229615406975;3864.401017842239;3868.845246190121;5355.9464405357;5426.077566813572;5463.125899856004;5502.284702988586;5518.813455107172;5252.949410117915;5284.731664400593;5303.2840566524565;5303.973480132575;5308.548773354154;5104.642675012714;5222.3472065991755;5261.4738526147075;5280.788768449219;5302.575793936553;5188.325517682677;5220.7650655721345;5226.268322434938;5251.2123181523075;5252.553532949589;5065.620078494054;5124.948750512447;5341.41244463101;5350.983313170485;5367.973160134175;5175.637705360588;5184.170532714747;5202.271681964604;5212.843614691566;5230.320058392384 10:01:52 INFO - PROCESS | 3943 | |5;yui.html;722.967466464009;729.1541811498663;729.6096588325246;760.0803028335712;762.3900879296561;11303;11429.54281828727;11615.419229038556;11677.883221167785;11686.766264674712;11000.064994475459;11033.83449248262;11055.889441105586;11068.225224234307;11075.612353567627;633.9461145802612;776.2819392062348;808.4704518540351;808.5957021489255;815.5759005317232;798.9480683755567;804.8551260773058;809.3727361294984;809.6032943857497;810.4893916832388;857.5326447086321;862.4307956748547;863.3481721300409;863.6588547523725;864.7967727584013;667.9966600166993;824.9133840946674;848.2747251100344;848.4527479775572;857.7512521368795;621.9844503887393;623.3454872383978;623.7567348733998;623.9095331176954;624.3350831364583;11502.137339699557;11521.827172592419;11528.538858445652;11553.30680159193;11578.189526733133;12537.561185358469;13030.609081727564;13051;13069.215847049207;13171.275579843104;10055.69832905014;10076.093151616316;10221.591136354537;11259.97350360088;11526;4251.256030194703;4323.200207961506;4366.235908715994;4526.79629416677;4533.229351010336;46971.29543056857;48279.75860120712;48736.75631621855;48793.268100978516;48952.51047489515;9913.603455861685;10509.847045886203;10524.421156836448;10710.73223169427;11058.834117488244;17914.46256612304;18156.27374904989;18162.909185453987;18187.54531136732;18233.7264941026;6829.112215411965;6834.940584209456;6871.312868713088;6923.792286231421;6936.965315173392;3640.381135207021;3732.8260620577266;3801.82891769871;3859.517560304962;3904.082540602956;2730.440259746747;2832.277769168849;2835.773138148943;2836.8297902125937;2843.928901777472;516.8423630792569;517.6350672775684;518.7795187045491;531.4658767938197;546.4890327543759;471.3165909431338;501.6663918494161;569.4391024840529;614.1800696070795;633.882731694638;7542.47202695817;7911.960440197762;7984.245435324804;8065;8119.959400202961;533.941266460689;561.8904313658879;564.0411300788676;604.8397174748695;616.9475594574421;3565.6790888820133;3648.21563363878;3755.1926335837925;3811.104390468238;3841.8271177796505;52635;52873.7356313216;53449.198262026104;53541.1968820468;53622.73188634032;45698.5726070546;45874.311885321746;46154;46545;47225.05549889052;42515.57484425116;42963.35554966678;42982.57017429848;43142.568574314486;43952;7315.890261645973;7442.813929651802;7469.365103966224;7482.326590606654;7506.099268087864;28424.289392765346;28573.42853142884;29119.563206552342;29382;29416.852915735286;35195.648043519235;35671;38817.805910970266;38921;39307.213855722155;9913.629744878588;9927.801443971224;9982.301238913205;9995.400275983464;10104.393736375841;10466.110380617733;10662.626808061681;10731.839022414513;10880.727981800519;11198.608048718255;8978.147076027766;9109.97723993275;9320.906790932275;9905.950470247602;9929.304948653526;10025;10105;10117.494125293853;10243.38539687621;10344.534495947852;9122.680706175517;9274.44353338802;9379.155875971195;9428.669996550088;10123.79752404933;8011.959940200261;8013.2387423194705;8086.1913808618665;8242;8394.11861754507;7895.933139839696;7988.161243069627;8014.519128852287;8439.240468357877;8486.15138486171 10:01:52 INFO - PROCESS | 3943 | __end_tp_report 10:01:52 INFO - PROCESS | 3943 | __start_cc_report 10:01:52 INFO - PROCESS | 3943 | _x_x_mozilla_cycle_collect,882 10:01:52 INFO - PROCESS | 3943 | __end_cc_report 10:01:52 INFO - PROCESS | 3943 | __startTimestamp1461171712876__endTimestamp 10:01:52 INFO - PROCESS | 3943 | 10:01:52 INFO - PROCESS | 3943 | ------- Summary: start ------- 10:01:52 INFO - PROCESS | 3943 | Number of tests: 6 10:01:52 INFO - PROCESS | 3943 | 10:01:52 INFO - PROCESS | 3943 | [#0] dojo.html Cycles:165 Average:4631.83 Median:4791.00 stddev:521.79 (10.9%) stddev-sans-first:498.43 10:01:52 INFO - PROCESS | 3943 | Values: 2599.4 2629.6 2635.6 2659.5 2671.9 4547.7 4581.9 4655.7 4676.6 4727.4 4657.3 4668.1 4729.9 4762.8 4768.9 4250.9 4291.6 4329.3 4349.2 4381.3 4253.5 4318.7 4338.8 4344.4 4408.5 4145.5 4214.3 4252.1 4293.8 4294.4 4293.5 4345.1 4349.3 4351.1 4414.4 4258.1 4272.4 4282.4 4290.7 4336.7 4345.3 4456.5 4473.1 4579.0 4603.3 5062.3 5081.0 5091.5 5096.3 5125.8 5073.1 5094.2 5124.5 5126.6 5127.0 4587.7 4683.8 4764.2 4770.9 4777.6 5150.5 5154.4 5160.0 5172.7 5214.6 4953.9 4956.7 4960.7 4966.8 4998.4 4854.9 4970.0 5051.6 5067.2 5070.5 4996.7 5010.1 5014.8 5022.4 5067.5 5004.3 5004.5 5011.4 5021.5 5045.1 3851.3 3906.1 3911.5 3911.9 3914.2 3460.3 3483.4 3483.4 3497.8 3498.4 4320.1 4360.3 4400.1 4444.2 4452.1 5082.1 5111.8 5114.9 5125.3 5163.7 4264.8 4376.7 4383.4 4397.7 4425.9 4456.4 4487.7 4490.9 4530.0 4539.3 4774.1 4780.5 4782.9 4785.2 4820.2 4885.7 4976.4 5059.9 5073.5 5106.4 4797.2 4816.8 4824.5 4840.4 4889.9 4992.4 5001.6 5005.1 5005.5 5051.6 4860.5 5015.7 5089.7 5135.1 5143.9 4923.1 4948.7 4983.5 4993.8 5016.8 4856.4 4857.9 4861.9 4866.9 4909.4 4654.8 4791.0 4803.5 4811.3 4816.7 4811.8 4833.8 4846.2 4851.0 4880.5 4776.7 4785.7 4796.2 4798.2 4839.5 10:01:52 INFO - PROCESS | 3943 | 10:01:52 INFO - PROCESS | 3943 | [#1] ext.html Cycles:180 Average:45327.98 Median:31534.61 stddev:88687.78 (281.2%) stddev-sans-first:88872.92 10:01:52 INFO - PROCESS | 3943 | Values: 577.7 595.8 605.8 613.8 635.5 26834.7 27376.9 27398.7 27456.6 27502.0 27679.4 33483.5 33735.8 35421.0 36017.3 7611.0 7804.6 7810.2 7817.2 7820.3 7404.0 7581.0 7708.5 7709.1 7718.8 9561.4 10017.7 10036.7 10038.5 10043.7 9535.6 9668.2 9675.7 9685.8 9695.0 9496.1 9628.5 9649.5 9653.5 9672.6 34476.3 34825.7 34874.7 37889.0 38005.0 2250.6 2382.4 2724.4 3198.2 3299.4 25939.6 27916.7 28126.4 28175.6 28389.9 3320.2 3503.9 3514.8 3515.1 3594.2 206384.0 207049.0 207783.0 208207.0 208369.0 49518.5 49754.5 49910.5 49925.0 49992.0 52373.2 52786.0 52800.5 52857.5 52946.7 13802.0 14212.8 14258.7 14292.4 14297.6 10859.6 10922.9 10957.8 10975.0 10997.9 13965.3 15755.8 16016.4 16610.5 16766.2 5618.5 5650.2 5674.4 5746.1 5850.1 865.1 882.0 954.3 987.5 1002.0 27389.6 27589.3 28011.6 28224.4 28503.1 975.9 978.4 981.4 998.5 1037.7 14653.4 14866.6 14889.3 15202.2 15214.9 344448.0 489083.0 500313.0 500452.0 503829.0 45412.8 45823.5 45827.0 45832.5 45946.3 1197.0 1264.2 1275.7 1284.6 1307.4 26322.3 26990.9 27302.3 27779.0 27808.6 38915.6 39395.0 39429.2 39495.8 39688.2 258081.0 260180.0 260705.0 260785.0 261350.0 24586.0 24736.9 25398.9 25492.0 25516.0 33107.2 39744.4 41448.6 41623.4 42419.2 30062.0 30435.4 30867.7 31184.2 31264.2 31021.8 31127.0 31315.0 31492.7 31576.5 31202.2 31308.1 31681.5 31718.5 33037.0 29631.0 30121.8 30148.2 30407.8 30531.8 23811.8 23887.5 23940.8 24211.3 24461.3 10:01:52 INFO - PROCESS | 3943 | 10:01:52 INFO - PROCESS | 3943 | [#2] jquery.html Cycles:180 Average:24510.35 Median:4478.60 stddev:66883.61 (1493.4%) stddev-sans-first:67046.69 10:01:52 INFO - PROCESS | 3943 | Values: 374.5 385.9 387.4 391.8 403.7 15642.3 16728.8 16850.2 16856.3 16906.7 15538.7 16260.1 16435.8 16446.5 16472.5 4568.8 4706.6 4735.6 4738.4 4739.5 3428.6 4992.8 5319.9 5323.3 5326.8 5367.1 5382.2 5385.3 5387.4 5411.3 5259.1 5319.6 5356.9 5357.5 5368.7 4957.1 4963.7 5175.9 5176.9 5184.1 12426.9 12476.1 12573.4 12580.2 12596.9 1840.3 1947.5 1970.9 1971.4 2001.4 8920.7 8975.0 9260.4 9406.5 9653.4 1728.0 1741.7 1746.5 1779.5 1803.3 65894.3 68649.0 69239.3 70613.6 73276.0 10145.5 10216.2 10294.3 10308.3 10533.5 14584.7 14712.4 14715.6 14746.8 14760.0 6775.7 6996.7 7046.1 7159.7 7164.1 6560.7 6599.5 6627.0 6735.2 6742.3 4474.1 4475.4 4481.8 4489.2 4539.9 1726.4 1745.7 1752.3 1780.3 1925.7 861.4 862.5 944.9 956.7 987.3 16225.8 16739.4 16798.2 17279.9 17305.1 868.7 869.1 871.0 889.3 918.3 9340.2 9419.4 9510.4 9586.2 9597.6 395225.0 405087.0 407066.0 407119.0 409559.0 77897.0 82245.0 82824.0 83240.0 83960.6 886.4 906.9 909.9 924.0 925.6 14865.3 14963.3 15089.1 15178.5 15197.2 33890.3 34185.7 34523.0 34687.3 35109.5 44985.6 48534.0 50638.5 51653.2 51956.5 7676.0 7685.8 7721.0 7732.3 7770.8 11721.5 11868.8 11932.3 11942.1 11957.8 10270.3 10425.6 10533.6 10557.5 10716.3 9954.9 10209.7 10335.9 10349.6 10432.7 10088.1 10214.8 10311.2 10699.1 10881.4 7656.7 7695.4 7727.7 7784.2 7847.8 9576.1 10224.8 10295.5 10400.4 10698.9 10:01:52 INFO - PROCESS | 3943 | 10:01:52 INFO - PROCESS | 3943 | [#3] mootools.html Cycles:180 Average:5119.44 Median:5411.85 stddev:2798.79 (51.7%) stddev-sans-first:2791.68 10:01:52 INFO - PROCESS | 3943 | Values: 1268.1 1414.1 1471.1 1546.5 1754.1 7129.4 7358.1 7384.9 7398.6 7403.8 7183.2 7272.2 7276.5 7282.3 7377.8 1889.2 2156.4 2167.3 2196.9 2240.3 2221.3 2247.3 2247.6 2249.1 2251.0 2188.3 2243.6 2251.1 2253.9 2256.7 1885.5 2165.4 2222.0 2228.2 2230.0 2086.4 2101.1 2109.0 2109.8 2116.5 7567.6 7670.7 7686.7 7702.8 7703.0 4528.5 4677.6 4685.5 4700.3 4743.7 2946.8 2997.9 3042.6 3095.6 3099.0 964.7 972.0 984.8 995.5 1006.0 10667.3 10679.5 10683.0 10693.1 10697.4 4195.3 4210.1 4322.6 4328.2 4385.0 8226.1 8281.5 8319.9 8331.3 8365.5 4060.1 4634.4 4641.7 4656.6 4681.5 4211.8 4333.6 4339.3 4355.0 4360.1 3654.0 3704.4 3778.1 3804.8 3815.8 1217.7 1255.7 1262.6 1271.8 1275.0 889.0 903.2 927.7 932.1 936.2 5383.5 5580.2 5585.5 5603.2 5697.2 838.7 928.3 936.5 940.0 947.9 3526.2 3574.4 3576.8 3585.2 3617.3 9314.5 9685.5 9811.9 9819.9 9842.7 9643.1 9653.4 9691.9 9701.2 9721.2 7217.9 7252.0 7277.4 7401.0 7413.4 5223.3 5296.3 5307.5 5309.3 5440.2 8781.1 8859.1 8938.5 8947.2 8980.9 8381.7 8633.1 8634.4 8752.1 8991.3 5839.2 6321.3 6445.6 6790.3 6902.4 7344.8 7382.0 7440.2 7441.2 7451.0 6616.3 6888.0 6905.7 6940.9 7008.1 6643.1 6684.7 6810.8 6829.0 6894.7 6008.5 6347.9 6375.7 6417.5 6452.5 4636.2 4683.6 4728.3 4783.8 4802.5 4571.0 4673.9 4740.2 4746.8 4813.9 10:01:52 INFO - PROCESS | 3943 | 10:01:52 INFO - PROCESS | 3943 | [#4] prototype.html Cycles:180 Average:4377.00 Median:5034.71 stddev:1280.88 (25.4%) stddev-sans-first:1247.53 10:01:52 INFO - PROCESS | 3943 | Values: 308.0 310.8 311.0 313.8 315.3 4961.2 5032.6 5036.8 5052.1 5057.4 5000.3 5005.2 5013.1 5018.7 5041.6 3719.6 3771.5 3922.4 3946.4 3951.4 3893.1 3915.5 3923.2 3934.6 3956.7 3718.1 3888.9 3895.7 3905.1 3911.3 3786.8 3903.1 3903.6 3912.3 3915.5 3424.7 3465.9 3467.6 3474.6 3486.3 4819.2 4821.5 4842.3 4854.9 4864.5 4187.1 4475.3 4477.5 4477.5 4495.3 5279.6 5284.2 5284.3 5286.8 5308.3 3727.7 3742.4 3743.8 3745.6 3749.8 5229.6 5461.1 5522.7 5550.4 5561.8 3731.8 3779.5 3781.1 3819.3 3821.1 3851.5 3855.0 3862.7 3863.3 3868.5 4274.9 4425.9 4430.6 4435.4 4444.4 5279.2 5279.6 5316.8 5322.2 5330.4 1315.7 1337.5 1346.2 1348.9 1349.1 858.9 878.3 898.3 910.3 916.5 4611.6 4620.4 4643.3 4663.9 4665.4 5355.4 5381.6 5389.1 5406.5 5413.6 4483.5 4621.5 4623.7 4628.8 4648.5 2868.2 2872.5 2873.3 2887.1 2889.5 5084.6 5095.7 5097.7 5108.8 5115.1 5304.8 5518.9 5532.4 5631.9 5673.3 5182.9 5186.2 5187.7 5202.3 5221.2 5488.5 5494.3 5499.9 5505.8 5519.5 5226.8 5376.6 5385.0 5398.0 5404.5 5152.1 5155.7 5190.4 5198.1 5202.3 3791.4 3809.8 3851.9 3864.4 3868.8 5355.9 5426.1 5463.1 5502.3 5518.8 5252.9 5284.7 5303.3 5304.0 5308.5 5104.6 5222.3 5261.5 5280.8 5302.6 5188.3 5220.8 5226.3 5251.2 5252.6 5065.6 5124.9 5341.4 5351.0 5368.0 5175.6 5184.2 5202.3 5212.8 5230.3 10:01:52 INFO - PROCESS | 3943 | 10:01:52 INFO - PROCESS | 3943 | [#5] yui.html Cycles:180 Average:12593.44 Median:48872.89 stddev:14653.90 (30.0%) stddev-sans-first:14667.90 10:01:52 INFO - PROCESS | 3943 | Values: 723.0 729.2 729.6 760.1 762.4 11303.0 11429.5 11615.4 11677.9 11686.8 11000.1 11033.8 11055.9 11068.2 11075.6 633.9 776.3 808.5 808.6 815.6 798.9 804.9 809.4 809.6 810.5 857.5 862.4 863.3 863.7 864.8 668.0 824.9 848.3 848.5 857.8 622.0 623.3 623.8 623.9 624.3 11502.1 11521.8 11528.5 11553.3 11578.2 12537.6 13030.6 13051.0 13069.2 13171.3 10055.7 10076.1 10221.6 11260.0 11526.0 4251.3 4323.2 4366.2 4526.8 4533.2 46971.3 48279.8 48736.8 48793.3 48952.5 9913.6 10509.8 10524.4 10710.7 11058.8 17914.5 18156.3 18162.9 18187.5 18233.7 6829.1 6834.9 6871.3 6923.8 6937.0 3640.4 3732.8 3801.8 3859.5 3904.1 2730.4 2832.3 2835.8 2836.8 2843.9 516.8 517.6 518.8 531.5 546.5 471.3 501.7 569.4 614.2 633.9 7542.5 7912.0 7984.2 8065.0 8120.0 533.9 561.9 564.0 604.8 616.9 3565.7 3648.2 3755.2 3811.1 3841.8 52635.0 52873.7 53449.2 53541.2 53622.7 45698.6 45874.3 46154.0 46545.0 47225.1 42515.6 42963.4 42982.6 43142.6 43952.0 7315.9 7442.8 7469.4 7482.3 7506.1 28424.3 28573.4 29119.6 29382.0 29416.9 35195.6 35671.0 38817.8 38921.0 39307.2 9913.6 9927.8 9982.3 9995.4 10104.4 10466.1 10662.6 10731.8 10880.7 11198.6 8978.1 9110.0 9320.9 9906.0 9929.3 10025.0 10105.0 10117.5 10243.4 10344.5 9122.7 9274.4 9379.2 9428.7 10123.8 8012.0 8013.2 8086.2 8242.0 8394.1 7895.9 7988.2 8014.5 8439.2 8486.2 10:01:52 INFO - PROCESS | 3943 | -------- Summary: end -------- 10:01:52 INFO - PROCESS | 3943 | 10:01:53 INFO - TEST-INFO | 3943: exit 0 10:01:53 INFO - TEST-OK | dromaeo_css | took 1119848ms 10:01:53 INFO - TEST-START | kraken 10:01:53 INFO - operating with platform_type : linux_ 10:01:53 INFO - Initialising browser for kraken test... 10:01:53 INFO - TEST-INFO | started process 4119 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpa996EE/profile http://localhost:47188/getInfo.html) 10:01:58 INFO - PROCESS | 4119 | __metrics Screen width/height:1600/1200 10:01:58 INFO - PROCESS | 4119 | colorDepth:24 10:01:58 INFO - PROCESS | 4119 | Browser inner width/height: 1024/697 10:01:58 INFO - PROCESS | 4119 | __metrics 10:01:59 ERROR - PROCESS | 4119 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:02:00 INFO - TEST-INFO | 4119: exit 0 10:02:00 INFO - Browser initialized. 10:02:00 INFO - Running cycle 1/1 for kraken test... 10:02:00 INFO - TEST-INFO | started process 4202 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpa996EE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:02:12 INFO - PROCESS | 4202 | RSS: Main: 154918912 10:02:12 INFO - PROCESS | 4202 | 10:02:15 INFO - PROCESS | 4202 | Cycle 1(1): loaded http://localhost:47188/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47188/tests/kraken/driver.html?testName=audio-beat-detection) 10:02:16 INFO - PROCESS | 4202 | RSS: Main: 209907712 10:02:16 INFO - PROCESS | 4202 | 10:02:19 INFO - PROCESS | 4202 | Cycle 1(1): loaded http://localhost:47188/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47188/tests/kraken/driver.html?testName=audio-dft) 10:02:19 INFO - PROCESS | 4202 | RSS: Main: 195346432 10:02:19 INFO - PROCESS | 4202 | 10:02:22 INFO - PROCESS | 4202 | Cycle 1(1): loaded http://localhost:47188/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47188/tests/kraken/driver.html?testName=audio-fft) 10:02:23 INFO - PROCESS | 4202 | RSS: Main: 266842112 10:02:23 INFO - PROCESS | 4202 | 10:02:25 INFO - PROCESS | 4202 | Cycle 1(1): loaded http://localhost:47188/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47188/tests/kraken/driver.html?testName=audio-oscillator) 10:02:26 INFO - PROCESS | 4202 | RSS: Main: 174796800 10:02:26 INFO - PROCESS | 4202 | 10:02:28 INFO - PROCESS | 4202 | Cycle 1(1): loaded http://localhost:47188/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47188/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:02:29 INFO - PROCESS | 4202 | RSS: Main: 178700288 10:02:29 INFO - PROCESS | 4202 | 10:02:32 INFO - PROCESS | 4202 | Cycle 1(1): loaded http://localhost:47188/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47188/tests/kraken/driver.html?testName=imaging-darkroom) 10:02:32 INFO - PROCESS | 4202 | RSS: Main: 215183360 10:02:32 INFO - PROCESS | 4202 | 10:02:36 INFO - PROCESS | 4202 | Cycle 1(1): loaded http://localhost:47188/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47188/tests/kraken/driver.html?testName=imaging-desaturate) 10:02:36 INFO - PROCESS | 4202 | RSS: Main: 215318528 10:02:36 INFO - PROCESS | 4202 | 10:02:39 INFO - PROCESS | 4202 | Cycle 1(1): loaded http://localhost:47188/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47188/tests/kraken/driver.html?testName=json-parse-financial) 10:02:40 INFO - PROCESS | 4202 | RSS: Main: 216502272 10:02:40 INFO - PROCESS | 4202 | 10:02:42 INFO - PROCESS | 4202 | Cycle 1(1): loaded http://localhost:47188/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47188/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:02:42 INFO - PROCESS | 4202 | RSS: Main: 202620928 10:02:42 INFO - PROCESS | 4202 | 10:02:44 INFO - PROCESS | 4202 | Cycle 1(1): loaded http://localhost:47188/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47188/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:02:45 INFO - PROCESS | 4202 | RSS: Main: 204795904 10:02:45 INFO - PROCESS | 4202 | 10:02:47 INFO - PROCESS | 4202 | Cycle 1(1): loaded http://localhost:47188/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47188/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:02:47 INFO - PROCESS | 4202 | RSS: Main: 216989696 10:02:47 INFO - PROCESS | 4202 | 10:02:50 INFO - PROCESS | 4202 | Cycle 1(1): loaded http://localhost:47188/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47188/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:02:51 INFO - PROCESS | 4202 | RSS: Main: 224858112 10:02:51 INFO - PROCESS | 4202 | 10:02:54 INFO - PROCESS | 4202 | Cycle 1(1): loaded http://localhost:47188/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47188/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:02:54 INFO - PROCESS | 4202 | RSS: Main: 221466624 10:02:54 INFO - PROCESS | 4202 | 10:02:56 INFO - PROCESS | 4202 | Cycle 1(1): loaded http://localhost:47188/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47188/tests/kraken/driver.html?testName=ai-astar) 10:02:56 INFO - PROCESS | 4202 | RSS: Main: 284827648 10:02:56 INFO - PROCESS | 4202 | 10:02:56 INFO - PROCESS | 4202 | __start_tp_report 10:02:56 INFO - PROCESS | 4202 | _x_x_mozilla_page_load 10:02:56 INFO - PROCESS | 4202 | _x_x_mozilla_page_load_details 10:02:56 INFO - PROCESS | 4202 | |i|pagename|runs| 10:02:56 INFO - PROCESS | 4202 | |0;ai-astar;112;116;109;114;113;116;103;114;113;114 10:02:56 INFO - PROCESS | 4202 | |1;audio-beat-detection;165;132;157;185;138;165;170;132;190;132 10:02:56 INFO - PROCESS | 4202 | |2;audio-dft;163;160;162;162;163;163;163;162;162;161 10:02:56 INFO - PROCESS | 4202 | |3;audio-fft;75;75;110;112;75;73;74;116;113;75 10:02:56 INFO - PROCESS | 4202 | |4;audio-oscillator;95;98;148;94;95;95;146;96;95;140 10:02:56 INFO - PROCESS | 4202 | |5;imaging-gaussian-blur;117;117;117;117;117;116;117;117;117;116 10:02:56 INFO - PROCESS | 4202 | |6;imaging-darkroom;146;146;145;147;146;147;152;148;147;147 10:02:56 INFO - PROCESS | 4202 | |7;imaging-desaturate;95;94;95;95;95;94;95;94;95;94 10:02:56 INFO - PROCESS | 4202 | |8;json-parse-financial;66;63;64;65;63;65;65;79;62;61 10:02:56 INFO - PROCESS | 4202 | |9;json-stringify-tinderbox;66;65;65;65;66;66;66;67;67;71 10:02:56 INFO - PROCESS | 4202 | |10;stanford-crypto-aes;79;79;79;79;80;80;81;81;80;81 10:02:56 INFO - PROCESS | 4202 | |11;stanford-crypto-ccm;137;132;135;145;131;131;131;137;171;133 10:02:56 INFO - PROCESS | 4202 | |12;stanford-crypto-pbkdf2;179;182;171;170;172;172;173;171;173;171 10:02:56 INFO - PROCESS | 4202 | |13;stanford-crypto-sha256-iterative;74;78;72;73;73;75;73;70;72;73 10:02:56 INFO - PROCESS | 4202 | __end_tp_report 10:02:56 INFO - PROCESS | 4202 | __start_cc_report 10:02:56 INFO - PROCESS | 4202 | _x_x_mozilla_cycle_collect,1903 10:02:56 INFO - PROCESS | 4202 | __end_cc_report 10:02:56 INFO - PROCESS | 4202 | __startTimestamp1461171776867__endTimestamp 10:02:56 INFO - PROCESS | 4202 | 10:02:56 INFO - PROCESS | 4202 | ------- Summary: start ------- 10:02:56 INFO - PROCESS | 4202 | Number of tests: 14 10:02:56 INFO - PROCESS | 4202 | 10:02:56 INFO - PROCESS | 4202 | [#0] ai-astar Cycles:10 Average:112.40 Median:114.00 stddev:3.86 (3.4%) stddev-sans-first:4.10 10:02:56 INFO - PROCESS | 4202 | Values: 112.0 116.0 109.0 114.0 113.0 116.0 103.0 114.0 113.0 114.0 10:02:56 INFO - PROCESS | 4202 | 10:02:56 INFO - PROCESS | 4202 | [#1] audio-beat-detection Cycles:10 Average:156.60 Median:165.00 stddev:22.12 (13.4%) stddev-sans-first:23.25 10:02:56 INFO - PROCESS | 4202 | Values: 165.0 132.0 157.0 185.0 138.0 165.0 170.0 132.0 190.0 132.0 10:02:56 INFO - PROCESS | 4202 | 10:02:56 INFO - PROCESS | 4202 | [#2] audio-dft Cycles:10 Average:162.10 Median:162.50 stddev:0.99 (0.6%) stddev-sans-first:1.00 10:02:56 INFO - PROCESS | 4202 | Values: 163.0 160.0 162.0 162.0 163.0 163.0 163.0 162.0 162.0 161.0 10:02:56 INFO - PROCESS | 4202 | 10:02:56 INFO - PROCESS | 4202 | [#3] audio-fft Cycles:10 Average:89.80 Median:74.50 stddev:19.81 (26.6%) stddev-sans-first:20.28 10:02:56 INFO - PROCESS | 4202 | Values: 75.0 75.0 110.0 112.0 75.0 73.0 74.0 116.0 113.0 75.0 10:02:56 INFO - PROCESS | 4202 | 10:02:56 INFO - PROCESS | 4202 | [#4] audio-oscillator Cycles:10 Average:110.20 Median:95.00 stddev:23.89 (25.1%) stddev-sans-first:24.70 10:02:56 INFO - PROCESS | 4202 | Values: 95.0 98.0 148.0 94.0 95.0 95.0 146.0 96.0 95.0 140.0 10:02:56 INFO - PROCESS | 4202 | 10:02:56 INFO - PROCESS | 4202 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 10:02:56 INFO - PROCESS | 4202 | Values: 117.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 116.0 10:02:56 INFO - PROCESS | 4202 | 10:02:56 INFO - PROCESS | 4202 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:1.91 (1.3%) stddev-sans-first:1.99 10:02:56 INFO - PROCESS | 4202 | Values: 146.0 146.0 145.0 147.0 146.0 147.0 152.0 148.0 147.0 147.0 10:02:56 INFO - PROCESS | 4202 | 10:02:56 INFO - PROCESS | 4202 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 10:02:56 INFO - PROCESS | 4202 | Values: 95.0 94.0 95.0 95.0 95.0 94.0 95.0 94.0 95.0 94.0 10:02:56 INFO - PROCESS | 4202 | 10:02:56 INFO - PROCESS | 4202 | [#8] json-parse-financial Cycles:10 Average:65.30 Median:65.00 stddev:5.06 (7.8%) stddev-sans-first:5.36 10:02:56 INFO - PROCESS | 4202 | Values: 66.0 63.0 64.0 65.0 63.0 65.0 65.0 79.0 62.0 61.0 10:02:56 INFO - PROCESS | 4202 | 10:02:56 INFO - PROCESS | 4202 | [#9] json-stringify-tinderbox Cycles:10 Average:66.40 Median:66.00 stddev:1.78 (2.7%) stddev-sans-first:1.88 10:02:56 INFO - PROCESS | 4202 | Values: 66.0 65.0 65.0 65.0 66.0 66.0 66.0 67.0 67.0 71.0 10:02:56 INFO - PROCESS | 4202 | 10:02:56 INFO - PROCESS | 4202 | [#10] stanford-crypto-aes Cycles:10 Average:79.90 Median:80.00 stddev:0.88 (1.1%) stddev-sans-first:0.87 10:02:56 INFO - PROCESS | 4202 | Values: 79.0 79.0 79.0 79.0 80.0 80.0 81.0 81.0 80.0 81.0 10:02:56 INFO - PROCESS | 4202 | 10:02:56 INFO - PROCESS | 4202 | [#11] stanford-crypto-ccm Cycles:10 Average:138.30 Median:136.00 stddev:12.28 (9.0%) stddev-sans-first:13.01 10:02:56 INFO - PROCESS | 4202 | Values: 137.0 132.0 135.0 145.0 131.0 131.0 131.0 137.0 171.0 133.0 10:02:56 INFO - PROCESS | 4202 | 10:02:56 INFO - PROCESS | 4202 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.40 Median:172.50 stddev:3.92 (2.3%) stddev-sans-first:3.60 10:02:56 INFO - PROCESS | 4202 | Values: 179.0 182.0 171.0 170.0 172.0 172.0 173.0 171.0 173.0 171.0 10:02:56 INFO - PROCESS | 4202 | 10:02:56 INFO - PROCESS | 4202 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.30 Median:73.00 stddev:2.11 (2.9%) stddev-sans-first:2.22 10:02:56 INFO - PROCESS | 4202 | Values: 74.0 78.0 72.0 73.0 73.0 75.0 73.0 70.0 72.0 73.0 10:02:56 INFO - PROCESS | 4202 | -------- Summary: end -------- 10:02:56 INFO - PROCESS | 4202 | 10:02:57 INFO - TEST-INFO | 4202: exit 0 10:02:57 INFO - TEST-OK | kraken | took 64283ms 10:02:57 INFO - SUITE-END | took 1184s 10:02:58 INFO - Completed test suite (00:19:44) 10:02:58 INFO - javascript benchmark 10:02:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2599.428125812321, 2629.6318515407834, 2635.5519561674514, 2659.4548117635886, 2671.906483273085, 4547.681662283641, 4581.88545286368, 4655.7439340836245, 4676.602488788453, 4727.385439892813, 4657.301404789283, 4668.113058518888, 4729.8817529561775, 4762.7618619069, 4768.856934291968, 4250.851220207293, 4291.63521100706, 4329.307310830268, 4349.195398851207, 4381.3208952612395, 4253.468316460442, 4318.69769116162, 4338.80682812226, 4344.370066340379, 4408.493023302329, 4145.461090058303, 4214.346776249656, 4252.128313695685, 4293.763842988635, 4294.4202532658, 4293.463317085364, 4345.087531618364, 4349.3041113421705, 4351.129774045172, 4414.448193975753, 4258.127083947814, 4272.4445822042935, 4282.421873047161, 4290.69965102443, 4336.6530677545725, 4345.326474396474, 4456.46522417312, 4473.105378924228, 4578.977105114486, 4603.286490593963, 5062.341895553592, 5080.974595127038, 5091.465396133427, 5096.337476128117, 5125.84622461323, 5073.137566613685, 5094.184930411154, 5124.461931497213, 5126.641135120543, 5126.974365128188, 4587.6788624795945, 4683.81264749413, 4764.237721964504, 4770.928436073462, 4777.593904518155, 5150.536451719363, 5154.355705536808, 5159.974200129051, 5172.741362931838, 5214.556762675139, 4953.851384458472, 4956.677815941952, 4960.652754307236, 4966.751662416865, 4998.4251811042195, 4854.927176092361, 4969.950300496948, 5051.570616497639, 5067.189249720027, 5070.543651071422, 4996.675216110941, 5010.098182327143, 5014.824481143142, 5022.397312322545, 5067.493250674903, 5004.299398084271, 5004.47805751819, 5011.398632164163, 5021.5229553192385, 5045.142325804622, 3851.268259030775, 3906.0820707133803, 3911.47195128654, 3911.8630847920185, 3914.158455931988, 3460.2906404187083, 3483.3729928613093, 3483.407820670492, 3497.755157139027, 3498.352804731133, 4320.071184695243, 4360.280553708666, 4400.075984043387, 4444.200043992112, 4452.065066336106, 5082.085224659597, 5111.821086261963, 5114.923276150861, 5125.308083408767, 5163.741812909415, 4264.7654379009455, 4376.715513491613, 4383.430154080013, 4397.714148580332, 4425.911481770411, 4456.398386217819, 4487.6634252431195, 4490.932636010462, 4529.977350113294, 4539.273716205391, 4774.092922344744, 4780.45024822136, 4782.856514304576, 4785.186518291829, 4820.204666230033, 4885.731284779229, 4976.377952755905, 5059.924101138559, 5073.518015788494, 5106.412762532208, 4797.160496912957, 4816.831410900601, 4824.517548245148, 4840.370751802243, 4889.877753056202, 4992.425871024879, 5001.624878134082, 5005.074061298671, 5005.4744251853035, 5051.621128415457, 4860.489648586848, 5015.673981191211, 5089.745512724423, 5135.101357262539, 5143.871403214949, 4923.08922849274, 4948.703077815343, 4983.476734942924, 4993.750312484434, 5016.799328026838, 4856.39295088114, 4857.878553036202, 4861.927071093865, 4866.9269960949905, 4909.386326709161, 4654.837080702159, 4791.0, 4803.519648035169, 4811.302361157683, 4816.735079570657, 4811.7834697438, 4833.758312084311, 4846.176150054429, 4851.0, 4880.536349046835, 4776.665633405628, 4785.736784476887, 4796.20862557688, 4798.2082956311815, 4839.491853355347], "value": 4596.652647227921, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [577.6736144078595, 595.7587177193237, 605.7637521366665, 613.7790395457636, 635.4884318123911, 26834.731652683466, 27376.86311568442, 27398.72601273984, 27456.588151177748, 27502.0, 27679.446411071767, 33483.49774753381, 33735.83132084336, 35421.0, 36017.279654406964, 7610.999999999986, 7804.609769511501, 7810.218978102201, 7817.1791961843755, 7820.257075577811, 7404.0, 7580.962095189544, 7708.498947568418, 7709.1134519530415, 7718.807029824243, 9561.426314421122, 10017.699469015904, 10036.749081272954, 10038.498075096253, 10043.69868903934, 9535.618575257016, 9668.226541876704, 9675.70972870815, 9685.757856053584, 9694.951525242399, 9496.097870702271, 9628.47043412612, 9649.517524123836, 9653.517324133836, 9672.56473458696, 34476.310473790385, 34825.65174348275, 34874.65125348739, 37889.0, 38005.0, 2250.628646273363, 2382.4163080045328, 2724.441489494649, 3198.2484116232667, 3299.4390953537954, 25939.610905836427, 27916.720832791616, 28126.437471250665, 28175.577366339523, 28389.858050709616, 3320.169957510622, 3503.877364292263, 3514.841832117561, 3515.0860776198115, 3594.155373487228, 206384.0, 207049.0, 207783.0, 208207.0, 208368.95815520978, 49518.50481495139, 49754.502454975714, 49910.50089499058, 49925.0, 49992.0, 52373.214401784004, 52786.0, 52800.47199528032, 52857.47142528526, 52946.73526632342, 13802.0, 14212.786808197885, 14258.714825703635, 14292.428302867977, 14297.571072867831, 10859.619913302997, 10922.890771092187, 10957.780844383067, 10975.0, 10997.900209978938, 13965.301734913417, 15755.763663545056, 16016.359345626044, 16610.50168494947, 16766.161691915357, 5618.460369966976, 5650.208970744099, 5674.432556744375, 5746.109353050284, 5850.0932355484965, 865.1262225152641, 881.991180088191, 954.2747511891013, 987.5407935309971, 1002.0080120680474, 27389.570978043215, 27589.31026724308, 28011.579826302623, 28224.399143333136, 28503.14490565286, 975.858500517421, 978.4080631218153, 981.4356744871727, 998.510729742421, 1037.7301901505664, 14653.413863445343, 14866.554003379915, 14889.255537223096, 15202.239888005555, 15214.923925380303, 344448.0, 489083.0, 500313.0, 500452.0, 503829.0, 45412.77293613511, 45823.541764582595, 45827.0, 45832.541674582826, 45946.31080533795, 1196.9760604787855, 1264.2161859647078, 1275.6874565731455, 1284.5632484954974, 1307.3920626908343, 26322.341941451617, 26990.865045675433, 27302.317442064108, 27779.0, 27808.58287125654, 38915.61084389233, 39395.0, 39429.2114157721, 39495.802520987214, 39688.206235874546, 258081.0, 260180.0, 260705.0, 260785.0, 261350.0, 24586.0, 24736.876315618305, 25398.873005634854, 25492.0, 25516.0, 33107.172320692174, 39744.40383394309, 41448.58551414568, 41623.37564936589, 42419.151616968105, 30062.0, 30435.391292174474, 30867.65968640988, 31184.22039449032, 31264.21839454032, 31021.844890775403, 31127.0, 31315.0, 31492.685073148976, 31576.526352105197, 31202.21994450157, 31308.060758177293, 31681.524777128823, 31718.524222137148, 33037.0, 29631.0, 30121.849390752905, 30148.24629384283, 30407.84796076094, 30531.847340763154, 23811.76188238165, 23887.52224955526, 23940.83717782196, 24211.273661790176, 24461.266162015167], "value": 16856.787465704587, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [374.4832131658312, 385.89966608681743, 387.44401783440765, 391.84130427176984, 403.67100812837515, 15642.29609667565, 16728.83271167288, 16850.157492125407, 16856.325746970106, 16906.74639880403, 15538.689226215498, 16260.105694186816, 16435.753463698024, 16446.506604801874, 16472.505824825275, 4568.817247310112, 4706.647001474886, 4735.597474214679, 4738.3603213566075, 4739.5497427744485, 3428.588569371679, 4992.800287988476, 5319.867003324909, 5323.281357016792, 5326.813561525348, 5367.087595108841, 5382.165764306539, 5385.3268341457315, 5387.434319396466, 5411.323584551931, 5259.079661059319, 5319.5744340452675, 5356.946430535684, 5357.464253574651, 5368.651037682557, 4957.058158949788, 4963.726995015273, 5175.870603234912, 5176.896462070775, 5184.118699821001, 12426.875731242753, 12476.126671133025, 12573.37133143339, 12580.182288151242, 12596.937015314865, 1840.3098837935775, 1947.4547126804518, 1970.8718933269292, 1971.447994561525, 2001.4395969128668, 8920.73237802867, 8974.955125224398, 9260.351775375726, 9406.482643454607, 9653.372530785547, 1727.956801079983, 1741.651669666072, 1746.5284373219288, 1779.4572655340116, 1803.323753592403, 65894.3410565893, 68649.0, 69239.3076069243, 70613.64693176502, 73276.0, 10145.492725363702, 10216.182705383551, 10294.330868493524, 10308.32995855267, 10533.473326333806, 14584.708305833823, 14712.411503539952, 14715.632109197355, 14746.778798318033, 14760.0, 6775.695093720795, 6996.720131194696, 7046.1192350956135, 7159.713611455483, 7164.104486939133, 6560.737570497222, 6599.505037122235, 6626.966865165643, 6735.158105236846, 6742.325767423316, 4474.0604473060375, 4475.4181956345465, 4481.775911204427, 4489.236829738952, 4539.863804085882, 1726.4216487476585, 1745.6919138232977, 1752.3353384458992, 1780.323477078702, 1925.7303977443169, 861.4099341950783, 862.5126803356084, 944.9133496479104, 956.7368973532195, 987.2792861211356, 16225.756613650805, 16739.414120505724, 16798.244079016473, 17279.91360043192, 17305.134743262788, 868.7176667583061, 869.1438932651333, 870.9777073554754, 889.2663552569156, 918.3158546882615, 9340.159385655188, 9419.387739797028, 9510.38182518148, 9586.185174260267, 9597.616095356108, 395225.0, 405087.0, 407066.0, 407119.0, 409559.0, 77897.0, 82245.0, 82824.0, 83240.0, 83960.58019709862, 886.4105369929053, 906.8549032154824, 909.940853844498, 924.0, 925.606617187706, 14865.256737163314, 14963.326650300545, 15089.149615447861, 15178.468753593572, 15197.164155971528, 33890.32219355649, 34185.658143418244, 34523.0, 34687.306253875286, 35109.47335790016, 44985.550144498135, 48534.0, 50638.49361506338, 51653.22520162276, 51956.48043519516, 7675.961620191863, 7685.807854803675, 7721.0, 7732.265434783687, 7770.766876993699, 11721.531138754355, 11868.82196767032, 11932.28406295625, 11942.104342174545, 11957.76084478323, 10270.33242839213, 10425.635102771366, 10533.578656853946, 10557.52491137916, 10716.285394336868, 9954.900450995397, 10209.74475638115, 10335.896641033494, 10349.586016559253, 10432.739181520523, 10088.092071713581, 10214.846777298495, 10311.22665800053, 10699.144068474348, 10881.401522916316, 7656.69373225087, 7695.384369250559, 7727.729529466442, 7784.182660820532, 7847.764567062997, 9576.138147566753, 10224.834592393674, 10295.485225738832, 10400.427976461368, 10698.946505267424], "value": 8077.466541085894, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1268.0616343905513, 1414.0949792133033, 1471.051171994064, 1546.4664690681718, 1754.0966402302815, 7129.42964562835, 7358.117025956893, 7384.889226661591, 7398.630068496581, 7403.814904627387, 7183.245759195288, 7272.163701174367, 7276.45426593005, 7282.271772822715, 7377.778666639996, 1889.1687657430755, 2156.385430152407, 2167.328128280234, 2196.8901554922268, 2240.3390999655057, 2221.255879280435, 2247.314569056437, 2247.6179049561533, 2249.1453247765908, 2251.0, 2188.2669305782583, 2243.5737209930144, 2251.144565065273, 2253.853499522534, 2256.6953461282683, 1885.453218566614, 2165.4478108082494, 2222.0445208560313, 2228.186711850179, 2229.9665505017274, 2086.426232785981, 2101.0545254635476, 2109.0, 2109.789021097893, 2116.534362440261, 7567.583782891938, 7670.7343288357915, 7686.692532298702, 7702.807429814244, 7703.0, 4528.479224889114, 4677.6257899367965, 4685.484596694361, 4700.271457923993, 4743.715377077387, 2946.778991575619, 2997.8950736724328, 3042.6196725409322, 3095.5820964169775, 3099.0392978176837, 964.6671898195111, 971.9514024298757, 984.7685793838442, 995.5470261031213, 1005.9849102263472, 10667.253292269545, 10679.466026698634, 10683.03852653265, 10693.144548436107, 10697.358158510515, 4195.328747400401, 4210.0948296116485, 4322.610965013164, 4328.199283132631, 4384.978075109604, 8226.095129535746, 8281.503109813431, 8319.875201871977, 8331.250187483156, 8365.539895305696, 4060.1067765091634, 4634.351190833286, 4641.744704041243, 4656.604188644003, 4681.485036645966, 4211.831526738957, 4333.631641310524, 4339.305711086211, 4354.9782251088545, 4360.106178233455, 3653.963460365362, 3704.407294832814, 3778.112143646241, 3804.771713697187, 3815.751976121543, 1217.6712287682276, 1255.7174635706892, 1262.5896583610363, 1271.7583659104741, 1274.9936250318874, 888.9688860889838, 903.1600611431301, 927.7170463008712, 932.0772435289015, 936.1855185988234, 5383.488568585978, 5580.246666700024, 5585.497305242548, 5603.243562119062, 5697.173909783141, 838.6896848166095, 928.3176865004217, 936.4615346175976, 940.0, 947.8957314695516, 3526.206603514189, 3574.4102223133414, 3576.803275819855, 3585.229175727231, 3617.2946275476556, 9314.48770317639, 9685.467299298465, 9811.901880981242, 9819.852702209473, 9842.704718858446, 9643.08390702882, 9653.420794752337, 9691.854622180674, 9701.17540009093, 9721.222302215805, 7217.8917316240295, 7252.0, 7277.417806575461, 7401.037865077397, 7413.406927445899, 5223.3209682741, 5296.311479507639, 5307.548858347083, 5309.256704061511, 5440.211169380497, 8781.121887811423, 8859.06979767115, 8938.46369217849, 8947.239484643878, 8980.910190898006, 8381.664733410838, 8633.05036445978, 8634.395592308478, 8752.081031491602, 8991.325650576102, 5839.182514447895, 6321.33625969285, 6445.613263204223, 6790.25307216196, 6902.413294869993, 7344.779656610311, 7382.0, 7440.181580026301, 7441.181470038399, 7451.0, 6616.338366163345, 6887.965560172167, 6905.654717264017, 6940.930590694028, 7008.088948436671, 6643.069970204272, 6684.665766711742, 6810.761623343159, 6829.0, 6894.689738961659, 6008.459238668541, 6347.936520634919, 6375.713092910737, 6417.454516365974, 6452.451541619015, 4636.211843986598, 4683.578477937002, 4728.290756386432, 4783.832565860178, 4802.471728109836, 4570.977145114386, 4673.906521869611, 4740.170470167775, 4746.762661866824, 4813.855584332476], "value": 4171.966026609977, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [307.970742779436, 310.7622668658476, 310.98134111953283, 313.8493523108907, 315.3267773303995, 4961.20620700688, 5032.622553308498, 5036.798528058874, 5052.141136006879, 5057.418396884359, 5000.324956130921, 5005.224190250517, 5013.14776487997, 5018.749062546867, 5041.571466425358, 3719.5536535615697, 3771.5474143102865, 3922.3722155305513, 3946.3883098119836, 3951.4072889066583, 3893.1240470894104, 3915.451836742844, 3923.2349691809964, 3934.645881870631, 3956.723029387944, 3718.107654162995, 3888.9222215555674, 3895.7078219133537, 3905.1408690088133, 3911.3350730375905, 3786.75386099904, 3903.1413089120347, 3903.551091624471, 3912.2762288976487, 3915.451836742858, 3424.7260219182403, 3465.9480107798404, 3467.601225859008, 3474.5656792900886, 3486.337595856779, 4819.156647586693, 4821.54195351441, 4842.273658951185, 4854.878628034292, 4864.537868902448, 4187.14163596465, 4475.328700694922, 4477.50011238703, 4477.507474177838, 4495.303227999665, 5279.577633789288, 5284.154535274376, 5284.313039304904, 5286.788528458857, 5308.256844041837, 3727.7204209684382, 3742.36379815432, 3743.7566558173903, 3745.569259535161, 3749.8312575934146, 5229.607779416559, 5461.1262198048125, 5522.723863806834, 5550.361708403545, 5561.77752889884, 3731.7574357666663, 3779.508663873734, 3781.0925377909653, 3819.255245227154, 3821.082940094357, 3851.4993050903204, 3855.0, 3862.6909847212155, 3863.343231650626, 3868.5357757069332, 4274.914501710011, 4425.911481770347, 4430.623397011225, 4435.401220835211, 4444.422225110779, 5279.208118782213, 5279.630425870152, 5316.76074576645, 5322.175062865262, 5330.38700549434, 1315.6908126590245, 1337.4516448256168, 1346.1788309131423, 1348.892088632907, 1349.1230700045048, 858.8668756342777, 878.3236907581254, 898.3397203055749, 910.3263584947091, 916.5279880861361, 4611.608013318905, 4620.376249206314, 4643.303504474356, 4663.930041049387, 4665.370175026396, 5355.3841308249275, 5381.569474442035, 5389.137737961907, 5406.54044406222, 5413.593980451482, 4483.529229430928, 4621.468531118897, 4623.653226008063, 4628.83799067031, 4648.511906249795, 2868.153894601098, 2872.4775868789575, 2873.281679580105, 2887.119428574305, 2889.479893619127, 5084.567811736044, 5095.745212739423, 5097.719625420564, 5108.846734597968, 5115.130427827204, 5304.814331498456, 5518.889622207534, 5532.3637781655625, 5631.887362252732, 5673.262475878109, 5182.8963420732125, 5186.247994040843, 5187.714675692873, 5202.271681964528, 5221.242919776611, 5488.506034456918, 5494.340679118532, 5499.862503437286, 5505.834824955257, 5519.530839878495, 5226.764795584132, 5376.56987440996, 5384.973075134756, 5398.031082904466, 5404.54061404785, 5152.098382782923, 5155.664881782672, 5190.403103642979, 5198.142306519382, 5202.323697919246, 3791.4123310886857, 3809.847606095836, 3851.9229615406975, 3864.401017842239, 3868.845246190121, 5355.9464405357, 5426.077566813572, 5463.125899856004, 5502.284702988586, 5518.813455107172, 5252.949410117915, 5284.731664400593, 5303.2840566524565, 5303.973480132575, 5308.548773354154, 5104.642675012714, 5222.3472065991755, 5261.4738526147075, 5280.788768449219, 5302.575793936553, 5188.325517682677, 5220.7650655721345, 5226.268322434938, 5251.2123181523075, 5252.553532949589, 5065.620078494054, 5124.948750512447, 5341.41244463101, 5350.983313170485, 5367.973160134175, 5175.637705360588, 5184.170532714747, 5202.271681964604, 5212.843614691566, 5230.320058392384], "value": 3970.045955454044, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [722.967466464009, 729.1541811498663, 729.6096588325246, 760.0803028335712, 762.3900879296561, 11303.0, 11429.54281828727, 11615.419229038556, 11677.883221167785, 11686.766264674712, 11000.064994475459, 11033.83449248262, 11055.889441105586, 11068.225224234307, 11075.612353567627, 633.9461145802612, 776.2819392062348, 808.4704518540351, 808.5957021489255, 815.5759005317232, 798.9480683755567, 804.8551260773058, 809.3727361294984, 809.6032943857497, 810.4893916832388, 857.5326447086321, 862.4307956748547, 863.3481721300409, 863.6588547523725, 864.7967727584013, 667.9966600166993, 824.9133840946674, 848.2747251100344, 848.4527479775572, 857.7512521368795, 621.9844503887393, 623.3454872383978, 623.7567348733998, 623.9095331176954, 624.3350831364583, 11502.137339699557, 11521.827172592419, 11528.538858445652, 11553.30680159193, 11578.189526733133, 12537.561185358469, 13030.609081727564, 13051.0, 13069.215847049207, 13171.275579843104, 10055.69832905014, 10076.093151616316, 10221.591136354537, 11259.97350360088, 11526.0, 4251.256030194703, 4323.200207961506, 4366.235908715994, 4526.79629416677, 4533.229351010336, 46971.29543056857, 48279.75860120712, 48736.75631621855, 48793.268100978516, 48952.51047489515, 9913.603455861685, 10509.847045886203, 10524.421156836448, 10710.73223169427, 11058.834117488244, 17914.46256612304, 18156.27374904989, 18162.909185453987, 18187.54531136732, 18233.7264941026, 6829.112215411965, 6834.940584209456, 6871.312868713088, 6923.792286231421, 6936.965315173392, 3640.381135207021, 3732.8260620577266, 3801.82891769871, 3859.517560304962, 3904.082540602956, 2730.440259746747, 2832.277769168849, 2835.773138148943, 2836.8297902125937, 2843.928901777472, 516.8423630792569, 517.6350672775684, 518.7795187045491, 531.4658767938197, 546.4890327543759, 471.3165909431338, 501.6663918494161, 569.4391024840529, 614.1800696070795, 633.882731694638, 7542.47202695817, 7911.960440197762, 7984.245435324804, 8065.0, 8119.959400202961, 533.941266460689, 561.8904313658879, 564.0411300788676, 604.8397174748695, 616.9475594574421, 3565.6790888820133, 3648.21563363878, 3755.1926335837925, 3811.104390468238, 3841.8271177796505, 52635.0, 52873.7356313216, 53449.198262026104, 53541.1968820468, 53622.73188634032, 45698.5726070546, 45874.311885321746, 46154.0, 46545.0, 47225.05549889052, 42515.57484425116, 42963.35554966678, 42982.57017429848, 43142.568574314486, 43952.0, 7315.890261645973, 7442.813929651802, 7469.365103966224, 7482.326590606654, 7506.099268087864, 28424.289392765346, 28573.42853142884, 29119.563206552342, 29382.0, 29416.852915735286, 35195.648043519235, 35671.0, 38817.805910970266, 38921.0, 39307.213855722155, 9913.629744878588, 9927.801443971224, 9982.301238913205, 9995.400275983464, 10104.393736375841, 10466.110380617733, 10662.626808061681, 10731.839022414513, 10880.727981800519, 11198.608048718255, 8978.147076027766, 9109.97723993275, 9320.906790932275, 9905.950470247602, 9929.304948653526, 10025.0, 10105.0, 10117.494125293853, 10243.38539687621, 10344.534495947852, 9122.680706175517, 9274.44353338802, 9379.155875971195, 9428.669996550088, 10123.79752404933, 8011.959940200261, 8013.2387423194705, 8086.1913808618665, 8242.0, 8394.11861754507, 7895.933139839696, 7988.161243069627, 8014.519128852287, 8439.240468357877, 8486.15138486171], "value": 5819.133552806253, "unit": "score"}], "name": "dromaeo_css", "value": 6262.610292242068, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 116.0, 109.0, 114.0, 113.0, 116.0, 103.0, 114.0, 113.0, 114.0], "value": 112.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 132.0, 157.0, 185.0, 138.0, 165.0, 170.0, 132.0, 190.0, 132.0], "value": 156.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 160.0, 162.0, 162.0, 163.0, 163.0, 163.0, 162.0, 162.0, 161.0], "value": 162.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 110.0, 112.0, 75.0, 73.0, 74.0, 116.0, 113.0, 75.0], "value": 89.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 98.0, 148.0, 94.0, 95.0, 95.0, 146.0, 96.0, 95.0, 140.0], "value": 110.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 116.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 145.0, 147.0, 146.0, 147.0, 152.0, 148.0, 147.0, 147.0], "value": 147.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 95.0, 94.0, 95.0, 94.0, 95.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 63.0, 64.0, 65.0, 63.0, 65.0, 65.0, 79.0, 62.0, 61.0], "value": 65.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 65.0, 65.0, 66.0, 66.0, 66.0, 67.0, 67.0, 71.0], "value": 66.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 79.0, 79.0, 80.0, 80.0, 81.0, 81.0, 80.0, 81.0], "value": 79.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 132.0, 135.0, 145.0, 131.0, 131.0, 131.0, 137.0, 171.0, 133.0], "value": 138.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 182.0, 171.0, 170.0, 172.0, 172.0, 173.0, 171.0, 173.0, 171.0], "value": 173.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 78.0, 72.0, 73.0, 73.0, 75.0, 73.0, 70.0, 72.0, 73.0], "value": 73.3, "unit": "score"}], "name": "kraken", "value": 1586.2000000000003, "alertThreshold": 2.0}]} 10:02:58 INFO - Return code: 0 10:02:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:02:58 ERROR - # TBPL SUCCESS # 10:02:58 INFO - Running post-action listener: _resource_record_post_action 10:02:58 INFO - Running post-run listener: _resource_record_post_run 10:02:59 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 430080; Write bytes: 303480832; Read time: 72; Write time: 425412 10:02:59 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 16801792; Read time: 0; Write time: 3960 10:02:59 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 430080; Write bytes: 286150656; Read time: 72; Write time: 412004 10:02:59 INFO - Running post-run listener: _upload_blobber_files 10:02:59 INFO - Blob upload gear active. 10:02:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:02:59 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 10:02:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:02:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:02:59 INFO - (blobuploader) - INFO - Open directory for files ... 10:02:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:02:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:02:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:03:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:03:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:03:00 INFO - (blobuploader) - INFO - Done attempting. 10:03:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:03:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:03:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:03:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:03:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:03:01 INFO - (blobuploader) - INFO - Done attempting. 10:03:01 INFO - (blobuploader) - INFO - Iteration through files over. 10:03:01 INFO - Return code: 0 10:03:01 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:03:01 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:03:01 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/38ab4688a070c189511affc565c1b711bdd1fa2b19dbf232527d106b4f22d4f6489defa8ce2bbe04a2eb5124867e212a82f4451c4f6aadd9d0f811265a628381", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d597851032472e5a4f46a5affb8ccfa1399e3eb8ef9ca90f6da34297b4f57ef2002737ebeacf4215f0610e8ab5390d371265942c235d9b6b4ad885028029a4fb"} 10:03:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:03:01 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:03:01 INFO - Contents: 10:03:01 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/38ab4688a070c189511affc565c1b711bdd1fa2b19dbf232527d106b4f22d4f6489defa8ce2bbe04a2eb5124867e212a82f4451c4f6aadd9d0f811265a628381", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d597851032472e5a4f46a5affb8ccfa1399e3eb8ef9ca90f6da34297b4f57ef2002737ebeacf4215f0610e8ab5390d371265942c235d9b6b4ad885028029a4fb"} 10:03:01 INFO - Running post-run listener: copy_logs_to_upload_dir 10:03:01 INFO - Copying logs to upload dir... 10:03:01 INFO - mkdir: /builds/slave/test/build/upload/logs 10:03:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.578846 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-04-20 10:03:01.405443) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-20 10:03:01.409787) ========= 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=52faae308a556c440401f8e5000001e8-1461168480.581075-1500704581 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/38ab4688a070c189511affc565c1b711bdd1fa2b19dbf232527d106b4f22d4f6489defa8ce2bbe04a2eb5124867e212a82f4451c4f6aadd9d0f811265a628381", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d597851032472e5a4f46a5affb8ccfa1399e3eb8ef9ca90f6da34297b4f57ef2002737ebeacf4215f0610e8ab5390d371265942c235d9b6b4ad885028029a4fb"} build_url:https://queue.taskcluster.net/v1/task/LKau8BlwT1GzWNTbDpQpIg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011437 build_url: 'https://queue.taskcluster.net/v1/task/LKau8BlwT1GzWNTbDpQpIg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/38ab4688a070c189511affc565c1b711bdd1fa2b19dbf232527d106b4f22d4f6489defa8ce2bbe04a2eb5124867e212a82f4451c4f6aadd9d0f811265a628381", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d597851032472e5a4f46a5affb8ccfa1399e3eb8ef9ca90f6da34297b4f57ef2002737ebeacf4215f0610e8ab5390d371265942c235d9b6b4ad885028029a4fb"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-20 10:03:01.435355) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 10:03:01.435778) ========= 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=52faae308a556c440401f8e5000001e8-1461168480.581075-1500704581 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004393 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 10:03:01.519615) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-20 10:03:01.520102) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-20 10:03:01.520610) ========= ========= Total master_lag: 0.15 =========