builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-005 starttime: 1461328964.86 results: success (0) buildid: 20160422035423 builduid: e1d26a5cd477466bafcab7d720b7b498 revision: 0361b7030d363459416d46e651a8c50c9536788f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-22 05:42:44.856854) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-22 05:42:44.857476) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-22 05:42:44.857757) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-22 05:42:44.873022) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 05:42:44.873402) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1461328964.350593-1865589231 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-22 05:42:45-- 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% 202M=0s 2016-04-22 05:42:45 (202 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.304389 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 05:42:45.191904) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 05:42:45.192279) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1461328964.350593-1865589231 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020414 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 05:42:45.241833) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 05:42:45.245249) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 0361b7030d363459416d46e651a8c50c9536788f --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 0361b7030d363459416d46e651a8c50c9536788f --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=7fc86f70bae03e018da0b1d8000001c4-1461328964.350593-1865589231 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-22 05:42:45,518 truncating revision to first 12 chars 2016-04-22 05:42:45,518 Setting DEBUG logging. 2016-04-22 05:42:45,518 attempt 1/10 2016-04-22 05:42:45,518 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/0361b7030d36?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-22 05:42:45,778 unpacking tar archive at: fx-team-0361b7030d36/testing/mozharness/ program finished with exit code 0 elapsedTime=0.541848 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 05:42:45.799598) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-22 05:42:45.799901) ========= script_repo_revision: 0361b7030d363459416d46e651a8c50c9536788f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-22 05:42:45.800310) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-22 05:42:45.800581) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-22 05:42:45.810725) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 29 secs) (at 2016-04-22 05:42:45.811036) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=7fc86f70bae03e018da0b1d8000001c4-1461328964.350593-1865589231 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:42:46 INFO - MultiFileLogger online at 20160422 05:42:46 in /builds/slave/test 05:42:46 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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 05:42:46 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:42:46 INFO - {'append_to_log': False, 05:42:46 INFO - 'base_work_dir': '/builds/slave/test', 05:42:46 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 05:42:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:42:46 INFO - 'branch': 'Fx-Team-Non-PGO', 05:42:46 INFO - 'buildbot_json_path': 'buildprops.json', 05:42:46 INFO - 'config_files': ('talos/linux_config.py',), 05:42:46 INFO - 'default_actions': ('clobber', 05:42:46 INFO - 'read-buildbot-config', 05:42:46 INFO - 'download-and-extract', 05:42:46 INFO - 'populate-webroot', 05:42:46 INFO - 'create-virtualenv', 05:42:46 INFO - 'install', 05:42:46 INFO - 'run-tests'), 05:42:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:42:46 INFO - 'download_minidump_stackwalk': True, 05:42:46 INFO - 'download_symbols': 'ondemand', 05:42:46 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:42:46 INFO - 'tooltool.py': '/tools/tooltool.py', 05:42:46 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:42:46 INFO - '/tools/misc-python/virtualenv.py')}, 05:42:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:42:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:42:46 INFO - 'installer_path': 'installer.exe', 05:42:46 INFO - 'log_level': 'info', 05:42:46 INFO - 'log_name': 'talos', 05:42:46 INFO - 'log_to_console': True, 05:42:46 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:42:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:42:46 INFO - 'opt_config_files': (), 05:42:46 INFO - 'pip_index': False, 05:42:46 INFO - 'sps_profile': False, 05:42:46 INFO - 'sps_profile_interval': 0, 05:42:46 INFO - 'suite': 'dromaeojs-e10s', 05:42:46 INFO - 'system_bits': '32', 05:42:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:42:46 INFO - 'title': 'talos-linux64-ix-005', 05:42:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:42:46 INFO - 'use_talos_json': True, 05:42:46 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:42:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:42:46 INFO - 'work_dir': 'build'} 05:42:46 INFO - ##### 05:42:46 INFO - ##### Running clobber step. 05:42:46 INFO - ##### 05:42:46 INFO - Running pre-action listener: _resource_record_pre_action 05:42:46 INFO - Running main action method: clobber 05:42:46 INFO - rmtree: /builds/slave/test/build 05:42:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:42:46 INFO - Running post-action listener: _resource_record_post_action 05:42:46 INFO - ##### 05:42:46 INFO - ##### Running read-buildbot-config step. 05:42:46 INFO - ##### 05:42:46 INFO - Running pre-action listener: _resource_record_pre_action 05:42:46 INFO - Running main action method: read_buildbot_config 05:42:46 INFO - Using buildbot properties: 05:42:46 INFO - { 05:42:46 INFO - "project": "", 05:42:46 INFO - "product": "firefox", 05:42:46 INFO - "script_repo_revision": "production", 05:42:46 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 05:42:46 INFO - "repository": "", 05:42:46 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 05:42:46 INFO - "buildid": "20160422035423", 05:42:46 INFO - "pgo_build": "False", 05:42:46 INFO - "basedir": "/builds/slave/test", 05:42:46 INFO - "buildnumber": 1184, 05:42:46 INFO - "slavename": "talos-linux64-ix-005", 05:42:46 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:42:46 INFO - "platform": "ubuntu64_hw", 05:42:46 INFO - "scheduler": "tests-fx-team-linux64-talos", 05:42:46 INFO - "branch": "fx-team", 05:42:46 INFO - "repo_path": "integration/fx-team", 05:42:46 INFO - "revision": "0361b7030d363459416d46e651a8c50c9536788f", 05:42:46 INFO - "stage_platform": "linux64", 05:42:46 INFO - "builduid": "e1d26a5cd477466bafcab7d720b7b498", 05:42:46 INFO - "slavebuilddir": "test" 05:42:46 INFO - } 05:42:46 INFO - Found installer url https://queue.taskcluster.net/v1/task/D5pYoYECQPOA_-xi3A8o-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 05:42:46 INFO - Running post-action listener: _resource_record_post_action 05:42:46 INFO - ##### 05:42:46 INFO - ##### Running download-and-extract step. 05:42:46 INFO - ##### 05:42:46 INFO - Running pre-action listener: _resource_record_pre_action 05:42:46 INFO - Running main action method: download_and_extract 05:42:46 INFO - mkdir: /builds/slave/test/build/tests 05: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')]} 05:42:46 INFO - https://queue.taskcluster.net/v1/task/D5pYoYECQPOA_-xi3A8o-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:42:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D5pYoYECQPOA_-xi3A8o-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 05:42:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D5pYoYECQPOA_-xi3A8o-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 05:42:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D5pYoYECQPOA_-xi3A8o-g/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 05:42:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D5pYoYECQPOA_-xi3A8o-g/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 05:42:47 INFO - Downloaded 1361 bytes. 05:42:47 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 05:42:47 INFO - Using the following test package requirements: 05:42:47 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 05:42:47 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:42:47 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:42:47 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:42:47 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:42:47 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:42:47 INFO - u'jsshell-linux-x86_64.zip'], 05:42:47 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:42:47 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:42:47 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 05:42:47 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:42:47 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:42:47 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:42:47 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:42:47 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:42:47 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:42:47 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:42:47 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:42:47 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:42:47 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')]} 05:42:47 INFO - https://queue.taskcluster.net/v1/task/D5pYoYECQPOA_-xi3A8o-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:42:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D5pYoYECQPOA_-xi3A8o-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:42:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D5pYoYECQPOA_-xi3A8o-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:42:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D5pYoYECQPOA_-xi3A8o-g/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 05:42:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D5pYoYECQPOA_-xi3A8o-g/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 05:42:48 INFO - Downloaded 22281373 bytes. 05:42:48 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'] 05:42:48 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 05:42:49 INFO - Return code: 0 05:42:49 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 05:42:49 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')]} 05:42:49 INFO - https://queue.taskcluster.net/v1/task/D5pYoYECQPOA_-xi3A8o-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:42:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D5pYoYECQPOA_-xi3A8o-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:42:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D5pYoYECQPOA_-xi3A8o-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:42:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D5pYoYECQPOA_-xi3A8o-g/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 05:42:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D5pYoYECQPOA_-xi3A8o-g/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 05:42:51 INFO - Downloaded 22281373 bytes. 05:42:51 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'] 05:42:51 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 05:42:52 INFO - Return code: 0 05:42:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:42:52 INFO - https://queue.taskcluster.net/v1/task/D5pYoYECQPOA_-xi3A8o-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:42:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D5pYoYECQPOA_-xi3A8o-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 05:42:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D5pYoYECQPOA_-xi3A8o-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 05:42:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D5pYoYECQPOA_-xi3A8o-g/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 05:42:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D5pYoYECQPOA_-xi3A8o-g/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 05:42:53 INFO - Downloaded 10845952 bytes. 05:42:53 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'] 05:42:53 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 05:42:53 INFO - Return code: 0 05: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')]} 05:42:53 INFO - https://queue.taskcluster.net/v1/task/D5pYoYECQPOA_-xi3A8o-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:42:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D5pYoYECQPOA_-xi3A8o-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:42:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D5pYoYECQPOA_-xi3A8o-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:42:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D5pYoYECQPOA_-xi3A8o-g/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 05:42:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D5pYoYECQPOA_-xi3A8o-g/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 05:42:55 INFO - Downloaded 54649298 bytes. 05:42:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/D5pYoYECQPOA_-xi3A8o-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:42:55 INFO - mkdir: /builds/slave/test/properties 05:42:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:42:55 INFO - Writing to file /builds/slave/test/properties/build_url 05:42:55 INFO - Contents: 05:42:55 INFO - build_url:https://queue.taskcluster.net/v1/task/D5pYoYECQPOA_-xi3A8o-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:42:56 INFO - Running post-action listener: _resource_record_post_action 05:42:56 INFO - Running post-action listener: set_extra_try_arguments 05:42:56 INFO - ##### 05:42:56 INFO - ##### Running populate-webroot step. 05:42:56 INFO - ##### 05:42:56 INFO - Running pre-action listener: _resource_record_pre_action 05:42:56 INFO - Running main action method: populate_webroot 05:42:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:42:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:42:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:42:56 INFO - '--tppagecycles', 05:42:56 INFO - '7'], 05:42:56 INFO - 'tests': ['tsvgm']}}, 05:42:56 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:42:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:42:56 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:42:56 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:42:56 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:42:56 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:42:56 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:42:56 INFO - 'talos_options': ['--disable-e10s'], 05:42:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:42:56 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:42:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:42:56 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:42:56 INFO - 'talos_options': ['--disable-e10s'], 05:42:56 INFO - 'tests': ['damp', 'tps']}, 05:42:56 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:42:56 INFO - 'tests': ['damp', 'tps']}, 05:42:56 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:42:56 INFO - 'tests': ['dromaeo_dom']}, 05:42:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:42:56 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:42:56 INFO - 'tests': ['a11yr', 05:42:56 INFO - 'ts_paint', 05:42:56 INFO - 'tpaint', 05:42:56 INFO - 'sessionrestore', 05:42:56 INFO - 'sessionrestore_no_auto_restore', 05:42:56 INFO - 'tabpaint']}, 05:42:56 INFO - 'other-e10s': {'tests': ['a11yr', 05:42:56 INFO - 'ts_paint', 05:42:56 INFO - 'tpaint', 05:42:56 INFO - 'sessionrestore', 05:42:56 INFO - 'sessionrestore_no_auto_restore', 05:42:56 INFO - 'tabpaint']}, 05:42:56 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:42:56 INFO - 'ts_paint', 05:42:56 INFO - 'tpaint', 05:42:56 INFO - 'sessionrestore', 05:42:56 INFO - 'sessionrestore_no_auto_restore', 05:42:56 INFO - 'tabpaint']}, 05:42:56 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:42:56 INFO - 'ts_paint', 05:42:56 INFO - 'tpaint', 05:42:56 INFO - 'sessionrestore', 05:42:56 INFO - 'sessionrestore_no_auto_restore', 05:42:56 INFO - 'tabpaint']}, 05:42:56 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:42:56 INFO - 'tests': ['a11yr', 05:42:56 INFO - 'ts_paint', 05:42:56 INFO - 'tpaint', 05:42:56 INFO - 'sessionrestore', 05:42:56 INFO - 'sessionrestore_no_auto_restore', 05:42:56 INFO - 'tabpaint']}, 05:42:56 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:42:56 INFO - 'tests': ['a11yr', 05:42:56 INFO - 'ts_paint', 05:42:56 INFO - 'tpaint', 05:42:56 INFO - 'sessionrestore', 05:42:56 INFO - 'sessionrestore_no_auto_restore', 05:42:56 INFO - 'tabpaint']}, 05:42:56 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:42:56 INFO - 'tests': ['tsvgx', 05:42:56 INFO - 'tsvgr_opacity', 05:42:56 INFO - 'tart', 05:42:56 INFO - 'tscrollx', 05:42:56 INFO - 'cart']}, 05:42:56 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:42:56 INFO - 'tsvgr_opacity', 05:42:56 INFO - 'tart', 05:42:56 INFO - 'tscrollx', 05:42:56 INFO - 'cart']}, 05:42:56 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:42:56 INFO - 'talos_options': ['--disable-e10s'], 05:42:56 INFO - 'tests': ['tp5o']}, 05:42:56 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:42:56 INFO - 'tests': ['tp5o']}, 05:42:56 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:42:56 INFO - 'talos_options': ['--disable-e10s', 05:42:56 INFO - '--xperf_path', 05:42:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:42:56 INFO - 'tests': ['tp5n']}, 05:42:56 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:42:56 INFO - 'talos_options': ['--xperf_path', 05:42:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:42:56 INFO - 'tests': ['tp5n']}}, 05:42:56 INFO - 'talos.zip': {'path': '', 05:42:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:42:56 INFO - Running post-action listener: _resource_record_post_action 05:42:56 INFO - ##### 05:42:56 INFO - ##### Running create-virtualenv step. 05:42:56 INFO - ##### 05:42:56 INFO - Running pre-action listener: _resource_record_pre_action 05:42:56 INFO - Running main action method: create_virtualenv 05:42:56 INFO - Creating virtualenv /builds/slave/test/build/venv 05:42:56 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 05:42:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:42:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:42:56 INFO - Using real prefix '/usr' 05:42:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:42:56 INFO - Installing distribute.............................................................................................................................................................................................done. 05:42:58 INFO - Installing pip.................done. 05:42:58 INFO - Return code: 0 05:42:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:42:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:42:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:42:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:42:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:42:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:42:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:42:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f59b1d9df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e7b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f465a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd5410>, '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 0x1fd6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fd67a0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1461328964.350593-1865589231', '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 05:42:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:42:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:42:58 INFO - Using env: {'DISPLAY': ':0', 05:42:58 INFO - 'HOME': '/home/cltbld', 05:42:58 INFO - 'LANG': 'en_US.UTF-8', 05:42:58 INFO - 'LANGUAGE': 'en_US:en', 05:42:58 INFO - 'LOGNAME': 'cltbld', 05:42:58 INFO - 'MAIL': '/var/mail/cltbld', 05:42:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:42:58 INFO - 'MOZ_NO_REMOTE': '1', 05:42:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:42:58 INFO - 'NO_EM_RESTART': '1', 05:42:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:42:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:42:58 INFO - 'PWD': '/builds/slave/test', 05:42:58 INFO - 'SHELL': '/bin/bash', 05:42:58 INFO - 'SHLVL': '1', 05:42:58 INFO - 'TERM': 'linux', 05:42:58 INFO - 'TMOUT': '86400', 05:42:58 INFO - 'USER': 'cltbld', 05:42:58 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1461328964.350593-1865589231', 05:42:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:42:58 INFO - '_': '/tools/buildbot/bin/python'} 05:42:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:42:58 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 05:42:58 INFO - Cleaning up... 05:42:58 INFO - Return code: 0 05:42:58 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:42:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:42:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:42:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:42:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:42:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:42:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:42:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f59b1d9df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e7b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f465a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd5410>, '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 0x1fd6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fd67a0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1461328964.350593-1865589231', '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 05:42:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 05:42:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 05:42:58 INFO - Using env: {'DISPLAY': ':0', 05:42:58 INFO - 'HOME': '/home/cltbld', 05:42:58 INFO - 'LANG': 'en_US.UTF-8', 05:42:58 INFO - 'LANGUAGE': 'en_US:en', 05:42:58 INFO - 'LOGNAME': 'cltbld', 05:42:58 INFO - 'MAIL': '/var/mail/cltbld', 05:42:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:42:58 INFO - 'MOZ_NO_REMOTE': '1', 05:42:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:42:58 INFO - 'NO_EM_RESTART': '1', 05:42:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:42:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:42:58 INFO - 'PWD': '/builds/slave/test', 05:42:58 INFO - 'SHELL': '/bin/bash', 05:42:58 INFO - 'SHLVL': '1', 05:42:58 INFO - 'TERM': 'linux', 05:42:58 INFO - 'TMOUT': '86400', 05:42:58 INFO - 'USER': 'cltbld', 05:42:58 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1461328964.350593-1865589231', 05:42:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:42:58 INFO - '_': '/tools/buildbot/bin/python'} 05:42:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:42:59 INFO - Downloading/unpacking psutil>=0.7.1 05:42:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:42:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:42:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:42:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:42:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:42:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:43:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:43:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:43:01 INFO - Installing collected packages: psutil 05:43:01 INFO - Running setup.py install for psutil 05:43:01 INFO - building 'psutil._psutil_linux' extension 05:43:01 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 05:43:01 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 05:43:01 INFO - building 'psutil._psutil_posix' extension 05:43:01 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 05:43:01 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 05:43:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:43:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:43:01 INFO - Successfully installed psutil 05:43:01 INFO - Cleaning up... 05:43:01 INFO - Return code: 0 05:43:01 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:43:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:43:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:43:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f59b1d9df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e7b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f465a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd5410>, '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 0x1fd6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fd67a0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1461328964.350593-1865589231', '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 05:43:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 05:43:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 05:43:01 INFO - Using env: {'DISPLAY': ':0', 05:43:01 INFO - 'HOME': '/home/cltbld', 05:43:01 INFO - 'LANG': 'en_US.UTF-8', 05:43:01 INFO - 'LANGUAGE': 'en_US:en', 05:43:01 INFO - 'LOGNAME': 'cltbld', 05:43:01 INFO - 'MAIL': '/var/mail/cltbld', 05:43:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:43:01 INFO - 'MOZ_NO_REMOTE': '1', 05:43:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:43:01 INFO - 'NO_EM_RESTART': '1', 05:43:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:43:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:43:01 INFO - 'PWD': '/builds/slave/test', 05:43:01 INFO - 'SHELL': '/bin/bash', 05:43:01 INFO - 'SHLVL': '1', 05:43:01 INFO - 'TERM': 'linux', 05:43:01 INFO - 'TMOUT': '86400', 05:43:01 INFO - 'USER': 'cltbld', 05:43:01 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1461328964.350593-1865589231', 05:43:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:43:01 INFO - '_': '/tools/buildbot/bin/python'} 05:43:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:43:01 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:43:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:43:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:43:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:03 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:43:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:43:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:43:03 INFO - Installing collected packages: mozsystemmonitor 05:43:03 INFO - Running setup.py install for mozsystemmonitor 05:43:04 INFO - Successfully installed mozsystemmonitor 05:43:04 INFO - Cleaning up... 05:43:04 INFO - Return code: 0 05:43:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:43:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:43:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:43:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:04 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 0x7f59b1d9df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e7b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f465a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd5410>, '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 0x1fd6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fd67a0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1461328964.350593-1865589231', '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 05:43:04 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 05:43:04 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 05:43:04 INFO - Using env: {'DISPLAY': ':0', 05:43:04 INFO - 'HOME': '/home/cltbld', 05:43:04 INFO - 'LANG': 'en_US.UTF-8', 05:43:04 INFO - 'LANGUAGE': 'en_US:en', 05:43:04 INFO - 'LOGNAME': 'cltbld', 05:43:04 INFO - 'MAIL': '/var/mail/cltbld', 05:43:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:43:04 INFO - 'MOZ_NO_REMOTE': '1', 05:43:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:43:04 INFO - 'NO_EM_RESTART': '1', 05:43:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:43:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:43:04 INFO - 'PWD': '/builds/slave/test', 05:43:04 INFO - 'SHELL': '/bin/bash', 05:43:04 INFO - 'SHLVL': '1', 05:43:04 INFO - 'TERM': 'linux', 05:43:04 INFO - 'TMOUT': '86400', 05:43:04 INFO - 'USER': 'cltbld', 05:43:04 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1461328964.350593-1865589231', 05:43:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:43:04 INFO - '_': '/tools/buildbot/bin/python'} 05:43:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:43:04 INFO - Downloading/unpacking blobuploader==1.2.4 05:43:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:43:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:43:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:06 INFO - Downloading blobuploader-1.2.4.tar.gz 05:43:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:43:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:43:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:43:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:43:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:43:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:43:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:43:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:43:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:06 INFO - Downloading docopt-0.6.1.tar.gz 05:43:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:43:06 INFO - Installing collected packages: blobuploader, requests, docopt 05:43:06 INFO - Running setup.py install for blobuploader 05:43:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:43:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:43:07 INFO - Running setup.py install for requests 05:43:07 INFO - Running setup.py install for docopt 05:43:07 INFO - Successfully installed blobuploader requests docopt 05:43:07 INFO - Cleaning up... 05:43:07 INFO - Return code: 0 05:43:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:43:07 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')]} 05:43:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:43:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:07 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')]} 05:43:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:43:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:07 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 0x7f59b1d9df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e7b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f465a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd5410>, '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 0x1fd6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fd67a0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1461328964.350593-1865589231', '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 05:43:07 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 05:43:07 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 05:43:07 INFO - Using env: {'DISPLAY': ':0', 05:43:07 INFO - 'HOME': '/home/cltbld', 05:43:07 INFO - 'LANG': 'en_US.UTF-8', 05:43:07 INFO - 'LANGUAGE': 'en_US:en', 05:43:07 INFO - 'LOGNAME': 'cltbld', 05:43:07 INFO - 'MAIL': '/var/mail/cltbld', 05:43:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:43:07 INFO - 'MOZ_NO_REMOTE': '1', 05:43:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:43:07 INFO - 'NO_EM_RESTART': '1', 05:43:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:43:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:43:07 INFO - 'PWD': '/builds/slave/test', 05:43:07 INFO - 'SHELL': '/bin/bash', 05:43:07 INFO - 'SHLVL': '1', 05:43:07 INFO - 'TERM': 'linux', 05:43:07 INFO - 'TMOUT': '86400', 05:43:07 INFO - 'USER': 'cltbld', 05:43:07 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1461328964.350593-1865589231', 05:43:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:43:07 INFO - '_': '/tools/buildbot/bin/python'} 05:43:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:43:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:43:07 INFO - Running setup.py (path:/tmp/pip-4YLTJD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:43:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:43:07 INFO - Running setup.py (path:/tmp/pip-lYDZ5j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:43:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:43:07 INFO - Running setup.py (path:/tmp/pip-95zQ2q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:43:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:43:07 INFO - Running setup.py (path:/tmp/pip-QDdUDg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:43:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:43:08 INFO - Running setup.py (path:/tmp/pip-PksLI2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:43:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:43:08 INFO - Running setup.py (path:/tmp/pip-7_2BJO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:43:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:43:08 INFO - Running setup.py (path:/tmp/pip-7e7JJt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:43:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:43:08 INFO - Running setup.py (path:/tmp/pip-Y6YBFm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:43:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:43:08 INFO - Running setup.py (path:/tmp/pip-qctWH0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:43:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:43:08 INFO - Running setup.py (path:/tmp/pip-6NyS3y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:43:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:43:08 INFO - Running setup.py (path:/tmp/pip-uWhtkw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:43:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:43:08 INFO - Running setup.py (path:/tmp/pip-6hQM8k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:43:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:43:08 INFO - Running setup.py (path:/tmp/pip-zhtl29-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:43:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:43:08 INFO - Running setup.py (path:/tmp/pip-El6kqg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:43:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:43:08 INFO - Running setup.py (path:/tmp/pip-EXBI29-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:43:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:43:08 INFO - Running setup.py (path:/tmp/pip-zugzHH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:43:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:43:08 INFO - Running setup.py (path:/tmp/pip-fDFz5i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:43:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:43:08 INFO - Running setup.py install for manifestparser 05:43:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:43:09 INFO - Running setup.py install for mozcrash 05:43:09 INFO - Running setup.py install for mozdebug 05:43:09 INFO - Running setup.py install for mozdevice 05:43:09 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:43:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:43:09 INFO - Running setup.py install for mozfile 05:43:09 INFO - Running setup.py install for mozhttpd 05:43:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:43:09 INFO - Running setup.py install for mozinfo 05:43:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:43:09 INFO - Running setup.py install for mozInstall 05:43:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:43:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:43:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:43:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:43:09 INFO - Running setup.py install for mozleak 05:43:09 INFO - Running setup.py install for mozlog 05:43:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:43:10 INFO - Running setup.py install for moznetwork 05:43:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:43:10 INFO - Running setup.py install for mozprocess 05:43:10 INFO - Running setup.py install for mozprofile 05:43:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:43:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:43:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:43:10 INFO - Running setup.py install for mozrunner 05:43:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:43:10 INFO - Running setup.py install for mozscreenshot 05:43:10 INFO - Running setup.py install for moztest 05:43:10 INFO - Running setup.py install for mozversion 05:43:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:43:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:43:10 INFO - Cleaning up... 05:43:10 INFO - Return code: 0 05:43:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:43:10 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')]} 05:43:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:43:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:10 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')]} 05:43:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:43:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:10 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 0x7f59b1d9df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e7b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f465a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd5410>, '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 0x1fd6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fd67a0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1461328964.350593-1865589231', '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 05:43:10 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 05:43:10 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 05:43:10 INFO - Using env: {'DISPLAY': ':0', 05:43:10 INFO - 'HOME': '/home/cltbld', 05:43:10 INFO - 'LANG': 'en_US.UTF-8', 05:43:10 INFO - 'LANGUAGE': 'en_US:en', 05:43:10 INFO - 'LOGNAME': 'cltbld', 05:43:10 INFO - 'MAIL': '/var/mail/cltbld', 05:43:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:43:10 INFO - 'MOZ_NO_REMOTE': '1', 05:43:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:43:10 INFO - 'NO_EM_RESTART': '1', 05:43:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:43:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:43:10 INFO - 'PWD': '/builds/slave/test', 05:43:10 INFO - 'SHELL': '/bin/bash', 05:43:10 INFO - 'SHLVL': '1', 05:43:10 INFO - 'TERM': 'linux', 05:43:10 INFO - 'TMOUT': '86400', 05:43:10 INFO - 'USER': 'cltbld', 05:43:10 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1461328964.350593-1865589231', 05:43:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:43:10 INFO - '_': '/tools/buildbot/bin/python'} 05:43:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:43:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:43:10 INFO - Running setup.py (path:/tmp/pip-Xpowv4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:43:11 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)) 05:43:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:43:11 INFO - Running setup.py (path:/tmp/pip-LNeVAJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:43:11 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)) 05:43:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:43:11 INFO - Running setup.py (path:/tmp/pip-jAsRs_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:43:11 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)) 05:43:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:43:11 INFO - Running setup.py (path:/tmp/pip-QBUoIO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:43:11 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)) 05:43:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:43:11 INFO - Running setup.py (path:/tmp/pip-9dpc5z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:43:11 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)) 05:43:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:43:11 INFO - Running setup.py (path:/tmp/pip-D4zvMW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:43:11 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)) 05:43:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:43:11 INFO - Running setup.py (path:/tmp/pip-t75m1k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:43:11 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)) 05:43:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:43:11 INFO - Running setup.py (path:/tmp/pip-U4zDW3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:43:11 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)) 05:43:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:43:11 INFO - Running setup.py (path:/tmp/pip-wg7n9C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:43:11 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)) 05:43:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:43:11 INFO - Running setup.py (path:/tmp/pip-93SQB2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:43:11 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)) 05:43:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:43:11 INFO - Running setup.py (path:/tmp/pip-FD6bWe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:43:11 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)) 05:43:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:43:11 INFO - Running setup.py (path:/tmp/pip-PMw5Fw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:43:11 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)) 05:43:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:43:11 INFO - Running setup.py (path:/tmp/pip-HKDvKM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:43:11 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)) 05:43:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:43:11 INFO - Running setup.py (path:/tmp/pip-zTzzx1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:43:12 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)) 05:43:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:43:12 INFO - Running setup.py (path:/tmp/pip-5vI7wX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:43:12 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)) 05:43:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:43:12 INFO - Running setup.py (path:/tmp/pip-0hjpcH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:43:12 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)) 05:43:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:43:12 INFO - Running setup.py (path:/tmp/pip-qXYn8t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:43:12 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)) 05:43:12 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)) 05:43:12 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)) 05:43:12 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)) 05:43:12 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)) 05:43:12 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)) 05:43:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:43:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:43:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:43:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:14 INFO - Downloading blessings-1.6.tar.gz 05:43:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:43:14 INFO - Installing collected packages: blessings 05:43:14 INFO - Running setup.py install for blessings 05:43:14 INFO - Successfully installed blessings 05:43:14 INFO - Cleaning up... 05:43:14 INFO - Return code: 0 05:43:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:43:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:43:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:43:14 INFO - Reading from file tmpfile_stdout 05:43:14 INFO - Current package versions: 05:43:14 INFO - argparse == 1.2.1 05:43:14 INFO - blessings == 1.6 05:43:14 INFO - blobuploader == 1.2.4 05:43:14 INFO - docopt == 0.6.1 05:43:14 INFO - manifestparser == 1.1 05:43:14 INFO - mozInstall == 1.12 05:43:14 INFO - mozcrash == 0.17 05:43:14 INFO - mozdebug == 0.1 05:43:14 INFO - mozdevice == 0.48 05:43:14 INFO - mozfile == 1.2 05:43:14 INFO - mozhttpd == 0.7 05:43:14 INFO - mozinfo == 0.9 05:43:14 INFO - mozleak == 0.1 05:43:14 INFO - mozlog == 3.1 05:43:14 INFO - moznetwork == 0.27 05:43:14 INFO - mozprocess == 0.22 05:43:14 INFO - mozprofile == 0.28 05:43:14 INFO - mozrunner == 6.11 05:43:14 INFO - mozscreenshot == 0.1 05:43:14 INFO - mozsystemmonitor == 0.0 05:43:14 INFO - moztest == 0.7 05:43:14 INFO - mozversion == 1.4 05:43:14 INFO - psutil == 3.1.1 05:43:14 INFO - requests == 1.2.3 05:43:14 INFO - wsgiref == 0.1.2 05:43:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:43:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:43:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:43:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:14 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 0x7f59b1d9df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e7b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f465a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd5410>, '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 0x1fd6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fd67a0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1461328964.350593-1865589231', '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 05:43:14 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 05:43:14 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 05:43:14 INFO - Using env: {'DISPLAY': ':0', 05:43:14 INFO - 'HOME': '/home/cltbld', 05:43:14 INFO - 'LANG': 'en_US.UTF-8', 05:43:14 INFO - 'LANGUAGE': 'en_US:en', 05:43:14 INFO - 'LOGNAME': 'cltbld', 05:43:14 INFO - 'MAIL': '/var/mail/cltbld', 05:43:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:43:14 INFO - 'MOZ_NO_REMOTE': '1', 05:43:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:43:14 INFO - 'NO_EM_RESTART': '1', 05:43:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:43:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:43:14 INFO - 'PWD': '/builds/slave/test', 05:43:14 INFO - 'SHELL': '/bin/bash', 05:43:14 INFO - 'SHLVL': '1', 05:43:14 INFO - 'TERM': 'linux', 05:43:14 INFO - 'TMOUT': '86400', 05:43:14 INFO - 'USER': 'cltbld', 05:43:14 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1461328964.350593-1865589231', 05:43:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:43:14 INFO - '_': '/tools/buildbot/bin/python'} 05:43:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:43:14 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)) 05:43:14 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)) 05:43:14 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)) 05:43:14 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)) 05:43:14 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)) 05:43:14 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)) 05:43:14 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)) 05:43:14 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)) 05:43:14 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)) 05:43:14 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)) 05:43:14 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)) 05:43:14 INFO - Cleaning up... 05:43:14 INFO - Return code: 0 05:43:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:43:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:43:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:43:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f59b1d9df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e7b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f465a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd5410>, '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 0x1fd6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fd67a0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1461328964.350593-1865589231', '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 05:43:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:43:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:43:14 INFO - Using env: {'DISPLAY': ':0', 05:43:14 INFO - 'HOME': '/home/cltbld', 05:43:14 INFO - 'LANG': 'en_US.UTF-8', 05:43:14 INFO - 'LANGUAGE': 'en_US:en', 05:43:14 INFO - 'LOGNAME': 'cltbld', 05:43:14 INFO - 'MAIL': '/var/mail/cltbld', 05:43:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:43:14 INFO - 'MOZ_NO_REMOTE': '1', 05:43:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:43:14 INFO - 'NO_EM_RESTART': '1', 05:43:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:43:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:43:14 INFO - 'PWD': '/builds/slave/test', 05:43:14 INFO - 'SHELL': '/bin/bash', 05:43:14 INFO - 'SHLVL': '1', 05:43:14 INFO - 'TERM': 'linux', 05:43:14 INFO - 'TMOUT': '86400', 05:43:14 INFO - 'USER': 'cltbld', 05:43:14 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1461328964.350593-1865589231', 05:43:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:43:14 INFO - '_': '/tools/buildbot/bin/python'} 05:43:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:43:15 INFO - Downloading/unpacking jsonschema 05:43:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:43:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:43:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:43:16 INFO - Downloading/unpacking functools32 (from jsonschema) 05:43:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:43:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:43:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:17 INFO - Downloading functools32-3.2.3-2.tar.gz 05:43:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:43:17 INFO - warning: no files found matching '*.txt' 05:43:17 INFO - no previously-included directories found matching 'build' 05:43:17 INFO - no previously-included directories found matching 'dist' 05:43:17 INFO - no previously-included directories found matching '.git*' 05:43:17 INFO - Installing collected packages: jsonschema, functools32 05:43:17 INFO - Running setup.py install for functools32 05:43:17 INFO - warning: no files found matching '*.txt' 05:43:17 INFO - no previously-included directories found matching 'build' 05:43:17 INFO - no previously-included directories found matching 'dist' 05:43:17 INFO - no previously-included directories found matching '.git*' 05:43:17 INFO - Successfully installed jsonschema functools32 05:43:17 INFO - Cleaning up... 05:43:17 INFO - Return code: 0 05:43:17 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:43:17 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')]} 05:43:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:43:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:17 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')]} 05:43:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:43:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:17 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 0x7f59b1d9df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e7b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f465a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd5410>, '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 0x1fd6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fd67a0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1461328964.350593-1865589231', '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 05:43:17 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 05:43:17 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 05:43:17 INFO - Using env: {'DISPLAY': ':0', 05:43:17 INFO - 'HOME': '/home/cltbld', 05:43:17 INFO - 'LANG': 'en_US.UTF-8', 05:43:17 INFO - 'LANGUAGE': 'en_US:en', 05:43:17 INFO - 'LOGNAME': 'cltbld', 05:43:17 INFO - 'MAIL': '/var/mail/cltbld', 05:43:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:43:17 INFO - 'MOZ_NO_REMOTE': '1', 05:43:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:43:17 INFO - 'NO_EM_RESTART': '1', 05:43:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:43:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:43:17 INFO - 'PWD': '/builds/slave/test', 05:43:17 INFO - 'SHELL': '/bin/bash', 05:43:17 INFO - 'SHLVL': '1', 05:43:17 INFO - 'TERM': 'linux', 05:43:17 INFO - 'TMOUT': '86400', 05:43:17 INFO - 'USER': 'cltbld', 05:43:17 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1461328964.350593-1865589231', 05:43:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:43:17 INFO - '_': '/tools/buildbot/bin/python'} 05:43:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:43:17 INFO - Downloading/unpacking flake8 05:43:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:43:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:43:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:19 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:43:19 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:43:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:43:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:43:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:19 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:43:19 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:43:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:43:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:43:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:19 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:43:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:43:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:43:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:43:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:43:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:43:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:43:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:43:20 INFO - no previously-included directories found matching 'docs/_build' 05:43:20 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:43:20 INFO - Running setup.py install for pep8 05:43:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:43:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:43:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:43:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:43:20 INFO - no previously-included directories found matching 'docs/_build' 05:43:20 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:43:20 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:43:20 INFO - Cleaning up... 05:43:20 INFO - Return code: 0 05:43:20 INFO - Running post-action listener: _resource_record_post_action 05:43:20 INFO - Running post-action listener: _start_resource_monitoring 05:43:20 INFO - Starting resource monitoring. 05:43:20 INFO - ##### 05:43:20 INFO - ##### Running install step. 05:43:20 INFO - ##### 05:43:20 INFO - Running pre-action listener: _resource_record_pre_action 05:43:20 INFO - Running main action method: install 05:43:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:43:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:43:20 INFO - Reading from file tmpfile_stdout 05:43:20 INFO - Detecting whether we're running mozinstall >=1.0... 05:43:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:43:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:43:20 INFO - Reading from file tmpfile_stdout 05:43:20 INFO - Output received: 05:43:20 INFO - Usage: mozinstall [options] installer 05:43:20 INFO - Options: 05:43:20 INFO - -h, --help show this help message and exit 05:43:20 INFO - -d DEST, --destination=DEST 05:43:20 INFO - Directory to install application into. [default: 05:43:20 INFO - "/builds/slave/test"] 05:43:20 INFO - --app=APP Application being installed. [default: firefox] 05:43:20 INFO - mkdir: /builds/slave/test/build/application 05:43:20 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'] 05:43:20 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 05:43:36 INFO - Reading from file tmpfile_stdout 05:43:36 INFO - Output received: 05:43:36 INFO - /builds/slave/test/build/application/firefox/firefox 05:43:36 INFO - Running post-action listener: _resource_record_post_action 05:43:36 INFO - ##### 05:43:36 INFO - ##### Running run-tests step. 05:43:36 INFO - ##### 05:43:36 INFO - Running pre-action listener: _resource_record_pre_action 05:43:36 INFO - Running main action method: run_tests 05:43:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:43:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:43:36 INFO - Python 2.7.3 05:43:36 INFO - Return code: 0 05:43:36 INFO - grabbing minidump binary from tooltool 05:43:36 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')]} 05:43:36 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 0x1fd5410>, '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 0x1fd6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fd67a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:43:36 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 05:43:36 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 05:43:36 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:43:36 INFO - Return code: 0 05:43:36 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:43:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:43:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:43:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:43:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:43:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:43:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:43:37 INFO - Return code: 0 05:43:37 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/D5pYoYECQPOA_-xi3A8o-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 05:43:37 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/D5pYoYECQPOA_-xi3A8o-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-005 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 05:43:37 INFO - Using env: {'DISPLAY': ':0', 05:43:37 INFO - 'HOME': '/home/cltbld', 05:43:37 INFO - 'LANG': 'en_US.UTF-8', 05:43:37 INFO - 'LANGUAGE': 'en_US:en', 05:43:37 INFO - 'LOGNAME': 'cltbld', 05:43:37 INFO - 'MAIL': '/var/mail/cltbld', 05:43:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:43:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:43:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:43:37 INFO - 'MOZ_NO_REMOTE': '1', 05:43:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:43:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:43:37 INFO - 'NO_EM_RESTART': '1', 05:43:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:43:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:43:37 INFO - 'PWD': '/builds/slave/test', 05:43:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:43:37 INFO - 'SHELL': '/bin/bash', 05:43:37 INFO - 'SHLVL': '1', 05:43:37 INFO - 'TERM': 'linux', 05:43:37 INFO - 'TMOUT': '86400', 05:43:37 INFO - 'USER': 'cltbld', 05:43:37 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1461328964.350593-1865589231', 05:43:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:43:37 INFO - '_': '/tools/buildbot/bin/python'} 05:43:37 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/D5pYoYECQPOA_-xi3A8o-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 05:43:37 INFO - mozversion application_buildid: 20160422035423 05:43:37 INFO - mozversion application_changeset: 0361b7030d363459416d46e651a8c50c9536788f 05:43:37 INFO - mozversion application_display_name: Nightly 05:43:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:43:37 INFO - mozversion application_name: Firefox 05:43:37 INFO - mozversion application_remotingname: firefox 05:43:37 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:43:37 INFO - mozversion application_vendor: Mozilla 05:43:37 INFO - mozversion application_version: 48.0a1 05:43:37 INFO - mozversion platform_buildid: 20160422035423 05:43:37 INFO - mozversion platform_changeset: 0361b7030d363459416d46e651a8c50c9536788f 05:43:37 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:43:37 INFO - mozversion platform_version: 48.0a1 05:43:37 INFO - using testdate: 1461329017 05:43:37 INFO - actual date: 1461329017 05:43:37 INFO - starting webserver on 'localhost:33648' 05:43:37 INFO - SUITE-START | Running 2 tests 05:43:37 INFO - TEST-START | dromaeo_css 05:43:37 INFO - operating with platform_type : linux_ 05:43:37 INFO - Initialising browser for dromaeo_css test... 05:43:37 INFO - TEST-INFO | started process 31508 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwpkLwa/profile http://localhost:33648/getInfo.html) 05:43:41 INFO - PROCESS | 31508 | 05:43:41 INFO - PROCESS | 31508 | (process:31575): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:43:42 INFO - PROCESS | 31508 | __metrics Screen width/height:1600/1200 05:43:42 INFO - PROCESS | 31508 | colorDepth:24 05:43:42 INFO - PROCESS | 31508 | Browser inner width/height: 1024/697 05:43:42 INFO - PROCESS | 31508 | __metrics 05:43:43 ERROR - PROCESS | 31508 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 05:43:43 INFO - TEST-INFO | 31508: exit 0 05:43:43 INFO - Browser initialized. 05:43:43 INFO - Running cycle 1/1 for dromaeo_css test... 05:43:43 INFO - TEST-INFO | started process 31626 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwpkLwa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:43:45 INFO - PROCESS | 31626 | 05:43:45 INFO - PROCESS | 31626 | (process:31687): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:43:55 INFO - PROCESS | 31626 | RSS: Main: 165380096 05:43:55 INFO - PROCESS | 31626 | 05:44:45 INFO - PROCESS | 31626 | 1461329085579 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] 05:46:57 INFO - PROCESS | 31626 | Cycle 1(1): loaded http://localhost:33648/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33648/tests/dromaeo/cssquery-ext.html) 05:46:58 INFO - PROCESS | 31626 | RSS: Main: 167383040 05:46:58 INFO - PROCESS | 31626 | 05:50:00 INFO - PROCESS | 31626 | Cycle 1(1): loaded http://localhost:33648/tests/dromaeo/cssquery-ext.html (next: http://localhost:33648/tests/dromaeo/cssquery-jquery.html) 05:50:01 INFO - PROCESS | 31626 | RSS: Main: 165941248 05:50:01 INFO - PROCESS | 31626 | 05:53:03 INFO - PROCESS | 31626 | Cycle 1(1): loaded http://localhost:33648/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33648/tests/dromaeo/cssquery-mootools.html) 05:53:03 INFO - PROCESS | 31626 | RSS: Main: 167194624 05:53:03 INFO - PROCESS | 31626 | 05:56:05 INFO - PROCESS | 31626 | Cycle 1(1): loaded http://localhost:33648/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33648/tests/dromaeo/cssquery-prototype.html) 05:56:06 INFO - PROCESS | 31626 | RSS: Main: 165097472 05:56:06 INFO - PROCESS | 31626 | 05:59:09 INFO - PROCESS | 31626 | Cycle 1(1): loaded http://localhost:33648/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33648/tests/dromaeo/cssquery-yui.html) 05:59:09 INFO - PROCESS | 31626 | RSS: Main: 165941248 05:59:09 INFO - PROCESS | 31626 | 06:02:12 INFO - PROCESS | 31626 | Cycle 1(1): loaded http://localhost:33648/tests/dromaeo/cssquery-yui.html (next: http://localhost:33648/tests/dromaeo/cssquery-dojo.html) 06:02:12 INFO - PROCESS | 31626 | RSS: Main: 168722432 06:02:12 INFO - PROCESS | 31626 | 06:02:12 INFO - PROCESS | 31626 | __start_tp_report 06:02:12 INFO - PROCESS | 31626 | _x_x_mozilla_page_load 06:02:12 INFO - PROCESS | 31626 | _x_x_mozilla_page_load_details 06:02:12 INFO - PROCESS | 31626 | |i|pagename|runs| 06:02:12 INFO - PROCESS | 31626 | |0;dojo.html;2637.393399518111;2690.9774285771405;2721.564549672053;2724.3189202699327;2734.2344143639775;4679.438467383919;4737.62099032077;4751.976240118799;4763.35694681218;4793.1132740443045;4701.388819453475;4775.212090005154;4821.4696383397795;4839.177339852225;4840.104580652582;4436.977815110928;4475.843345482893;4521.502634710179;4525.705829121113;4569.885752856172;4456.108778244348;4564.680472366936;4577.336286238494;4605.700629459091;4618.561236682526;4367.934480982788;4369.781510924473;4421.403110580062;4490.797914093857;4561.29299958507;4407.713498622601;4439.511653718088;4448.1770872388715;4451.688381813275;4508.188526065307;4376.081022985145;4382.233109205877;4403.889902752425;4404.911901761947;4435.445569303837;4725.1730947084125;4733.219018861883;4761.833335833264;4814.927776083362;4818.229083346648;5043.924341134886;5104.106781313255;5109.744512774347;5124.154514505102;5184.533391994739;5065.265536497224;5111.412187598399;5138.177891537336;5143.074246635604;5155.278261043457;4803.78382972767;4847.95152048475;4848.587870031016;4882.462929077798;4888.560029597354;5253.290805741252;5302.469753024667;5323.095073837457;5338.759755810997;5377.435369286169;4954.826581069645;5022.773975171126;5078.542931136216;5105.412877519133;5117.513836185556;5063.974680126576;5078.5175408336145;5083.262926875583;5118.795248190031;5138.691678499302;4972.975135124374;5104.081265372194;5227.294315267466;5231.084560201949;5234.869128271747;5110.182370820651;5111.080005599028;5116.360454943132;5132.28148059272;5133.307003554547;4195.895102622398;4304.6556275498515;4351.804168812348;4379.255526560492;4400.9559904401185;3775.811209439517;3808.27642747877;3814.8855534334016;3839.308924393636;3852.5184351956004;4370.694051416434;4470.307102399133;4505.301678239878;4510.368548403226;4518.480374756879;5050.621203409759;5087.592992560586;5091.745412729423;5152.92270615941;5183.922241166386;4404.757738324359;4455.1757924784015;4487.910241795211;4495.43807024122;4505;4566.3150527420485;4582.083583283356;4637.397138372057;4666.719996800135;4674.2988551716835;4813.927791083137;4816.614670826396;4825.252085926687;4853.441854186673;4894.535019173173;5154.023720449045;5197.168453047494;5197.948020519746;5202.531772140525;5258.316418865523;4705.34125222476;4846.321514987975;4856.660033797601;4926.926096108633;4944.92582611254;5110.310108135503;5116.692998420107;5123.103456895103;5138.486151384832;5157;5152.175651895679;5174.63777535584;5200.349956255468;5211.765470553758;5261.710605916712;4815.95184048155;4984.526469985346;4994.9500504994485;5063.265826455217;5111.488851114858;4883.926741098815;5050.722210278323;5124.154514505065;5125.179971204739;5162.6902385856965;4938.43208031081;4939.629527785359;4969.180085285887;4980.676256043345;5021.196608542616;4873;5070.062038522885;5082.085224659449;5105.821296254762;5164.9741751291;4973.254011898244;5022.698638081581;5025.321581586585;5043.5712964398435;5048.141815891381 06:02:12 INFO - PROCESS | 31626 | |1;ext.html;575.9625624334418;611.1352436302632;625.7152995387099;629.6033498895697;637.5537124013192;32864;34013.48979765299;34136.14659633507;34260.314793704114;34350.48474272888;34856.651433485655;35174.296514069705;35376.82311588445;35387.646123538754;35521.111972200706;7443.665035073421;7604.391648668094;7623.847523049536;7644.61776911155;7645.961770191141;7404.0374751282525;7635;7677.884831727529;7684.039495063117;7708.537487750753;7744.651490682904;7747.225277472264;7769.650365733527;7777.261160189773;7793.649285782153;7683.807904802369;7743.18696536864;7744.41916856238;7755.069391672979;7765.7670269892;7652.732154374626;7726.111497177784;7762.922370776333;7776.416768742367;7794.41541884361;29080;35472.113197170016;35583.82208088969;36079.27841443183;36198.27603447943;2791.4556661451024;2821.379296554775;2874;2929.4580502606873;3283.5238890361;26941.32646683829;27172.59241111385;27243.591346129822;27419.17742467729;27487;3311.569495965509;3351.262722201112;3390.118569172033;3477.94783078254;3479.791212527231;229277;232612;233843;234519;234911;33902.66097339044;34805.47791783125;34864;56471.15293270604;57038.42961570414;33614.32771344559;33949.151271217925;33999;34120.14699632529;34244.31511369759;12119.151659383759;12268.018558515298;12344.876551234373;12366.62900112998;12443.253404795742;10145.442000689885;10159.085682288629;10231.846522302172;10239.18086553074;10242.48787560619;8345.874811877828;8356.456830306011;8386.664533418594;8479.321654267767;8501.447405918596;3295.2750394913082;3309.255417531036;3321.5183798349103;3330.084226837639;3361.815100169514;837.5853952293531;909.3634455880909;964.6816550538306;972.6012334942781;995.2684776689127;27379.72620273772;27845.86077069642;28256;28404.289892752433;28587.28531786722;1040.2094408249784;1043.4991204222015;1051.2010871737534;1064.8722153341648;1132.5639628742992;14521.419143234363;14836.18400987956;15143.242837858063;15347.769783453257;15403.691926161639;263049;269812;270128;270529;270867;44299.77850110793;44924.55075449269;44945.77527112409;45059.54940450619;45073.549264507594;1211.2853416484318;1250.5373011985623;1267.5690265309838;1269.650846017334;1271.9682007949875;25528.744712552638;28110.156695299174;28161.295967600974;28961.420771584028;29064;41494.377584335656;41768;42290.154196916505;42370.762923708615;42505.36241956435;343289;345458;345879;346377;346962;24708.876455618327;25342.493150137263;25347.61978570286;37786.811065944494;39064;35928.4610730834;36540;36572.451413229355;36595.085122871074;36717.816410917774;31036.53445198369;31463.685363146076;31882.20294492656;32274.193145171557;32419.513707294882;31397.372052559276;31434.52848207233;31547;31611.367772644877;31698.68301316957;31583.842080789447;33335.49996750002;34174.31651366909;36626.08434789152;38132.42801358037;27610.309742256606;30567.2358191047;30843.845780770953;30847.537286940264;30855.537166942962;23757.64363534583;23874.52250955006;24191;24312.756872431048;24437.633435498126 06:02:12 INFO - PROCESS | 31626 | |2;jquery.html;376.57823237973463;381.35360563844284;385.4930766042655;387.5233462840706;388.06282826972864;14827.406903723851;15469.84530154698;16389.426370077035;16405.91797041013;16416.425425110123;10922.563097476112;10951.561937522489;10958.890411095887;10976.890231097706;11691;4607.424071991001;4608.769561521911;4791.976040119795;4819;4826.372571565709;4687.6249900007915;4754.477007529169;4779.641526885497;4804.183288840905;4809.398825146856;4668.626509879202;4770.6422018348585;4775.928361074587;4780.498047704976;5166.870828229286;5142.07442660321;5161.174212126042;5189.2475591039465;5198.1423065194385;5226.712530810804;4510.661700372485;4634.050019745944;4636.907261854778;4689.320048592969;4702.083093796711;19315.323963661343;19953.30163444287;20203.89898050515;20364.898175509177;20413.795862041337;1949.8635095543318;2040.9285675001452;2207.9337619871267;2440.5362981033722;2482.0816297969686;8559.27246184075;8900.73297801067;8980.236679882219;9054.683086092022;9111.316651251183;1682.9747553786704;1752.8510076643502;1761.3659082730208;1767.8674099442594;1794.1836464408793;61171;62844.685776571285;63705.68147159281;63977.360226397606;64333.356666433676;10011.849822252672;10074.14369778577;10192.439415832052;10211.846822297672;10320.793584128276;14023.158610483404;14363.56909292723;14484.420623175165;14527.418903243752;14556;7077.964610176916;7337.779866603903;7352.080989876265;7364.889526657104;7406.07424071991;6709.6980635871505;6721.966390168018;6866.588004719732;6895.620740859301;6955.269696681877;4313.676474264443;4356.520782713899;4418.447694038246;4457.509673935864;4520.163769702615;1840.2914877772155;1851.6389304085574;1867.8505719542404;1911.235505797692;1918.6450506656313;888.2050564744518;908.2370808520874;958.2477754962321;960.582146766159;992.503748125937;14835;16230.756538651929;16630.916845415697;16655.750163747554;16666.33334666624;839.8740188971703;846.1327139681875;877.7542288159326;886.7295474880224;888.8000199955088;8968.05835387288;9259.35184537076;9299.116583924517;9313.254939604816;9527.761805954906;404434;406888;421226;423902;424428;63369;75887.48225035469;78894;82436.58781706053;84412;878.3982971664558;879.8768172455862;891.9018907920124;899.3165194452264;908.4276905549593;14903.180325082225;15017.474388396353;15053.247337633293;15144.772828407362;15381.461648842236;33504.832475837466;34857.65142348645;35375.82312088423;36196;36271;47351.76324118357;47603;48771.268430974276;49043;50175.74912125416;7422.146453157956;7563.130240022468;7623.733169339046;7648.579328137006;7883.408744344082;10720.552725381973;10729.731756706145;11829.467673954521;11844.70388240301;11870.643880683594;9912.950435247778;10084.294099412971;10301.484925753832;10549;10585.735356616146;9979.800403992025;10190.541425635716;10238.897611024093;10284;10361.481925903523;10281.845772313272;10388.220883433622;10392.896071039193;10621.203409744454;10665.46672666348;7911.604419778873;7984.880226796487;8054.879176812469;8159.061707903667;8210.137935516685;9134.862977055482;10283.897161028293;10314.793704126025;10448.947755261175;10476.476176191312 06:02:12 INFO - PROCESS | 31626 | |3;mootools.html;1400.9369578368976;1453.2806260900854;1551.3872020551883;1743.9912800435995;1746.0484036200269;6903.689333979971;7600.619969001548;7655.502392344493;7861.646225919833;7916.762497125088;7732.188120247378;7740.651670674819;7754.922450775491;7767.106782719989;7862.764117076496;2252.526969336441;2285.6342985122383;2286.3483907086484;2289.599320118981;2292.6790249365017;2221.1670623516184;2221.466847956495;2294.919677811277;2296.1504243429954;2298.5173113646156;2301.160076572056;2333.88330583471;2344.10923848938;2364.1016413762745;2365.0894405653776;2276.704028476304;2287.1651847075864;2292.1748170658548;2292.908283668643;2299.471121642015;2255.57144142614;2266.9206577769864;2281.178775640768;2282.087165133943;2285.211601997308;7952.20477952206;7988.680452781882;8059.677612895477;8078.919210807875;8096.959515202387;4714.339992401066;4871.342368780241;4882.43851957026;4894.3147959285725;4911.312416261726;2879.5680647902773;2946.189797805599;3058.266016156129;3065.938681226385;3069.600951876264;970.1171933540514;983.3902980152279;985.1872205430549;994.5474808961977;995.3331268050351;10920.617778377798;10938.507767150497;11036.282641628268;11047.281926674741;11063.834042489369;4316.395704601358;4363.890902727458;4514.142312960527;4535.795889184995;4582.679212455163;9335.346525743269;9357.20463760588;9357.344985851061;9369.390989585656;9375.718728438158;4780.402449693788;4814.6870453420415;4824.445188803263;4866;4867.805287788448;3774.150816066418;4161.417401563784;4286.742795432284;4383.232934236496;4410.095930334273;3749.1751814600743;3767.7927713975446;3846.538415390115;3869.7484663497344;3886.7084968627464;1258.7985922252396;1274.9226903266724;1279.1877158004734;1287.6394609509352;1291.1478424239956;745.9776206713807;753.8906858505486;771.2364758888772;773.6789232468575;787.3543694170725;5289.127293996447;5385.7576409061685;5438.483344082306;5471.863203419946;5528.391876893538;415.5927191352491;437.2370213976631;441.9867403977886;446.76768080598555;454.1960729508751;3682.9079273018388;3709;3740.7007439404783;3747.887563373103;3805.961940380561;9581.952090239503;9895.455749933679;9919.40483570988;9967.651132210338;9973.152282056106;9868.309218354647;9897.604095836086;9901.009899010041;9905.207583393456;9947.751306217402;7260.891086633705;7532.8493430132185;7542.47202695817;7542.660580273791;7599.924000759922;5188.7405629719115;5346.866328341823;5348.7593058311695;5414.0796064669885;5521.475459831309;8697.869531957153;8944.642214311614;8947.910520894708;9129.360944733804;9198.770030749285;8702.303815694855;8908;8923.419977701687;9005.234555062892;9050.049744776703;6180.289266734383;6549;6668.799936001928;6739.865202696017;6795.93204067953;7389.334959853639;7405.666744996381;7409.62951852416;7428.814279642836;7470.8879366810625;6531.836704082436;6744.662766861539;6748.831279218059;6788;6847.349501797321;6712.865742685021;6720.899186512109;6734.9326506734305;6812.14848143982;6816.693248803716;6298.968505157445;6338.683065846597;6349.460295874717;6373.2989371168205;6405.551611387158;4423.535528769433;4468.262736648547;4487.102579484051;4529.252673308867;4557.453105627346;4491.46102467706;4517.277664460719;4561.3614094027525;4571.428571428572;4610.515895830889 06:02:12 INFO - PROCESS | 31626 | |4;prototype.html;315.62913576547555;317.2180574882913;320.70975766930934;322.97739158258923;323.6827908649525;5368.785248590057;5421.83734487965;5426.240326354308;5436.728163591824;5440.863978400532;5355.6251062425645;5370.248165256858;5376.650517716345;5380.677159370431;5387.892242155154;3934.547527034392;4071.3485842265245;4193.622573968342;4194.874153775377;4200.411942328076;4179.498460184782;4197.496300443936;4197.958020419787;4206.263903816835;4214.494260688722;4154.771487568182;4160.167966406731;4168.458100446937;4173.874783756492;4185.476815398075;4088.7342322748927;4149.33610622302;4167.895802604929;4170.145120250341;4189.539150693421;3606.747527673064;3615.6384361563896;3624.1483251435893;3634.2186429917697;3637.727170462226;5109.591232701412;5112.335396398482;5134.794608215667;5152.124138896396;5193.506616871391;4660.5339466053465;4793.712377257376;4798.976005119952;4831.516848315176;4831.975840120812;5600.887982240373;5616.971915140439;5633.436656334375;5639.351474580435;5640.661560306395;4021.3163762160502;4025.1081991463966;4032.3548232282988;4034.11249525104;4042.393640953851;5688.800891968803;5939.2575928009;5940.762369505214;5975.581709280352;6010.368911264298;4136.400221967798;4145.7719825409895;4147.253494370982;4155.667546596265;4171.186618609342;4199.202151591188;4205;4207.326827707613;4214.683898707548;4220.978895105505;4695.272232803921;4772.403449568804;4791.760411979387;4825.396825396825;4829.5653391194255;5626.887462250732;5645.604807663424;5659.405762394971;5681.0910254359105;5682.204491371212;1443.1557538839895;1450.2676148545129;1456.0753921260075;1456.3228098934046;1459.3505889879114;905.4431524612316;946.0425184371381;965.4545181972163;977.1840513171582;978.9608415663436;4862.7325497098;4868.14807408702;4901.6323775716255;4908.852734417902;4923.359963204761;5830.591858569859;5836.883262334814;5846.473817356458;5850.678212698257;5858.443447872445;4762.904741905142;4850.466448690641;4906.288588154697;4918.729469879191;4923.729194894244;3109.3936682346725;3131.1858916681826;3135.6707545707827;3141.4502462069045;3153.858076386568;5408.8377348679605;5421.918671219935;5431.782728690887;5437.537809286255;5440.809571665052;5789.131630255495;5977.9402205977385;5984.910226346608;6036.758529658764;6049.667268300285;5421.783128674809;5428.945710542923;5437.429069947678;5457.890842183214;5465.398806131243;5638.746256418389;5810.7094645266725;5849.444302791228;5862.706864656665;5882.23530940975;5692.516136128475;5702.087665973424;5711.343195532567;5712.0860662293835;5735.11105778605;5428.45715428454;5436.429174936575;5448.738773408991;5451.618386712892;5465.480779325958;4091.0999580092334;4163.687723420695;4172.874813755592;4174.3947127665715;4180.47744031996;5800.448957349214;5835.3581106077445;5847.619904706181;5851.912221316598;5861.974154523026;5657.4908258256955;5659;5663.292088488939;5663.433656634468;5670.149477578231;5469.617126801086;5664.564237377967;5683.3748287687495;5683.8010669626365;5693.060644993529;5347.224652425454;5540.584456165884;5564.387917329172;5571.275734154534;5576.693281869536;5598.580106491948;5769.134629805562;5779.335376431764;5784.334801497714;5789.884202315846;5554.944450555443;5563;5585.69278689676;5604.355499117491;5614.41048689898 06:02:12 INFO - PROCESS | 31626 | |5;yui.html;634.5050860328945;692.0003569056281;749.9025126733524;751.8007727952097;759.2331744937613;11887.583934562292;12014.579489717862;12347.444365003574;12353.07351948603;12545.435455404506;11325.886741132586;11470.713232169179;11490.827637585442;11523.884761152385;11559.24864883784;634.1850721822459;762.1502025241844;773.2074623510904;785;789.1950210784996;778.3034184404954;785.5404588315843;786.2609147401453;786.2726977545748;786.8111653203218;811.7645882694012;813.7396033269326;817.146082343949;817.6238930092164;818.9099199088096;804.0231119190182;805.5770720371822;810.7324582887633;811.2617518058597;812.7805492517017;595.1281372788885;595.6188039654625;595.8004068637011;597.2176448852018;597.459299334099;12547.811782823264;12609.684757881034;12611.243325400505;12625.494980200781;12628.431720572504;11608.883911160865;11791.174617776673;11866.762664746657;12010.339431331273;12228.449719762542;9759.170470509944;9817.852732209023;9829.508524573743;9959.452230127341;10025.749356266078;3239.7894136881264;3384.9492257616157;3392.1858753899132;3393.304372603635;3396.2018925552475;45679.08641827178;45690.54309456929;45795.77102114502;46974.29538556925;48863.75568122172;8580.2706769924;8679.218870301704;8684.305255579538;8705.869411958825;8733.301335893113;15868.127253000965;16122.193890305438;16122.596935076717;16132.435364762412;16145.838541614668;6485.189351331083;6488.0916671666;6718.260991290954;6776.830579235559;6802.523823332319;3670.5778835434267;3706.629337066272;3719.5350581177354;3738.570064442624;3746.28820524105;2810.2412348665744;2872.942541149165;2886.826790392583;2888;2890.8120972136744;482.645255737033;489.2490027807299;493.7013107070243;499.6926889962647;500.684568721703;370.00578752367716;414.8091877736215;502.2541525834133;509.54904909154925;517.557488347465;7132.572045677172;7150.9284907151305;7273.599952002585;7521.962390188014;7716.498427602188;500.732108322046;506.9366329208849;540.6512799244465;552.8175702018324;600.891839468891;3575.80333081683;3588.6411358863907;3610.1155216971483;3630.9273814523563;3722.4230244312175;54525;54599.18101228485;54887.45112548903;55100.72449637726;55167.448325516234;47509.762451187526;48420.75789621029;48828.511714883105;48898;49300.75349623229;43025;44570;44880.10239795186;44961.07752996045;45325.32012019822;6864.551144917249;7023.859522809617;7096.077509923677;7156;7234.276572342724;29730.702692972794;29762.404751905273;29825.552616710334;30001.249968750955;30687.079387618407;38428.615713842504;39111.6088839108;39621.207575847744;40483.79758101308;40488.392674109324;8385.496870187808;8425.157484251771;8436.072032076345;8489.151084891462;8495.108013658477;9103.49930753815;9112.95443522778;9505.524723763645;9717;9973.252006099427;9153.954230228806;9192.264618830612;9210.98679145307;9239.76900577491;9363.531823408666;8578.699745508877;8738.300935925237;8796.868046979429;8877.378583499092;9026.819463610822;8354.582270886553;8594.269487093667;8604.48373097616;8684.478931264144;8783.253423458822;8177.264046235868;8178.550179740171;8185.508869467851;8232.547209903512;8328.250457458858;7845.764627061198;8117.512949223065;8247;8251.669933202606;8480.91519084826 06:02:12 INFO - PROCESS | 31626 | __end_tp_report 06:02:12 INFO - PROCESS | 31626 | __start_cc_report 06:02:12 INFO - PROCESS | 31626 | _x_x_mozilla_cycle_collect,374 06:02:12 INFO - PROCESS | 31626 | __end_cc_report 06:02:12 INFO - PROCESS | 31626 | __startTimestamp1461330132305__endTimestamp 06:02:12 INFO - PROCESS | 31626 | 06:02:12 INFO - PROCESS | 31626 | ------- Summary: start ------- 06:02:12 INFO - PROCESS | 31626 | Number of tests: 6 06:02:12 INFO - PROCESS | 31626 | 06:02:12 INFO - PROCESS | 31626 | [#0] dojo.html Cycles:165 Average:4769.23 Median:4882.46 stddev:497.01 (10.2%) stddev-sans-first:469.55 06:02:12 INFO - PROCESS | 31626 | Values: 2637.4 2691.0 2721.6 2724.3 2734.2 4679.4 4737.6 4752.0 4763.4 4793.1 4701.4 4775.2 4821.5 4839.2 4840.1 4437.0 4475.8 4521.5 4525.7 4569.9 4456.1 4564.7 4577.3 4605.7 4618.6 4367.9 4369.8 4421.4 4490.8 4561.3 4407.7 4439.5 4448.2 4451.7 4508.2 4376.1 4382.2 4403.9 4404.9 4435.4 4725.2 4733.2 4761.8 4814.9 4818.2 5043.9 5104.1 5109.7 5124.2 5184.5 5065.3 5111.4 5138.2 5143.1 5155.3 4803.8 4848.0 4848.6 4882.5 4888.6 5253.3 5302.5 5323.1 5338.8 5377.4 4954.8 5022.8 5078.5 5105.4 5117.5 5064.0 5078.5 5083.3 5118.8 5138.7 4973.0 5104.1 5227.3 5231.1 5234.9 5110.2 5111.1 5116.4 5132.3 5133.3 4195.9 4304.7 4351.8 4379.3 4401.0 3775.8 3808.3 3814.9 3839.3 3852.5 4370.7 4470.3 4505.3 4510.4 4518.5 5050.6 5087.6 5091.7 5152.9 5183.9 4404.8 4455.2 4487.9 4495.4 4505.0 4566.3 4582.1 4637.4 4666.7 4674.3 4813.9 4816.6 4825.3 4853.4 4894.5 5154.0 5197.2 5197.9 5202.5 5258.3 4705.3 4846.3 4856.7 4926.9 4944.9 5110.3 5116.7 5123.1 5138.5 5157.0 5152.2 5174.6 5200.3 5211.8 5261.7 4816.0 4984.5 4995.0 5063.3 5111.5 4883.9 5050.7 5124.2 5125.2 5162.7 4938.4 4939.6 4969.2 4980.7 5021.2 4873.0 5070.1 5082.1 5105.8 5165.0 4973.3 5022.7 5025.3 5043.6 5048.1 06:02:12 INFO - PROCESS | 31626 | 06:02:12 INFO - PROCESS | 31626 | [#1] ext.html Cycles:180 Average:42114.28 Median:18646.39 stddev:75291.85 (403.8%) stddev-sans-first:75438.47 06:02:12 INFO - PROCESS | 31626 | Values: 576.0 611.1 625.7 629.6 637.6 32864.0 34013.5 34136.1 34260.3 34350.5 34856.7 35174.3 35376.8 35387.6 35521.1 7443.7 7604.4 7623.8 7644.6 7646.0 7404.0 7635.0 7677.9 7684.0 7708.5 7744.7 7747.2 7769.7 7777.3 7793.6 7683.8 7743.2 7744.4 7755.1 7765.8 7652.7 7726.1 7762.9 7776.4 7794.4 29080.0 35472.1 35583.8 36079.3 36198.3 2791.5 2821.4 2874.0 2929.5 3283.5 26941.3 27172.6 27243.6 27419.2 27487.0 3311.6 3351.3 3390.1 3477.9 3479.8 229277.0 232612.0 233843.0 234519.0 234911.0 33902.7 34805.5 34864.0 56471.2 57038.4 33614.3 33949.2 33999.0 34120.1 34244.3 12119.2 12268.0 12344.9 12366.6 12443.3 10145.4 10159.1 10231.8 10239.2 10242.5 8345.9 8356.5 8386.7 8479.3 8501.4 3295.3 3309.3 3321.5 3330.1 3361.8 837.6 909.4 964.7 972.6 995.3 27379.7 27845.9 28256.0 28404.3 28587.3 1040.2 1043.5 1051.2 1064.9 1132.6 14521.4 14836.2 15143.2 15347.8 15403.7 263049.0 269812.0 270128.0 270529.0 270867.0 44299.8 44924.6 44945.8 45059.5 45073.5 1211.3 1250.5 1267.6 1269.7 1272.0 25528.7 28110.2 28161.3 28961.4 29064.0 41494.4 41768.0 42290.2 42370.8 42505.4 343289.0 345458.0 345879.0 346377.0 346962.0 24708.9 25342.5 25347.6 37786.8 39064.0 35928.5 36540.0 36572.5 36595.1 36717.8 31036.5 31463.7 31882.2 32274.2 32419.5 31397.4 31434.5 31547.0 31611.4 31698.7 31583.8 33335.5 34174.3 36626.1 38132.4 27610.3 30567.2 30843.8 30847.5 30855.5 23757.6 23874.5 24191.0 24312.8 24437.6 06:02:12 INFO - PROCESS | 31626 | 06:02:12 INFO - PROCESS | 31626 | [#2] jquery.html Cycles:180 Average:24476.24 Median:4484.09 stddev:68497.13 (1527.6%) stddev-sans-first:68665.38 06:02:12 INFO - PROCESS | 31626 | Values: 376.6 381.4 385.5 387.5 388.1 14827.4 15469.8 16389.4 16405.9 16416.4 10922.6 10951.6 10958.9 10976.9 11691.0 4607.4 4608.8 4792.0 4819.0 4826.4 4687.6 4754.5 4779.6 4804.2 4809.4 4668.6 4770.6 4775.9 4780.5 5166.9 5142.1 5161.2 5189.2 5198.1 5226.7 4510.7 4634.1 4636.9 4689.3 4702.1 19315.3 19953.3 20203.9 20364.9 20413.8 1949.9 2040.9 2207.9 2440.5 2482.1 8559.3 8900.7 8980.2 9054.7 9111.3 1683.0 1752.9 1761.4 1767.9 1794.2 61171.0 62844.7 63705.7 63977.4 64333.4 10011.8 10074.1 10192.4 10211.8 10320.8 14023.2 14363.6 14484.4 14527.4 14556.0 7078.0 7337.8 7352.1 7364.9 7406.1 6709.7 6722.0 6866.6 6895.6 6955.3 4313.7 4356.5 4418.4 4457.5 4520.2 1840.3 1851.6 1867.9 1911.2 1918.6 888.2 908.2 958.2 960.6 992.5 14835.0 16230.8 16630.9 16655.8 16666.3 839.9 846.1 877.8 886.7 888.8 8968.1 9259.4 9299.1 9313.3 9527.8 404434.0 406888.0 421226.0 423902.0 424428.0 63369.0 75887.5 78894.0 82436.6 84412.0 878.4 879.9 891.9 899.3 908.4 14903.2 15017.5 15053.2 15144.8 15381.5 33504.8 34857.7 35375.8 36196.0 36271.0 47351.8 47603.0 48771.3 49043.0 50175.7 7422.1 7563.1 7623.7 7648.6 7883.4 10720.6 10729.7 11829.5 11844.7 11870.6 9913.0 10084.3 10301.5 10549.0 10585.7 9979.8 10190.5 10238.9 10284.0 10361.5 10281.8 10388.2 10392.9 10621.2 10665.5 7911.6 7984.9 8054.9 8159.1 8210.1 9134.9 10283.9 10314.8 10448.9 10476.5 06:02:12 INFO - PROCESS | 31626 | 06:02:12 INFO - PROCESS | 31626 | [#3] mootools.html Cycles:180 Average:5222.91 Median:5238.93 stddev:2916.57 (55.7%) stddev-sans-first:2910.61 06:02:12 INFO - PROCESS | 31626 | Values: 1400.9 1453.3 1551.4 1744.0 1746.0 6903.7 7600.6 7655.5 7861.6 7916.8 7732.2 7740.7 7754.9 7767.1 7862.8 2252.5 2285.6 2286.3 2289.6 2292.7 2221.2 2221.5 2294.9 2296.2 2298.5 2301.2 2333.9 2344.1 2364.1 2365.1 2276.7 2287.2 2292.2 2292.9 2299.5 2255.6 2266.9 2281.2 2282.1 2285.2 7952.2 7988.7 8059.7 8078.9 8097.0 4714.3 4871.3 4882.4 4894.3 4911.3 2879.6 2946.2 3058.3 3065.9 3069.6 970.1 983.4 985.2 994.5 995.3 10920.6 10938.5 11036.3 11047.3 11063.8 4316.4 4363.9 4514.1 4535.8 4582.7 9335.3 9357.2 9357.3 9369.4 9375.7 4780.4 4814.7 4824.4 4866.0 4867.8 3774.2 4161.4 4286.7 4383.2 4410.1 3749.2 3767.8 3846.5 3869.7 3886.7 1258.8 1274.9 1279.2 1287.6 1291.1 746.0 753.9 771.2 773.7 787.4 5289.1 5385.8 5438.5 5471.9 5528.4 415.6 437.2 442.0 446.8 454.2 3682.9 3709.0 3740.7 3747.9 3806.0 9582.0 9895.5 9919.4 9967.7 9973.2 9868.3 9897.6 9901.0 9905.2 9947.8 7260.9 7532.8 7542.5 7542.7 7599.9 5188.7 5346.9 5348.8 5414.1 5521.5 8697.9 8944.6 8947.9 9129.4 9198.8 8702.3 8908.0 8923.4 9005.2 9050.0 6180.3 6549.0 6668.8 6739.9 6795.9 7389.3 7405.7 7409.6 7428.8 7470.9 6531.8 6744.7 6748.8 6788.0 6847.3 6712.9 6720.9 6734.9 6812.1 6816.7 6299.0 6338.7 6349.5 6373.3 6405.6 4423.5 4468.3 4487.1 4529.3 4557.5 4491.5 4517.3 4561.4 4571.4 4610.5 06:02:12 INFO - PROCESS | 31626 | 06:02:12 INFO - PROCESS | 31626 | [#4] prototype.html Cycles:180 Average:4688.15 Median:5384.28 stddev:1366.41 (25.4%) stddev-sans-first:1330.25 06:02:12 INFO - PROCESS | 31626 | Values: 315.6 317.2 320.7 323.0 323.7 5368.8 5421.8 5426.2 5436.7 5440.9 5355.6 5370.2 5376.7 5380.7 5387.9 3934.5 4071.3 4193.6 4194.9 4200.4 4179.5 4197.5 4198.0 4206.3 4214.5 4154.8 4160.2 4168.5 4173.9 4185.5 4088.7 4149.3 4167.9 4170.1 4189.5 3606.7 3615.6 3624.1 3634.2 3637.7 5109.6 5112.3 5134.8 5152.1 5193.5 4660.5 4793.7 4799.0 4831.5 4832.0 5600.9 5617.0 5633.4 5639.4 5640.7 4021.3 4025.1 4032.4 4034.1 4042.4 5688.8 5939.3 5940.8 5975.6 6010.4 4136.4 4145.8 4147.3 4155.7 4171.2 4199.2 4205.0 4207.3 4214.7 4221.0 4695.3 4772.4 4791.8 4825.4 4829.6 5626.9 5645.6 5659.4 5681.1 5682.2 1443.2 1450.3 1456.1 1456.3 1459.4 905.4 946.0 965.5 977.2 979.0 4862.7 4868.1 4901.6 4908.9 4923.4 5830.6 5836.9 5846.5 5850.7 5858.4 4762.9 4850.5 4906.3 4918.7 4923.7 3109.4 3131.2 3135.7 3141.5 3153.9 5408.8 5421.9 5431.8 5437.5 5440.8 5789.1 5977.9 5984.9 6036.8 6049.7 5421.8 5428.9 5437.4 5457.9 5465.4 5638.7 5810.7 5849.4 5862.7 5882.2 5692.5 5702.1 5711.3 5712.1 5735.1 5428.5 5436.4 5448.7 5451.6 5465.5 4091.1 4163.7 4172.9 4174.4 4180.5 5800.4 5835.4 5847.6 5851.9 5862.0 5657.5 5659.0 5663.3 5663.4 5670.1 5469.6 5664.6 5683.4 5683.8 5693.1 5347.2 5540.6 5564.4 5571.3 5576.7 5598.6 5769.1 5779.3 5784.3 5789.9 5554.9 5563.0 5585.7 5604.4 5614.4 06:02:12 INFO - PROCESS | 31626 | 06:02:12 INFO - PROCESS | 31626 | [#5] yui.html Cycles:180 Average:12463.28 Median:595.37 stddev:15091.77 (2534.8%) stddev-sans-first:15107.96 06:02:12 INFO - PROCESS | 31626 | Values: 634.5 692.0 749.9 751.8 759.2 11887.6 12014.6 12347.4 12353.1 12545.4 11325.9 11470.7 11490.8 11523.9 11559.2 634.2 762.2 773.2 785.0 789.2 778.3 785.5 786.3 786.3 786.8 811.8 813.7 817.1 817.6 818.9 804.0 805.6 810.7 811.3 812.8 595.1 595.6 595.8 597.2 597.5 12547.8 12609.7 12611.2 12625.5 12628.4 11608.9 11791.2 11866.8 12010.3 12228.4 9759.2 9817.9 9829.5 9959.5 10025.7 3239.8 3384.9 3392.2 3393.3 3396.2 45679.1 45690.5 45795.8 46974.3 48863.8 8580.3 8679.2 8684.3 8705.9 8733.3 15868.1 16122.2 16122.6 16132.4 16145.8 6485.2 6488.1 6718.3 6776.8 6802.5 3670.6 3706.6 3719.5 3738.6 3746.3 2810.2 2872.9 2886.8 2888.0 2890.8 482.6 489.2 493.7 499.7 500.7 370.0 414.8 502.3 509.5 517.6 7132.6 7150.9 7273.6 7522.0 7716.5 500.7 506.9 540.7 552.8 600.9 3575.8 3588.6 3610.1 3630.9 3722.4 54525.0 54599.2 54887.5 55100.7 55167.4 47509.8 48420.8 48828.5 48898.0 49300.8 43025.0 44570.0 44880.1 44961.1 45325.3 6864.6 7023.9 7096.1 7156.0 7234.3 29730.7 29762.4 29825.6 30001.2 30687.1 38428.6 39111.6 39621.2 40483.8 40488.4 8385.5 8425.2 8436.1 8489.2 8495.1 9103.5 9113.0 9505.5 9717.0 9973.3 9154.0 9192.3 9211.0 9239.8 9363.5 8578.7 8738.3 8796.9 8877.4 9026.8 8354.6 8594.3 8604.5 8684.5 8783.3 8177.3 8178.6 8185.5 8232.5 8328.3 7845.8 8117.5 8247.0 8251.7 8480.9 06:02:12 INFO - PROCESS | 31626 | -------- Summary: end -------- 06:02:12 INFO - PROCESS | 31626 | 06:02:13 INFO - TEST-INFO | 31626: exit 0 06:02:13 INFO - TEST-OK | dromaeo_css | took 1115117ms 06:02:13 INFO - TEST-START | kraken 06:02:13 INFO - operating with platform_type : linux_ 06:02:13 INFO - Initialising browser for kraken test... 06:02:13 INFO - TEST-INFO | started process 31859 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpv38frw/profile http://localhost:33648/getInfo.html) 06:02:16 INFO - PROCESS | 31859 | 06:02:16 INFO - PROCESS | 31859 | (process:31929): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:02:17 INFO - PROCESS | 31859 | __metrics Screen width/height:1600/1200 06:02:17 INFO - PROCESS | 31859 | colorDepth:24 06:02:17 INFO - PROCESS | 31859 | Browser inner width/height: 1024/697 06:02:17 INFO - PROCESS | 31859 | __metrics 06:02:18 ERROR - PROCESS | 31859 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 06:02:19 INFO - TEST-INFO | 31859: exit 0 06:02:19 INFO - Browser initialized. 06:02:19 INFO - Running cycle 1/1 for kraken test... 06:02:19 INFO - TEST-INFO | started process 31980 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpv38frw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:02:21 INFO - PROCESS | 31980 | 06:02:21 INFO - PROCESS | 31980 | (process:32039): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:02:31 INFO - PROCESS | 31980 | RSS: Main: 165253120 06:02:31 INFO - PROCESS | 31980 | 06:02:33 INFO - PROCESS | 31980 | Cycle 1(1): loaded http://localhost:33648/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33648/tests/kraken/driver.html?testName=audio-beat-detection) 06:02:34 INFO - PROCESS | 31980 | RSS: Main: 169078784 06:02:34 INFO - PROCESS | 31980 | 06:02:37 INFO - PROCESS | 31980 | Cycle 1(1): loaded http://localhost:33648/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33648/tests/kraken/driver.html?testName=audio-dft) 06:02:38 INFO - PROCESS | 31980 | RSS: Main: 172371968 06:02:38 INFO - PROCESS | 31980 | 06:02:41 INFO - PROCESS | 31980 | Cycle 1(1): loaded http://localhost:33648/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33648/tests/kraken/driver.html?testName=audio-fft) 06:02:41 INFO - PROCESS | 31980 | RSS: Main: 164655104 06:02:41 INFO - PROCESS | 31980 | 06:02:43 INFO - PROCESS | 31980 | Cycle 1(1): loaded http://localhost:33648/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33648/tests/kraken/driver.html?testName=audio-oscillator) 06:02:44 INFO - PROCESS | 31980 | RSS: Main: 165060608 06:02:44 INFO - PROCESS | 31980 | 06:02:46 INFO - PROCESS | 31980 | Cycle 1(1): loaded http://localhost:33648/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33648/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:02:47 INFO - PROCESS | 31980 | RSS: Main: 165232640 06:02:47 INFO - PROCESS | 31980 | 06:02:50 INFO - PROCESS | 31980 | Cycle 1(1): loaded http://localhost:33648/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33648/tests/kraken/driver.html?testName=imaging-darkroom) 06:02:51 INFO - PROCESS | 31980 | RSS: Main: 165306368 06:02:51 INFO - PROCESS | 31980 | 06:02:54 INFO - PROCESS | 31980 | Cycle 1(1): loaded http://localhost:33648/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33648/tests/kraken/driver.html?testName=imaging-desaturate) 06:02:55 INFO - PROCESS | 31980 | RSS: Main: 165335040 06:02:55 INFO - PROCESS | 31980 | 06:02:58 INFO - PROCESS | 31980 | Cycle 1(1): loaded http://localhost:33648/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33648/tests/kraken/driver.html?testName=json-parse-financial) 06:02:58 INFO - PROCESS | 31980 | RSS: Main: 165871616 06:02:58 INFO - PROCESS | 31980 | 06:03:00 INFO - PROCESS | 31980 | Cycle 1(1): loaded http://localhost:33648/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33648/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:03:01 INFO - PROCESS | 31980 | RSS: Main: 165666816 06:03:01 INFO - PROCESS | 31980 | 06:03:03 INFO - PROCESS | 31980 | Cycle 1(1): loaded http://localhost:33648/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33648/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:03:03 INFO - PROCESS | 31980 | RSS: Main: 166318080 06:03:03 INFO - PROCESS | 31980 | 06:03:05 INFO - PROCESS | 31980 | Cycle 1(1): loaded http://localhost:33648/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33648/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:03:06 INFO - PROCESS | 31980 | RSS: Main: 166604800 06:03:06 INFO - PROCESS | 31980 | 06:03:09 INFO - PROCESS | 31980 | Cycle 1(1): loaded http://localhost:33648/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33648/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:03:10 INFO - PROCESS | 31980 | RSS: Main: 166961152 06:03:10 INFO - PROCESS | 31980 | 06:03:13 INFO - PROCESS | 31980 | Cycle 1(1): loaded http://localhost:33648/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33648/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:03:13 INFO - PROCESS | 31980 | RSS: Main: 166461440 06:03:13 INFO - PROCESS | 31980 | 06:03:15 INFO - PROCESS | 31980 | Cycle 1(1): loaded http://localhost:33648/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33648/tests/kraken/driver.html?testName=ai-astar) 06:03:15 INFO - PROCESS | 31980 | RSS: Main: 168239104 06:03:15 INFO - PROCESS | 31980 | 06:03:15 INFO - PROCESS | 31980 | __start_tp_report 06:03:15 INFO - PROCESS | 31980 | _x_x_mozilla_page_load 06:03:15 INFO - PROCESS | 31980 | _x_x_mozilla_page_load_details 06:03:15 INFO - PROCESS | 31980 | |i|pagename|runs| 06:03:15 INFO - PROCESS | 31980 | |0;ai-astar;115;110;113;116;115;128;113;113;113;113 06:03:15 INFO - PROCESS | 31980 | |1;audio-beat-detection;166;135;155;182;136;163;160;133;189;134 06:03:15 INFO - PROCESS | 31980 | |2;audio-dft;164;164;166;177;163;164;162;163;164;163 06:03:15 INFO - PROCESS | 31980 | |3;audio-fft;73;73;74;158;74;73;76;73;159;76 06:03:15 INFO - PROCESS | 31980 | |4;audio-oscillator;94;94;149;95;96;95;137;94;96;142 06:03:15 INFO - PROCESS | 31980 | |5;imaging-gaussian-blur;118;118;117;117;118;117;119;117;118;117 06:03:15 INFO - PROCESS | 31980 | |6;imaging-darkroom;148;147;148;147;148;148;147;148;148;147 06:03:15 INFO - PROCESS | 31980 | |7;imaging-desaturate;95;95;95;95;96;96;95;95;95;96 06:03:15 INFO - PROCESS | 31980 | |8;json-parse-financial;66;65;66;65;65;67;67;64;65;67 06:03:15 INFO - PROCESS | 31980 | |9;json-stringify-tinderbox;65;66;65;64;65;65;65;64;65;65 06:03:15 INFO - PROCESS | 31980 | |10;stanford-crypto-aes;79;81;81;79;88;79;81;83;108;80 06:03:15 INFO - PROCESS | 31980 | |11;stanford-crypto-ccm;137;134;158;152;144;135;136;139;141;147 06:03:15 INFO - PROCESS | 31980 | |12;stanford-crypto-pbkdf2;178;173;180;175;181;175;179;177;181;178 06:03:15 INFO - PROCESS | 31980 | |13;stanford-crypto-sha256-iterative;73;75;72;74;74;72;75;74;79;73 06:03:15 INFO - PROCESS | 31980 | __end_tp_report 06:03:15 INFO - PROCESS | 31980 | __start_cc_report 06:03:15 INFO - PROCESS | 31980 | _x_x_mozilla_cycle_collect,910 06:03:15 INFO - PROCESS | 31980 | __end_cc_report 06:03:15 INFO - PROCESS | 31980 | __startTimestamp1461330195798__endTimestamp 06:03:15 INFO - PROCESS | 31980 | 06:03:15 INFO - PROCESS | 31980 | ------- Summary: start ------- 06:03:15 INFO - PROCESS | 31980 | Number of tests: 14 06:03:15 INFO - PROCESS | 31980 | 06:03:15 INFO - PROCESS | 31980 | [#0] ai-astar Cycles:10 Average:114.90 Median:114.00 stddev:4.89 (4.3%) stddev-sans-first:5.18 06:03:15 INFO - PROCESS | 31980 | Values: 115.0 110.0 113.0 116.0 115.0 128.0 113.0 113.0 113.0 113.0 06:03:15 INFO - PROCESS | 31980 | 06:03:15 INFO - PROCESS | 31980 | [#1] audio-beat-detection Cycles:10 Average:155.30 Median:161.50 stddev:20.49 (12.7%) stddev-sans-first:21.37 06:03:15 INFO - PROCESS | 31980 | Values: 166.0 135.0 155.0 182.0 136.0 163.0 160.0 133.0 189.0 134.0 06:03:15 INFO - PROCESS | 31980 | 06:03:15 INFO - PROCESS | 31980 | [#2] audio-dft Cycles:10 Average:165.00 Median:164.00 stddev:4.35 (2.7%) stddev-sans-first:4.59 06:03:15 INFO - PROCESS | 31980 | Values: 164.0 164.0 166.0 177.0 163.0 164.0 162.0 163.0 164.0 163.0 06:03:15 INFO - PROCESS | 31980 | 06:03:15 INFO - PROCESS | 31980 | [#3] audio-fft Cycles:10 Average:90.90 Median:73.50 stddev:35.65 (48.5%) stddev-sans-first:37.22 06:03:15 INFO - PROCESS | 31980 | Values: 73.0 73.0 74.0 158.0 74.0 73.0 76.0 73.0 159.0 76.0 06:03:15 INFO - PROCESS | 31980 | 06:03:15 INFO - PROCESS | 31980 | [#4] audio-oscillator Cycles:10 Average:109.20 Median:94.50 stddev:23.28 (24.6%) stddev-sans-first:24.03 06:03:15 INFO - PROCESS | 31980 | Values: 94.0 94.0 149.0 95.0 96.0 95.0 137.0 94.0 96.0 142.0 06:03:15 INFO - PROCESS | 31980 | 06:03:15 INFO - PROCESS | 31980 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.70 (0.6%) stddev-sans-first:0.73 06:03:15 INFO - PROCESS | 31980 | Values: 118.0 118.0 117.0 117.0 118.0 117.0 119.0 117.0 118.0 117.0 06:03:15 INFO - PROCESS | 31980 | 06:03:15 INFO - PROCESS | 31980 | [#6] imaging-darkroom Cycles:10 Average:147.60 Median:148.00 stddev:0.52 (0.3%) stddev-sans-first:0.53 06:03:15 INFO - PROCESS | 31980 | Values: 148.0 147.0 148.0 147.0 148.0 148.0 147.0 148.0 148.0 147.0 06:03:15 INFO - PROCESS | 31980 | 06:03:15 INFO - PROCESS | 31980 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 06:03:15 INFO - PROCESS | 31980 | Values: 95.0 95.0 95.0 95.0 96.0 96.0 95.0 95.0 95.0 96.0 06:03:15 INFO - PROCESS | 31980 | 06:03:15 INFO - PROCESS | 31980 | [#8] json-parse-financial Cycles:10 Average:65.70 Median:66.00 stddev:1.06 (1.6%) stddev-sans-first:1.12 06:03:15 INFO - PROCESS | 31980 | Values: 66.0 65.0 66.0 65.0 65.0 67.0 67.0 64.0 65.0 67.0 06:03:15 INFO - PROCESS | 31980 | 06:03:15 INFO - PROCESS | 31980 | [#9] json-stringify-tinderbox Cycles:10 Average:64.90 Median:65.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 06:03:15 INFO - PROCESS | 31980 | Values: 65.0 66.0 65.0 64.0 65.0 65.0 65.0 64.0 65.0 65.0 06:03:15 INFO - PROCESS | 31980 | 06:03:15 INFO - PROCESS | 31980 | [#10] stanford-crypto-aes Cycles:10 Average:83.90 Median:81.00 stddev:8.89 (11.0%) stddev-sans-first:9.25 06:03:15 INFO - PROCESS | 31980 | Values: 79.0 81.0 81.0 79.0 88.0 79.0 81.0 83.0 108.0 80.0 06:03:15 INFO - PROCESS | 31980 | 06:03:15 INFO - PROCESS | 31980 | [#11] stanford-crypto-ccm Cycles:10 Average:142.30 Median:142.50 stddev:7.94 (5.6%) stddev-sans-first:8.19 06:03:15 INFO - PROCESS | 31980 | Values: 137.0 134.0 158.0 152.0 144.0 135.0 136.0 139.0 141.0 147.0 06:03:15 INFO - PROCESS | 31980 | 06:03:15 INFO - PROCESS | 31980 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.70 Median:178.50 stddev:2.71 (1.5%) stddev-sans-first:2.87 06:03:15 INFO - PROCESS | 31980 | Values: 178.0 173.0 180.0 175.0 181.0 175.0 179.0 177.0 181.0 178.0 06:03:15 INFO - PROCESS | 31980 | 06:03:15 INFO - PROCESS | 31980 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.10 Median:74.00 stddev:2.02 (2.7%) stddev-sans-first:2.11 06:03:15 INFO - PROCESS | 31980 | Values: 73.0 75.0 72.0 74.0 74.0 72.0 75.0 74.0 79.0 73.0 06:03:15 INFO - PROCESS | 31980 | -------- Summary: end -------- 06:03:15 INFO - PROCESS | 31980 | 06:03:16 INFO - TEST-INFO | 31980: exit 0 06:03:16 INFO - TEST-OK | kraken | took 63774ms 06:03:16 INFO - SUITE-END | took 1178s 06:03:16 INFO - Completed test suite (00:19:38) 06:03:16 INFO - javascript benchmark 06:03:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2637.393399518111, 2690.9774285771405, 2721.564549672053, 2724.3189202699327, 2734.2344143639775, 4679.438467383919, 4737.62099032077, 4751.976240118799, 4763.35694681218, 4793.1132740443045, 4701.388819453475, 4775.212090005154, 4821.4696383397795, 4839.177339852225, 4840.104580652582, 4436.977815110928, 4475.843345482893, 4521.502634710179, 4525.705829121113, 4569.885752856172, 4456.108778244348, 4564.680472366936, 4577.336286238494, 4605.700629459091, 4618.561236682526, 4367.934480982788, 4369.781510924473, 4421.403110580062, 4490.797914093857, 4561.29299958507, 4407.713498622601, 4439.511653718088, 4448.1770872388715, 4451.688381813275, 4508.188526065307, 4376.081022985145, 4382.233109205877, 4403.889902752425, 4404.911901761947, 4435.445569303837, 4725.1730947084125, 4733.219018861883, 4761.833335833264, 4814.927776083362, 4818.229083346648, 5043.924341134886, 5104.106781313255, 5109.744512774347, 5124.154514505102, 5184.533391994739, 5065.265536497224, 5111.412187598399, 5138.177891537336, 5143.074246635604, 5155.278261043457, 4803.78382972767, 4847.95152048475, 4848.587870031016, 4882.462929077798, 4888.560029597354, 5253.290805741252, 5302.469753024667, 5323.095073837457, 5338.759755810997, 5377.435369286169, 4954.826581069645, 5022.773975171126, 5078.542931136216, 5105.412877519133, 5117.513836185556, 5063.974680126576, 5078.5175408336145, 5083.262926875583, 5118.795248190031, 5138.691678499302, 4972.975135124374, 5104.081265372194, 5227.294315267466, 5231.084560201949, 5234.869128271747, 5110.182370820651, 5111.080005599028, 5116.360454943132, 5132.28148059272, 5133.307003554547, 4195.895102622398, 4304.6556275498515, 4351.804168812348, 4379.255526560492, 4400.9559904401185, 3775.811209439517, 3808.27642747877, 3814.8855534334016, 3839.308924393636, 3852.5184351956004, 4370.694051416434, 4470.307102399133, 4505.301678239878, 4510.368548403226, 4518.480374756879, 5050.621203409759, 5087.592992560586, 5091.745412729423, 5152.92270615941, 5183.922241166386, 4404.757738324359, 4455.1757924784015, 4487.910241795211, 4495.43807024122, 4505.0, 4566.3150527420485, 4582.083583283356, 4637.397138372057, 4666.719996800135, 4674.2988551716835, 4813.927791083137, 4816.614670826396, 4825.252085926687, 4853.441854186673, 4894.535019173173, 5154.023720449045, 5197.168453047494, 5197.948020519746, 5202.531772140525, 5258.316418865523, 4705.34125222476, 4846.321514987975, 4856.660033797601, 4926.926096108633, 4944.92582611254, 5110.310108135503, 5116.692998420107, 5123.103456895103, 5138.486151384832, 5157.0, 5152.175651895679, 5174.63777535584, 5200.349956255468, 5211.765470553758, 5261.710605916712, 4815.95184048155, 4984.526469985346, 4994.9500504994485, 5063.265826455217, 5111.488851114858, 4883.926741098815, 5050.722210278323, 5124.154514505065, 5125.179971204739, 5162.6902385856965, 4938.43208031081, 4939.629527785359, 4969.180085285887, 4980.676256043345, 5021.196608542616, 4873.0, 5070.062038522885, 5082.085224659449, 5105.821296254762, 5164.9741751291, 4973.254011898244, 5022.698638081581, 5025.321581586585, 5043.5712964398435, 5048.141815891381], "value": 4737.742024332016, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [575.9625624334418, 611.1352436302632, 625.7152995387099, 629.6033498895697, 637.5537124013192, 32864.0, 34013.48979765299, 34136.14659633507, 34260.314793704114, 34350.48474272888, 34856.651433485655, 35174.296514069705, 35376.82311588445, 35387.646123538754, 35521.111972200706, 7443.665035073421, 7604.391648668094, 7623.847523049536, 7644.61776911155, 7645.961770191141, 7404.0374751282525, 7635.0, 7677.884831727529, 7684.039495063117, 7708.537487750753, 7744.651490682904, 7747.225277472264, 7769.650365733527, 7777.261160189773, 7793.649285782153, 7683.807904802369, 7743.18696536864, 7744.41916856238, 7755.069391672979, 7765.7670269892, 7652.732154374626, 7726.111497177784, 7762.922370776333, 7776.416768742367, 7794.41541884361, 29080.0, 35472.113197170016, 35583.82208088969, 36079.27841443183, 36198.27603447943, 2791.4556661451024, 2821.379296554775, 2874.0, 2929.4580502606873, 3283.5238890361, 26941.32646683829, 27172.59241111385, 27243.591346129822, 27419.17742467729, 27487.0, 3311.569495965509, 3351.262722201112, 3390.118569172033, 3477.94783078254, 3479.791212527231, 229277.0, 232612.0, 233843.0, 234519.0, 234911.0, 33902.66097339044, 34805.47791783125, 34864.0, 56471.15293270604, 57038.42961570414, 33614.32771344559, 33949.151271217925, 33999.0, 34120.14699632529, 34244.31511369759, 12119.151659383759, 12268.018558515298, 12344.876551234373, 12366.62900112998, 12443.253404795742, 10145.442000689885, 10159.085682288629, 10231.846522302172, 10239.18086553074, 10242.48787560619, 8345.874811877828, 8356.456830306011, 8386.664533418594, 8479.321654267767, 8501.447405918596, 3295.2750394913082, 3309.255417531036, 3321.5183798349103, 3330.084226837639, 3361.815100169514, 837.5853952293531, 909.3634455880909, 964.6816550538306, 972.6012334942781, 995.2684776689127, 27379.72620273772, 27845.86077069642, 28256.0, 28404.289892752433, 28587.28531786722, 1040.2094408249784, 1043.4991204222015, 1051.2010871737534, 1064.8722153341648, 1132.5639628742992, 14521.419143234363, 14836.18400987956, 15143.242837858063, 15347.769783453257, 15403.691926161639, 263049.0, 269812.0, 270128.0, 270529.0, 270867.0, 44299.77850110793, 44924.55075449269, 44945.77527112409, 45059.54940450619, 45073.549264507594, 1211.2853416484318, 1250.5373011985623, 1267.5690265309838, 1269.650846017334, 1271.9682007949875, 25528.744712552638, 28110.156695299174, 28161.295967600974, 28961.420771584028, 29064.0, 41494.377584335656, 41768.0, 42290.154196916505, 42370.762923708615, 42505.36241956435, 343289.0, 345458.0, 345879.0, 346377.0, 346962.0, 24708.876455618327, 25342.493150137263, 25347.61978570286, 37786.811065944494, 39064.0, 35928.4610730834, 36540.0, 36572.451413229355, 36595.085122871074, 36717.816410917774, 31036.53445198369, 31463.685363146076, 31882.20294492656, 32274.193145171557, 32419.513707294882, 31397.372052559276, 31434.52848207233, 31547.0, 31611.367772644877, 31698.68301316957, 31583.842080789447, 33335.49996750002, 34174.31651366909, 36626.08434789152, 38132.42801358037, 27610.309742256606, 30567.2358191047, 30843.845780770953, 30847.537286940264, 30855.537166942962, 23757.64363534583, 23874.52250955006, 24191.0, 24312.756872431048, 24437.633435498126], "value": 15868.028988572225, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [376.57823237973463, 381.35360563844284, 385.4930766042655, 387.5233462840706, 388.06282826972864, 14827.406903723851, 15469.84530154698, 16389.426370077035, 16405.91797041013, 16416.425425110123, 10922.563097476112, 10951.561937522489, 10958.890411095887, 10976.890231097706, 11691.0, 4607.424071991001, 4608.769561521911, 4791.976040119795, 4819.0, 4826.372571565709, 4687.6249900007915, 4754.477007529169, 4779.641526885497, 4804.183288840905, 4809.398825146856, 4668.626509879202, 4770.6422018348585, 4775.928361074587, 4780.498047704976, 5166.870828229286, 5142.07442660321, 5161.174212126042, 5189.2475591039465, 5198.1423065194385, 5226.712530810804, 4510.661700372485, 4634.050019745944, 4636.907261854778, 4689.320048592969, 4702.083093796711, 19315.323963661343, 19953.30163444287, 20203.89898050515, 20364.898175509177, 20413.795862041337, 1949.8635095543318, 2040.9285675001452, 2207.9337619871267, 2440.5362981033722, 2482.0816297969686, 8559.27246184075, 8900.73297801067, 8980.236679882219, 9054.683086092022, 9111.316651251183, 1682.9747553786704, 1752.8510076643502, 1761.3659082730208, 1767.8674099442594, 1794.1836464408793, 61171.0, 62844.685776571285, 63705.68147159281, 63977.360226397606, 64333.356666433676, 10011.849822252672, 10074.14369778577, 10192.439415832052, 10211.846822297672, 10320.793584128276, 14023.158610483404, 14363.56909292723, 14484.420623175165, 14527.418903243752, 14556.0, 7077.964610176916, 7337.779866603903, 7352.080989876265, 7364.889526657104, 7406.07424071991, 6709.6980635871505, 6721.966390168018, 6866.588004719732, 6895.620740859301, 6955.269696681877, 4313.676474264443, 4356.520782713899, 4418.447694038246, 4457.509673935864, 4520.163769702615, 1840.2914877772155, 1851.6389304085574, 1867.8505719542404, 1911.235505797692, 1918.6450506656313, 888.2050564744518, 908.2370808520874, 958.2477754962321, 960.582146766159, 992.503748125937, 14835.0, 16230.756538651929, 16630.916845415697, 16655.750163747554, 16666.33334666624, 839.8740188971703, 846.1327139681875, 877.7542288159326, 886.7295474880224, 888.8000199955088, 8968.05835387288, 9259.35184537076, 9299.116583924517, 9313.254939604816, 9527.761805954906, 404434.0, 406888.0, 421226.0, 423902.0, 424428.0, 63369.0, 75887.48225035469, 78894.0, 82436.58781706053, 84412.0, 878.3982971664558, 879.8768172455862, 891.9018907920124, 899.3165194452264, 908.4276905549593, 14903.180325082225, 15017.474388396353, 15053.247337633293, 15144.772828407362, 15381.461648842236, 33504.832475837466, 34857.65142348645, 35375.82312088423, 36196.0, 36271.0, 47351.76324118357, 47603.0, 48771.268430974276, 49043.0, 50175.74912125416, 7422.146453157956, 7563.130240022468, 7623.733169339046, 7648.579328137006, 7883.408744344082, 10720.552725381973, 10729.731756706145, 11829.467673954521, 11844.70388240301, 11870.643880683594, 9912.950435247778, 10084.294099412971, 10301.484925753832, 10549.0, 10585.735356616146, 9979.800403992025, 10190.541425635716, 10238.897611024093, 10284.0, 10361.481925903523, 10281.845772313272, 10388.220883433622, 10392.896071039193, 10621.203409744454, 10665.46672666348, 7911.604419778873, 7984.880226796487, 8054.879176812469, 8159.061707903667, 8210.137935516685, 9134.862977055482, 10283.897161028293, 10314.793704126025, 10448.947755261175, 10476.476176191312], "value": 8008.411620089244, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1400.9369578368976, 1453.2806260900854, 1551.3872020551883, 1743.9912800435995, 1746.0484036200269, 6903.689333979971, 7600.619969001548, 7655.502392344493, 7861.646225919833, 7916.762497125088, 7732.188120247378, 7740.651670674819, 7754.922450775491, 7767.106782719989, 7862.764117076496, 2252.526969336441, 2285.6342985122383, 2286.3483907086484, 2289.599320118981, 2292.6790249365017, 2221.1670623516184, 2221.466847956495, 2294.919677811277, 2296.1504243429954, 2298.5173113646156, 2301.160076572056, 2333.88330583471, 2344.10923848938, 2364.1016413762745, 2365.0894405653776, 2276.704028476304, 2287.1651847075864, 2292.1748170658548, 2292.908283668643, 2299.471121642015, 2255.57144142614, 2266.9206577769864, 2281.178775640768, 2282.087165133943, 2285.211601997308, 7952.20477952206, 7988.680452781882, 8059.677612895477, 8078.919210807875, 8096.959515202387, 4714.339992401066, 4871.342368780241, 4882.43851957026, 4894.3147959285725, 4911.312416261726, 2879.5680647902773, 2946.189797805599, 3058.266016156129, 3065.938681226385, 3069.600951876264, 970.1171933540514, 983.3902980152279, 985.1872205430549, 994.5474808961977, 995.3331268050351, 10920.617778377798, 10938.507767150497, 11036.282641628268, 11047.281926674741, 11063.834042489369, 4316.395704601358, 4363.890902727458, 4514.142312960527, 4535.795889184995, 4582.679212455163, 9335.346525743269, 9357.20463760588, 9357.344985851061, 9369.390989585656, 9375.718728438158, 4780.402449693788, 4814.6870453420415, 4824.445188803263, 4866.0, 4867.805287788448, 3774.150816066418, 4161.417401563784, 4286.742795432284, 4383.232934236496, 4410.095930334273, 3749.1751814600743, 3767.7927713975446, 3846.538415390115, 3869.7484663497344, 3886.7084968627464, 1258.7985922252396, 1274.9226903266724, 1279.1877158004734, 1287.6394609509352, 1291.1478424239956, 745.9776206713807, 753.8906858505486, 771.2364758888772, 773.6789232468575, 787.3543694170725, 5289.127293996447, 5385.7576409061685, 5438.483344082306, 5471.863203419946, 5528.391876893538, 415.5927191352491, 437.2370213976631, 441.9867403977886, 446.76768080598555, 454.1960729508751, 3682.9079273018388, 3709.0, 3740.7007439404783, 3747.887563373103, 3805.961940380561, 9581.952090239503, 9895.455749933679, 9919.40483570988, 9967.651132210338, 9973.152282056106, 9868.309218354647, 9897.604095836086, 9901.009899010041, 9905.207583393456, 9947.751306217402, 7260.891086633705, 7532.8493430132185, 7542.47202695817, 7542.660580273791, 7599.924000759922, 5188.7405629719115, 5346.866328341823, 5348.7593058311695, 5414.0796064669885, 5521.475459831309, 8697.869531957153, 8944.642214311614, 8947.910520894708, 9129.360944733804, 9198.770030749285, 8702.303815694855, 8908.0, 8923.419977701687, 9005.234555062892, 9050.049744776703, 6180.289266734383, 6549.0, 6668.799936001928, 6739.865202696017, 6795.93204067953, 7389.334959853639, 7405.666744996381, 7409.62951852416, 7428.814279642836, 7470.8879366810625, 6531.836704082436, 6744.662766861539, 6748.831279218059, 6788.0, 6847.349501797321, 6712.865742685021, 6720.899186512109, 6734.9326506734305, 6812.14848143982, 6816.693248803716, 6298.968505157445, 6338.683065846597, 6349.460295874717, 6373.2989371168205, 6405.551611387158, 4423.535528769433, 4468.262736648547, 4487.102579484051, 4529.252673308867, 4557.453105627346, 4491.46102467706, 4517.277664460719, 4561.3614094027525, 4571.428571428572, 4610.515895830889], "value": 4159.296582045373, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [315.62913576547555, 317.2180574882913, 320.70975766930934, 322.97739158258923, 323.6827908649525, 5368.785248590057, 5421.83734487965, 5426.240326354308, 5436.728163591824, 5440.863978400532, 5355.6251062425645, 5370.248165256858, 5376.650517716345, 5380.677159370431, 5387.892242155154, 3934.547527034392, 4071.3485842265245, 4193.622573968342, 4194.874153775377, 4200.411942328076, 4179.498460184782, 4197.496300443936, 4197.958020419787, 4206.263903816835, 4214.494260688722, 4154.771487568182, 4160.167966406731, 4168.458100446937, 4173.874783756492, 4185.476815398075, 4088.7342322748927, 4149.33610622302, 4167.895802604929, 4170.145120250341, 4189.539150693421, 3606.747527673064, 3615.6384361563896, 3624.1483251435893, 3634.2186429917697, 3637.727170462226, 5109.591232701412, 5112.335396398482, 5134.794608215667, 5152.124138896396, 5193.506616871391, 4660.5339466053465, 4793.712377257376, 4798.976005119952, 4831.516848315176, 4831.975840120812, 5600.887982240373, 5616.971915140439, 5633.436656334375, 5639.351474580435, 5640.661560306395, 4021.3163762160502, 4025.1081991463966, 4032.3548232282988, 4034.11249525104, 4042.393640953851, 5688.800891968803, 5939.2575928009, 5940.762369505214, 5975.581709280352, 6010.368911264298, 4136.400221967798, 4145.7719825409895, 4147.253494370982, 4155.667546596265, 4171.186618609342, 4199.202151591188, 4205.0, 4207.326827707613, 4214.683898707548, 4220.978895105505, 4695.272232803921, 4772.403449568804, 4791.760411979387, 4825.396825396825, 4829.5653391194255, 5626.887462250732, 5645.604807663424, 5659.405762394971, 5681.0910254359105, 5682.204491371212, 1443.1557538839895, 1450.2676148545129, 1456.0753921260075, 1456.3228098934046, 1459.3505889879114, 905.4431524612316, 946.0425184371381, 965.4545181972163, 977.1840513171582, 978.9608415663436, 4862.7325497098, 4868.14807408702, 4901.6323775716255, 4908.852734417902, 4923.359963204761, 5830.591858569859, 5836.883262334814, 5846.473817356458, 5850.678212698257, 5858.443447872445, 4762.904741905142, 4850.466448690641, 4906.288588154697, 4918.729469879191, 4923.729194894244, 3109.3936682346725, 3131.1858916681826, 3135.6707545707827, 3141.4502462069045, 3153.858076386568, 5408.8377348679605, 5421.918671219935, 5431.782728690887, 5437.537809286255, 5440.809571665052, 5789.131630255495, 5977.9402205977385, 5984.910226346608, 6036.758529658764, 6049.667268300285, 5421.783128674809, 5428.945710542923, 5437.429069947678, 5457.890842183214, 5465.398806131243, 5638.746256418389, 5810.7094645266725, 5849.444302791228, 5862.706864656665, 5882.23530940975, 5692.516136128475, 5702.087665973424, 5711.343195532567, 5712.0860662293835, 5735.11105778605, 5428.45715428454, 5436.429174936575, 5448.738773408991, 5451.618386712892, 5465.480779325958, 4091.0999580092334, 4163.687723420695, 4172.874813755592, 4174.3947127665715, 4180.47744031996, 5800.448957349214, 5835.3581106077445, 5847.619904706181, 5851.912221316598, 5861.974154523026, 5657.4908258256955, 5659.0, 5663.292088488939, 5663.433656634468, 5670.149477578231, 5469.617126801086, 5664.564237377967, 5683.3748287687495, 5683.8010669626365, 5693.060644993529, 5347.224652425454, 5540.584456165884, 5564.387917329172, 5571.275734154534, 5576.693281869536, 5598.580106491948, 5769.134629805562, 5779.335376431764, 5784.334801497714, 5789.884202315846, 5554.944450555443, 5563.0, 5585.69278689676, 5604.355499117491, 5614.41048689898], "value": 4250.001963223007, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [634.5050860328945, 692.0003569056281, 749.9025126733524, 751.8007727952097, 759.2331744937613, 11887.583934562292, 12014.579489717862, 12347.444365003574, 12353.07351948603, 12545.435455404506, 11325.886741132586, 11470.713232169179, 11490.827637585442, 11523.884761152385, 11559.24864883784, 634.1850721822459, 762.1502025241844, 773.2074623510904, 785.0, 789.1950210784996, 778.3034184404954, 785.5404588315843, 786.2609147401453, 786.2726977545748, 786.8111653203218, 811.7645882694012, 813.7396033269326, 817.146082343949, 817.6238930092164, 818.9099199088096, 804.0231119190182, 805.5770720371822, 810.7324582887633, 811.2617518058597, 812.7805492517017, 595.1281372788885, 595.6188039654625, 595.8004068637011, 597.2176448852018, 597.459299334099, 12547.811782823264, 12609.684757881034, 12611.243325400505, 12625.494980200781, 12628.431720572504, 11608.883911160865, 11791.174617776673, 11866.762664746657, 12010.339431331273, 12228.449719762542, 9759.170470509944, 9817.852732209023, 9829.508524573743, 9959.452230127341, 10025.749356266078, 3239.7894136881264, 3384.9492257616157, 3392.1858753899132, 3393.304372603635, 3396.2018925552475, 45679.08641827178, 45690.54309456929, 45795.77102114502, 46974.29538556925, 48863.75568122172, 8580.2706769924, 8679.218870301704, 8684.305255579538, 8705.869411958825, 8733.301335893113, 15868.127253000965, 16122.193890305438, 16122.596935076717, 16132.435364762412, 16145.838541614668, 6485.189351331083, 6488.0916671666, 6718.260991290954, 6776.830579235559, 6802.523823332319, 3670.5778835434267, 3706.629337066272, 3719.5350581177354, 3738.570064442624, 3746.28820524105, 2810.2412348665744, 2872.942541149165, 2886.826790392583, 2888.0, 2890.8120972136744, 482.645255737033, 489.2490027807299, 493.7013107070243, 499.6926889962647, 500.684568721703, 370.00578752367716, 414.8091877736215, 502.2541525834133, 509.54904909154925, 517.557488347465, 7132.572045677172, 7150.9284907151305, 7273.599952002585, 7521.962390188014, 7716.498427602188, 500.732108322046, 506.9366329208849, 540.6512799244465, 552.8175702018324, 600.891839468891, 3575.80333081683, 3588.6411358863907, 3610.1155216971483, 3630.9273814523563, 3722.4230244312175, 54525.0, 54599.18101228485, 54887.45112548903, 55100.72449637726, 55167.448325516234, 47509.762451187526, 48420.75789621029, 48828.511714883105, 48898.0, 49300.75349623229, 43025.0, 44570.0, 44880.10239795186, 44961.07752996045, 45325.32012019822, 6864.551144917249, 7023.859522809617, 7096.077509923677, 7156.0, 7234.276572342724, 29730.702692972794, 29762.404751905273, 29825.552616710334, 30001.249968750955, 30687.079387618407, 38428.615713842504, 39111.6088839108, 39621.207575847744, 40483.79758101308, 40488.392674109324, 8385.496870187808, 8425.157484251771, 8436.072032076345, 8489.151084891462, 8495.108013658477, 9103.49930753815, 9112.95443522778, 9505.524723763645, 9717.0, 9973.252006099427, 9153.954230228806, 9192.264618830612, 9210.98679145307, 9239.76900577491, 9363.531823408666, 8578.699745508877, 8738.300935925237, 8796.868046979429, 8877.378583499092, 9026.819463610822, 8354.582270886553, 8594.269487093667, 8604.48373097616, 8684.478931264144, 8783.253423458822, 8177.264046235868, 8178.550179740171, 8185.508869467851, 8232.547209903512, 8328.250457458858, 7845.764627061198, 8117.512949223065, 8247.0, 8251.669933202606, 8480.91519084826], "value": 5561.231156723592, "unit": "score"}], "name": "dromaeo_css", "value": 6242.763492719825, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 110.0, 113.0, 116.0, 115.0, 128.0, 113.0, 113.0, 113.0, 113.0], "value": 114.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 135.0, 155.0, 182.0, 136.0, 163.0, 160.0, 133.0, 189.0, 134.0], "value": 155.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 166.0, 177.0, 163.0, 164.0, 162.0, 163.0, 164.0, 163.0], "value": 165.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 74.0, 158.0, 74.0, 73.0, 76.0, 73.0, 159.0, 76.0], "value": 90.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 149.0, 95.0, 96.0, 95.0, 137.0, 94.0, 96.0, 142.0], "value": 109.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 117.0, 118.0, 117.0, 119.0, 117.0, 118.0, 117.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 148.0, 147.0, 148.0, 148.0, 147.0, 148.0, 148.0, 147.0], "value": 147.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 95.0, 95.0, 96.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 66.0, 65.0, 65.0, 67.0, 67.0, 64.0, 65.0, 67.0], "value": 65.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 65.0, 64.0, 65.0, 65.0, 65.0, 64.0, 65.0, 65.0], "value": 64.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 81.0, 81.0, 79.0, 88.0, 79.0, 81.0, 83.0, 108.0, 80.0], "value": 83.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 134.0, 158.0, 152.0, 144.0, 135.0, 136.0, 139.0, 141.0, 147.0], "value": 142.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 173.0, 180.0, 175.0, 181.0, 175.0, 179.0, 177.0, 181.0, 178.0], "value": 177.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 75.0, 72.0, 74.0, 74.0, 72.0, 75.0, 74.0, 79.0, 73.0], "value": 74.1, "unit": "score"}], "name": "kraken", "value": 1604.4, "alertThreshold": 2.0}]} 06:03:17 INFO - Return code: 0 06:03:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:03:17 ERROR - # TBPL SUCCESS # 06:03:17 INFO - Running post-action listener: _resource_record_post_action 06:03:17 INFO - Running post-run listener: _resource_record_post_run 06:03:18 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 0; Write bytes: 518402048; Read time: 0; Write time: 431716 06:03:18 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 234676224; Read time: 0; Write time: 267952 06:03:18 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 0; Write bytes: 283664384; Read time: 0; Write time: 163764 06:03:18 INFO - Running post-run listener: _upload_blobber_files 06:03:18 INFO - Blob upload gear active. 06:03:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:03:18 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 06:03:18 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'] 06:03:18 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 06:03:18 INFO - (blobuploader) - INFO - Open directory for files ... 06:03:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:03:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:03:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:03:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:03:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:03:19 INFO - (blobuploader) - INFO - Done attempting. 06:03:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:03:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:03:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:03:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:03:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:03:20 INFO - (blobuploader) - INFO - Done attempting. 06:03:20 INFO - (blobuploader) - INFO - Iteration through files over. 06:03:20 INFO - Return code: 0 06:03:20 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:03:20 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:03:20 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3d883cc81ddb2b6f8d2c9df773856e0bd1096cfb1487af16ff30735fde5554f9e271489a93f0a0ff0913ccac16bf3cde7053d08665d342a6a9fb46a828575f44", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/04664fda582b12597d996c465202904a3db480456d040a3e29e270bfcc914288baf60daae99c16af7bc11a2e87b116b643e17a1793eaa2e650076a3f0aa01a41"} 06:03:20 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:03:20 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:03:20 INFO - Contents: 06:03:20 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3d883cc81ddb2b6f8d2c9df773856e0bd1096cfb1487af16ff30735fde5554f9e271489a93f0a0ff0913ccac16bf3cde7053d08665d342a6a9fb46a828575f44", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/04664fda582b12597d996c465202904a3db480456d040a3e29e270bfcc914288baf60daae99c16af7bc11a2e87b116b643e17a1793eaa2e650076a3f0aa01a41"} 06:03:20 INFO - Running post-run listener: copy_logs_to_upload_dir 06:03:20 INFO - Copying logs to upload dir... 06:03:20 INFO - mkdir: /builds/slave/test/build/upload/logs 06:03:20 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.270049 ========= master_lag: 54.97 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 29 secs) (at 2016-04-22 06:04:15.055294) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-04-22 06:04:15.058494) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1461328964.350593-1865589231 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3d883cc81ddb2b6f8d2c9df773856e0bd1096cfb1487af16ff30735fde5554f9e271489a93f0a0ff0913ccac16bf3cde7053d08665d342a6a9fb46a828575f44", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/04664fda582b12597d996c465202904a3db480456d040a3e29e270bfcc914288baf60daae99c16af7bc11a2e87b116b643e17a1793eaa2e650076a3f0aa01a41"} build_url:https://queue.taskcluster.net/v1/task/D5pYoYECQPOA_-xi3A8o-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011196 build_url: 'https://queue.taskcluster.net/v1/task/D5pYoYECQPOA_-xi3A8o-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3d883cc81ddb2b6f8d2c9df773856e0bd1096cfb1487af16ff30735fde5554f9e271489a93f0a0ff0913ccac16bf3cde7053d08665d342a6a9fb46a828575f44", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/04664fda582b12597d996c465202904a3db480456d040a3e29e270bfcc914288baf60daae99c16af7bc11a2e87b116b643e17a1793eaa2e650076a3f0aa01a41"}' ========= master_lag: 1.16 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-04-22 06:04:16.229749) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 06:04:16.230139) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1461328964.350593-1865589231 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004453 ========= master_lag: 0.36 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 06:04:16.596619) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-22 06:04:16.596973) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-22 06:04:16.598909) ========= ========= Total master_lag: 56.55 =========