builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-065 starttime: 1461407173.26 results: success (0) buildid: 20160423024847 builduid: 0b56103f51b843b3a3ea6e70d15b86ed revision: ad71189f79aa732acb0ad2518d33d46387386045 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-23 03:26:13.264442) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-23 03:26:13.264882) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-23 03:26:13.265161) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-23 03:26:13.285841) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 03:26:13.286138) ========= 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=523ca41ca1e0623de333ad52000001bf-1461406961.573527-667212725 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-23 03:26:14-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.7M=0s 2016-04-23 03:26:14 (46.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.086727 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 03:26:13.386101) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 03:26:13.386411) ========= 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=523ca41ca1e0623de333ad52000001bf-1461406961.573527-667212725 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018558 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 03:26:13.442901) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 03:26:13.443211) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev ad71189f79aa732acb0ad2518d33d46387386045 --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 ad71189f79aa732acb0ad2518d33d46387386045 --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=523ca41ca1e0623de333ad52000001bf-1461406961.573527-667212725 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-23 03:26:14,848 truncating revision to first 12 chars 2016-04-23 03:26:14,848 Setting DEBUG logging. 2016-04-23 03:26:14,848 attempt 1/10 2016-04-23 03:26:14,848 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/ad71189f79aa?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-23 03:26:15,117 unpacking tar archive at: fx-team-ad71189f79aa/testing/mozharness/ program finished with exit code 0 elapsedTime=0.558257 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 03:26:14.014448) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-23 03:26:14.014782) ========= script_repo_revision: ad71189f79aa732acb0ad2518d33d46387386045 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-23 03:26:14.015209) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-23 03:26:14.015502) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-23 03:26:14.121576) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-04-23 03:26:14.121951) ========= /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=523ca41ca1e0623de333ad52000001bf-1461406961.573527-667212725 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:26:15 INFO - MultiFileLogger online at 20160423 03:26:15 in /builds/slave/test 03:26:15 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 03:26:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:26:15 INFO - {'append_to_log': False, 03:26:15 INFO - 'base_work_dir': '/builds/slave/test', 03:26:15 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 03:26:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:26:15 INFO - 'branch': 'Fx-Team-Non-PGO', 03:26:15 INFO - 'buildbot_json_path': 'buildprops.json', 03:26:15 INFO - 'config_files': ('talos/linux_config.py',), 03:26:15 INFO - 'default_actions': ('clobber', 03:26:15 INFO - 'read-buildbot-config', 03:26:15 INFO - 'download-and-extract', 03:26:15 INFO - 'populate-webroot', 03:26:15 INFO - 'create-virtualenv', 03:26:15 INFO - 'install', 03:26:15 INFO - 'run-tests'), 03:26:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:26:15 INFO - 'download_minidump_stackwalk': True, 03:26:15 INFO - 'download_symbols': 'ondemand', 03:26:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:26:15 INFO - 'tooltool.py': '/tools/tooltool.py', 03:26:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:26:15 INFO - '/tools/misc-python/virtualenv.py')}, 03:26:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:26:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:26:15 INFO - 'installer_path': 'installer.exe', 03:26:15 INFO - 'log_level': 'info', 03:26:15 INFO - 'log_name': 'talos', 03:26:15 INFO - 'log_to_console': True, 03:26:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:26:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:26:15 INFO - 'opt_config_files': (), 03:26:15 INFO - 'pip_index': False, 03:26:15 INFO - 'sps_profile': False, 03:26:15 INFO - 'sps_profile_interval': 0, 03:26:15 INFO - 'suite': 'dromaeojs-e10s', 03:26:15 INFO - 'system_bits': '32', 03:26:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:26:15 INFO - 'title': 'talos-linux64-ix-065', 03:26:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:26:15 INFO - 'use_talos_json': True, 03:26:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:26:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:26:15 INFO - 'work_dir': 'build'} 03:26:15 INFO - ##### 03:26:15 INFO - ##### Running clobber step. 03:26:15 INFO - ##### 03:26:15 INFO - Running pre-action listener: _resource_record_pre_action 03:26:15 INFO - Running main action method: clobber 03:26:15 INFO - rmtree: /builds/slave/test/build 03:26:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:26:16 INFO - Running post-action listener: _resource_record_post_action 03:26:16 INFO - ##### 03:26:16 INFO - ##### Running read-buildbot-config step. 03:26:16 INFO - ##### 03:26:16 INFO - Running pre-action listener: _resource_record_pre_action 03:26:16 INFO - Running main action method: read_buildbot_config 03:26:16 INFO - Using buildbot properties: 03:26:16 INFO - { 03:26:16 INFO - "project": "", 03:26:16 INFO - "product": "firefox", 03:26:16 INFO - "script_repo_revision": "production", 03:26:16 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 03:26:16 INFO - "repository": "", 03:26:16 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 03:26:16 INFO - "buildid": "20160423024847", 03:26:16 INFO - "pgo_build": "False", 03:26:16 INFO - "basedir": "/builds/slave/test", 03:26:16 INFO - "buildnumber": 1433, 03:26:16 INFO - "slavename": "talos-linux64-ix-065", 03:26:16 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:26:16 INFO - "platform": "ubuntu64_hw", 03:26:16 INFO - "scheduler": "tests-fx-team-linux64-talos", 03:26:16 INFO - "branch": "fx-team", 03:26:16 INFO - "repo_path": "integration/fx-team", 03:26:16 INFO - "revision": "ad71189f79aa732acb0ad2518d33d46387386045", 03:26:16 INFO - "stage_platform": "linux64", 03:26:16 INFO - "builduid": "0b56103f51b843b3a3ea6e70d15b86ed", 03:26:16 INFO - "slavebuilddir": "test" 03:26:16 INFO - } 03:26:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/FvIk4Y5qTbu7jFUuU9ikjA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 03:26:16 INFO - Running post-action listener: _resource_record_post_action 03:26:16 INFO - ##### 03:26:16 INFO - ##### Running download-and-extract step. 03:26:16 INFO - ##### 03:26:16 INFO - Running pre-action listener: _resource_record_pre_action 03:26:16 INFO - Running main action method: download_and_extract 03:26:16 INFO - mkdir: /builds/slave/test/build/tests 03:26:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:16 INFO - https://queue.taskcluster.net/v1/task/FvIk4Y5qTbu7jFUuU9ikjA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:26:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FvIk4Y5qTbu7jFUuU9ikjA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 03:26:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FvIk4Y5qTbu7jFUuU9ikjA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 03:26:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FvIk4Y5qTbu7jFUuU9ikjA/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 03:26:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FvIk4Y5qTbu7jFUuU9ikjA/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 03:26:25 INFO - Downloaded 1361 bytes. 03:26:25 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 03:26:25 INFO - Using the following test package requirements: 03:26:25 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 03:26:25 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 03:26:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 03:26:25 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 03:26:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 03:26:25 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 03:26:25 INFO - u'jsshell-linux-x86_64.zip'], 03:26:25 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 03:26:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 03:26:25 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 03:26:25 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 03:26:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 03:26:25 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 03:26:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 03:26:25 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 03:26:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 03:26:25 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 03:26:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 03:26:25 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:26:25 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')]} 03:26:25 INFO - https://queue.taskcluster.net/v1/task/FvIk4Y5qTbu7jFUuU9ikjA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:26:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FvIk4Y5qTbu7jFUuU9ikjA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 03:26:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FvIk4Y5qTbu7jFUuU9ikjA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 03:26:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FvIk4Y5qTbu7jFUuU9ikjA/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 03:26:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FvIk4Y5qTbu7jFUuU9ikjA/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 03:26:33 INFO - Downloaded 22285608 bytes. 03:26:33 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'] 03:26:33 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 03:26:34 INFO - Return code: 0 03:26:34 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 03:26:34 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')]} 03:26:34 INFO - https://queue.taskcluster.net/v1/task/FvIk4Y5qTbu7jFUuU9ikjA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:26:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FvIk4Y5qTbu7jFUuU9ikjA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 03:26:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FvIk4Y5qTbu7jFUuU9ikjA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 03:26:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FvIk4Y5qTbu7jFUuU9ikjA/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 03:26:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FvIk4Y5qTbu7jFUuU9ikjA/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 03:26:36 INFO - Downloaded 22285608 bytes. 03:26:36 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'] 03:26:36 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 03:26:37 INFO - Return code: 0 03:26:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:37 INFO - https://queue.taskcluster.net/v1/task/FvIk4Y5qTbu7jFUuU9ikjA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:26:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FvIk4Y5qTbu7jFUuU9ikjA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 03:26:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FvIk4Y5qTbu7jFUuU9ikjA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 03:26:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FvIk4Y5qTbu7jFUuU9ikjA/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 03:26:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FvIk4Y5qTbu7jFUuU9ikjA/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 03:26:38 INFO - Downloaded 10840145 bytes. 03:26:38 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'] 03:26:38 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 03:26:39 INFO - Return code: 0 03:26:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:39 INFO - https://queue.taskcluster.net/v1/task/FvIk4Y5qTbu7jFUuU9ikjA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:26:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FvIk4Y5qTbu7jFUuU9ikjA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 03:26:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FvIk4Y5qTbu7jFUuU9ikjA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 03:26:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FvIk4Y5qTbu7jFUuU9ikjA/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 03:26:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FvIk4Y5qTbu7jFUuU9ikjA/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 03:26:40 INFO - Downloaded 54744954 bytes. 03:26:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FvIk4Y5qTbu7jFUuU9ikjA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 03:26:40 INFO - mkdir: /builds/slave/test/properties 03:26:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:26:40 INFO - Writing to file /builds/slave/test/properties/build_url 03:26:40 INFO - Contents: 03:26:40 INFO - build_url:https://queue.taskcluster.net/v1/task/FvIk4Y5qTbu7jFUuU9ikjA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 03:26:41 INFO - Running post-action listener: _resource_record_post_action 03:26:41 INFO - Running post-action listener: set_extra_try_arguments 03:26:41 INFO - ##### 03:26:41 INFO - ##### Running populate-webroot step. 03:26:41 INFO - ##### 03:26:41 INFO - Running pre-action listener: _resource_record_pre_action 03:26:41 INFO - Running main action method: populate_webroot 03:26:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:26:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:26:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:26:41 INFO - '--tppagecycles', 03:26:41 INFO - '7'], 03:26:41 INFO - 'tests': ['tsvgm']}}, 03:26:41 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:26:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:26:41 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:26:41 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:26:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:26:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:26:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:26:41 INFO - 'talos_options': ['--disable-e10s'], 03:26:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:26:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:26:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:26:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:26:41 INFO - 'talos_options': ['--disable-e10s'], 03:26:41 INFO - 'tests': ['damp', 'tps']}, 03:26:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:26:41 INFO - 'tests': ['damp', 'tps']}, 03:26:41 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:26:41 INFO - 'tests': ['dromaeo_dom']}, 03:26:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:26:41 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:26:41 INFO - 'tests': ['a11yr', 03:26:41 INFO - 'ts_paint', 03:26:41 INFO - 'tpaint', 03:26:41 INFO - 'sessionrestore', 03:26:41 INFO - 'sessionrestore_no_auto_restore', 03:26:41 INFO - 'tabpaint']}, 03:26:41 INFO - 'other-e10s': {'tests': ['a11yr', 03:26:41 INFO - 'ts_paint', 03:26:41 INFO - 'tpaint', 03:26:41 INFO - 'sessionrestore', 03:26:41 INFO - 'sessionrestore_no_auto_restore', 03:26:41 INFO - 'tabpaint']}, 03:26:41 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:26:41 INFO - 'ts_paint', 03:26:41 INFO - 'tpaint', 03:26:41 INFO - 'sessionrestore', 03:26:41 INFO - 'sessionrestore_no_auto_restore', 03:26:41 INFO - 'tabpaint']}, 03:26:41 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:26:41 INFO - 'ts_paint', 03:26:41 INFO - 'tpaint', 03:26:41 INFO - 'sessionrestore', 03:26:41 INFO - 'sessionrestore_no_auto_restore', 03:26:41 INFO - 'tabpaint']}, 03:26:41 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:26:41 INFO - 'tests': ['a11yr', 03:26:41 INFO - 'ts_paint', 03:26:41 INFO - 'tpaint', 03:26:41 INFO - 'sessionrestore', 03:26:41 INFO - 'sessionrestore_no_auto_restore', 03:26:41 INFO - 'tabpaint']}, 03:26:41 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:26:41 INFO - 'tests': ['a11yr', 03:26:41 INFO - 'ts_paint', 03:26:41 INFO - 'tpaint', 03:26:41 INFO - 'sessionrestore', 03:26:41 INFO - 'sessionrestore_no_auto_restore', 03:26:41 INFO - 'tabpaint']}, 03:26:41 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:26:41 INFO - 'tests': ['tsvgx', 03:26:41 INFO - 'tsvgr_opacity', 03:26:41 INFO - 'tart', 03:26:41 INFO - 'tscrollx', 03:26:41 INFO - 'cart']}, 03:26:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:26:41 INFO - 'tsvgr_opacity', 03:26:41 INFO - 'tart', 03:26:41 INFO - 'tscrollx', 03:26:41 INFO - 'cart']}, 03:26:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:26:41 INFO - 'talos_options': ['--disable-e10s'], 03:26:41 INFO - 'tests': ['tp5o']}, 03:26:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:26:41 INFO - 'tests': ['tp5o']}, 03:26:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:26:41 INFO - 'talos_options': ['--disable-e10s', 03:26:41 INFO - '--xperf_path', 03:26:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:26:41 INFO - 'tests': ['tp5n']}, 03:26:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:26:41 INFO - 'talos_options': ['--xperf_path', 03:26:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:26:41 INFO - 'tests': ['tp5n']}}, 03:26:41 INFO - 'talos.zip': {'path': '', 03:26:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:26:41 INFO - Running post-action listener: _resource_record_post_action 03:26:41 INFO - ##### 03:26:41 INFO - ##### Running create-virtualenv step. 03:26:41 INFO - ##### 03:26:41 INFO - Running pre-action listener: _resource_record_pre_action 03:26:41 INFO - Running main action method: create_virtualenv 03:26:41 INFO - Creating virtualenv /builds/slave/test/build/venv 03:26:41 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 03:26:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:26:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:26:41 INFO - Using real prefix '/usr' 03:26:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:26:42 INFO - Installing distribute.............................................................................................................................................................................................done. 03:26:44 INFO - Installing pip.................done. 03:26:44 INFO - Return code: 0 03:26:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:26:44 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')]} 03:26:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:44 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')]} 03:26:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:44 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 0x7f3cc5e3bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13515a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e0410>, '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 0x13e1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13e17a0>, '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': '523ca41ca1e0623de333ad52000001bf-1461406961.573527-667212725', '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 03:26:44 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 03:26:44 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 03:26:44 INFO - Using env: {'DISPLAY': ':0', 03:26:44 INFO - 'HOME': '/home/cltbld', 03:26:44 INFO - 'LANG': 'en_US.UTF-8', 03:26:44 INFO - 'LANGUAGE': 'en_US:en', 03:26:44 INFO - 'LOGNAME': 'cltbld', 03:26:44 INFO - 'MAIL': '/var/mail/cltbld', 03:26:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:44 INFO - 'MOZ_NO_REMOTE': '1', 03:26:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:44 INFO - 'NO_EM_RESTART': '1', 03:26:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:44 INFO - 'PWD': '/builds/slave/test', 03:26:44 INFO - 'SHELL': '/bin/bash', 03:26:44 INFO - 'SHLVL': '1', 03:26:44 INFO - 'TERM': 'linux', 03:26:44 INFO - 'TMOUT': '86400', 03:26:44 INFO - 'USER': 'cltbld', 03:26:44 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1461406961.573527-667212725', 03:26:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:44 INFO - '_': '/tools/buildbot/bin/python'} 03:26:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:44 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 03:26:44 INFO - Cleaning up... 03:26:44 INFO - Return code: 0 03:26:44 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:26:44 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')]} 03:26:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:44 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')]} 03:26:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:44 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 0x7f3cc5e3bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13515a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e0410>, '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 0x13e1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13e17a0>, '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': '523ca41ca1e0623de333ad52000001bf-1461406961.573527-667212725', '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 03:26:44 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 03:26:44 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 03:26:44 INFO - Using env: {'DISPLAY': ':0', 03:26:44 INFO - 'HOME': '/home/cltbld', 03:26:44 INFO - 'LANG': 'en_US.UTF-8', 03:26:44 INFO - 'LANGUAGE': 'en_US:en', 03:26:44 INFO - 'LOGNAME': 'cltbld', 03:26:44 INFO - 'MAIL': '/var/mail/cltbld', 03:26:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:44 INFO - 'MOZ_NO_REMOTE': '1', 03:26:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:44 INFO - 'NO_EM_RESTART': '1', 03:26:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:44 INFO - 'PWD': '/builds/slave/test', 03:26:44 INFO - 'SHELL': '/bin/bash', 03:26:44 INFO - 'SHLVL': '1', 03:26:44 INFO - 'TERM': 'linux', 03:26:44 INFO - 'TMOUT': '86400', 03:26:44 INFO - 'USER': 'cltbld', 03:26:44 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1461406961.573527-667212725', 03:26:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:44 INFO - '_': '/tools/buildbot/bin/python'} 03:26:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:44 INFO - Downloading/unpacking psutil>=0.7.1 03:26:44 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 03:26:44 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 03:26:44 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 03:26:44 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 03:26:44 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 03:26:44 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 03:26:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:26:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:26:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:26:46 INFO - Installing collected packages: psutil 03:26:46 INFO - Running setup.py install for psutil 03:26:46 INFO - building 'psutil._psutil_linux' extension 03:26:46 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 03:26:47 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 03:26:47 INFO - building 'psutil._psutil_posix' extension 03:26:47 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 03:26:47 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 03:26:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:26:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:26:47 INFO - Successfully installed psutil 03:26:47 INFO - Cleaning up... 03:26:47 INFO - Return code: 0 03:26:47 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:26: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')]} 03:26:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26: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')]} 03:26:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:47 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 0x7f3cc5e3bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13515a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e0410>, '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 0x13e1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13e17a0>, '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': '523ca41ca1e0623de333ad52000001bf-1461406961.573527-667212725', '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 03:26:47 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 03:26:47 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 03:26:47 INFO - Using env: {'DISPLAY': ':0', 03:26:47 INFO - 'HOME': '/home/cltbld', 03:26:47 INFO - 'LANG': 'en_US.UTF-8', 03:26:47 INFO - 'LANGUAGE': 'en_US:en', 03:26:47 INFO - 'LOGNAME': 'cltbld', 03:26:47 INFO - 'MAIL': '/var/mail/cltbld', 03:26:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:47 INFO - 'MOZ_NO_REMOTE': '1', 03:26:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:47 INFO - 'NO_EM_RESTART': '1', 03:26:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:47 INFO - 'PWD': '/builds/slave/test', 03:26:47 INFO - 'SHELL': '/bin/bash', 03:26:47 INFO - 'SHLVL': '1', 03:26:47 INFO - 'TERM': 'linux', 03:26:47 INFO - 'TMOUT': '86400', 03:26:47 INFO - 'USER': 'cltbld', 03:26:47 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1461406961.573527-667212725', 03:26:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:47 INFO - '_': '/tools/buildbot/bin/python'} 03:26:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:47 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:26:47 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 03:26:47 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 03:26:47 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 03:26:47 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 03:26:47 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 03:26:47 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 03:26:49 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:26:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:26:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:26:49 INFO - Installing collected packages: mozsystemmonitor 03:26:49 INFO - Running setup.py install for mozsystemmonitor 03:26:49 INFO - Successfully installed mozsystemmonitor 03:26:49 INFO - Cleaning up... 03:26:49 INFO - Return code: 0 03:26:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:26: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')]} 03:26:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26: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')]} 03:26:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:49 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 0x7f3cc5e3bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13515a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e0410>, '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 0x13e1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13e17a0>, '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': '523ca41ca1e0623de333ad52000001bf-1461406961.573527-667212725', '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 03:26:49 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 03:26:49 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 03:26:49 INFO - Using env: {'DISPLAY': ':0', 03:26:49 INFO - 'HOME': '/home/cltbld', 03:26:49 INFO - 'LANG': 'en_US.UTF-8', 03:26:49 INFO - 'LANGUAGE': 'en_US:en', 03:26:49 INFO - 'LOGNAME': 'cltbld', 03:26:49 INFO - 'MAIL': '/var/mail/cltbld', 03:26:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:49 INFO - 'MOZ_NO_REMOTE': '1', 03:26:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:49 INFO - 'NO_EM_RESTART': '1', 03:26:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:49 INFO - 'PWD': '/builds/slave/test', 03:26:49 INFO - 'SHELL': '/bin/bash', 03:26:49 INFO - 'SHLVL': '1', 03:26:49 INFO - 'TERM': 'linux', 03:26:49 INFO - 'TMOUT': '86400', 03:26:49 INFO - 'USER': 'cltbld', 03:26:49 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1461406961.573527-667212725', 03:26:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:49 INFO - '_': '/tools/buildbot/bin/python'} 03:26:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:49 INFO - Downloading/unpacking blobuploader==1.2.4 03:26:49 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 03:26:49 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 03:26:49 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 03:26:49 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 03:26:49 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 03:26:49 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 03:26:51 INFO - Downloading blobuploader-1.2.4.tar.gz 03:26:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:26:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:26:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:26:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:26:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:52 INFO - Downloading docopt-0.6.1.tar.gz 03:26:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:26:52 INFO - Installing collected packages: blobuploader, requests, docopt 03:26:52 INFO - Running setup.py install for blobuploader 03:26:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:26:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:26:52 INFO - Running setup.py install for requests 03:26:52 INFO - Running setup.py install for docopt 03:26:52 INFO - Successfully installed blobuploader requests docopt 03:26:52 INFO - Cleaning up... 03:26:53 INFO - Return code: 0 03:26:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:26: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')]} 03:26:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26: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')]} 03:26:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:53 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 0x7f3cc5e3bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13515a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e0410>, '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 0x13e1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13e17a0>, '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': '523ca41ca1e0623de333ad52000001bf-1461406961.573527-667212725', '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 03:26:53 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 03:26:53 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 03:26:53 INFO - Using env: {'DISPLAY': ':0', 03:26:53 INFO - 'HOME': '/home/cltbld', 03:26:53 INFO - 'LANG': 'en_US.UTF-8', 03:26:53 INFO - 'LANGUAGE': 'en_US:en', 03:26:53 INFO - 'LOGNAME': 'cltbld', 03:26:53 INFO - 'MAIL': '/var/mail/cltbld', 03:26:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:53 INFO - 'MOZ_NO_REMOTE': '1', 03:26:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:53 INFO - 'NO_EM_RESTART': '1', 03:26:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:53 INFO - 'PWD': '/builds/slave/test', 03:26:53 INFO - 'SHELL': '/bin/bash', 03:26:53 INFO - 'SHLVL': '1', 03:26:53 INFO - 'TERM': 'linux', 03:26:53 INFO - 'TMOUT': '86400', 03:26:53 INFO - 'USER': 'cltbld', 03:26:53 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1461406961.573527-667212725', 03:26:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:53 INFO - '_': '/tools/buildbot/bin/python'} 03:26:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:26:53 INFO - Running setup.py (path:/tmp/pip-ret03I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:26:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:26:53 INFO - Running setup.py (path:/tmp/pip-PLQab7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:26:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:26:53 INFO - Running setup.py (path:/tmp/pip-kM20iE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:26:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:26:53 INFO - Running setup.py (path:/tmp/pip-IKdzpM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:26:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:26:53 INFO - Running setup.py (path:/tmp/pip-d8o_20-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:26:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:26:53 INFO - Running setup.py (path:/tmp/pip-3aVgod-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:26:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:26:53 INFO - Running setup.py (path:/tmp/pip-3t_UxW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:26:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:26:53 INFO - Running setup.py (path:/tmp/pip-Z1JJso-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:26:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:26:53 INFO - Running setup.py (path:/tmp/pip-HNGZNY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:26:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:26:53 INFO - Running setup.py (path:/tmp/pip-eKzZc_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:26:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:26:53 INFO - Running setup.py (path:/tmp/pip-kAIFXJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:26:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:26:54 INFO - Running setup.py (path:/tmp/pip-4OFvN3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:26:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:26:54 INFO - Running setup.py (path:/tmp/pip-6KRYjp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:26:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:26:54 INFO - Running setup.py (path:/tmp/pip-5kG6z9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:26:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:26:54 INFO - Running setup.py (path:/tmp/pip-hAjVOX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:26:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:26:54 INFO - Running setup.py (path:/tmp/pip-R5QYHv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:26:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:26:54 INFO - Running setup.py (path:/tmp/pip-VUTY6t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:26:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:26:54 INFO - Running setup.py install for manifestparser 03:26:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:26:54 INFO - Running setup.py install for mozcrash 03:26:54 INFO - Running setup.py install for mozdebug 03:26:54 INFO - Running setup.py install for mozdevice 03:26:54 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:26:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:26:54 INFO - Running setup.py install for mozfile 03:26:54 INFO - Running setup.py install for mozhttpd 03:26:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:26:55 INFO - Running setup.py install for mozinfo 03:26:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:26:55 INFO - Running setup.py install for mozInstall 03:26:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:26:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:26:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:26:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:26:55 INFO - Running setup.py install for mozleak 03:26:55 INFO - Running setup.py install for mozlog 03:26:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:26:55 INFO - Running setup.py install for moznetwork 03:26:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:26:55 INFO - Running setup.py install for mozprocess 03:26:55 INFO - Running setup.py install for mozprofile 03:26:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:26:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:26:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:26:55 INFO - Running setup.py install for mozrunner 03:26:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:26:55 INFO - Running setup.py install for mozscreenshot 03:26:56 INFO - Running setup.py install for moztest 03:26:56 INFO - Running setup.py install for mozversion 03:26:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:26:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:26:56 INFO - Cleaning up... 03:26:56 INFO - Return code: 0 03:26:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:26:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:56 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 0x7f3cc5e3bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13515a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e0410>, '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 0x13e1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13e17a0>, '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': '523ca41ca1e0623de333ad52000001bf-1461406961.573527-667212725', '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 03:26:56 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 03:26:56 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 03:26:56 INFO - Using env: {'DISPLAY': ':0', 03:26:56 INFO - 'HOME': '/home/cltbld', 03:26:56 INFO - 'LANG': 'en_US.UTF-8', 03:26:56 INFO - 'LANGUAGE': 'en_US:en', 03:26:56 INFO - 'LOGNAME': 'cltbld', 03:26:56 INFO - 'MAIL': '/var/mail/cltbld', 03:26:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:56 INFO - 'MOZ_NO_REMOTE': '1', 03:26:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:56 INFO - 'NO_EM_RESTART': '1', 03:26:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:56 INFO - 'PWD': '/builds/slave/test', 03:26:56 INFO - 'SHELL': '/bin/bash', 03:26:56 INFO - 'SHLVL': '1', 03:26:56 INFO - 'TERM': 'linux', 03:26:56 INFO - 'TMOUT': '86400', 03:26:56 INFO - 'USER': 'cltbld', 03:26:56 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1461406961.573527-667212725', 03:26:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:56 INFO - '_': '/tools/buildbot/bin/python'} 03:26:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:26:56 INFO - Running setup.py (path:/tmp/pip-8Ps9Ke-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:26:56 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)) 03:26:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:26:56 INFO - Running setup.py (path:/tmp/pip-IUKuDO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:26:56 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)) 03:26:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:26:56 INFO - Running setup.py (path:/tmp/pip-P_v5HV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:26:56 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)) 03:26:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:26:56 INFO - Running setup.py (path:/tmp/pip-ozxFpL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:26:56 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)) 03:26:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:26:56 INFO - Running setup.py (path:/tmp/pip-T20L6K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:26:56 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)) 03:26:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:26:56 INFO - Running setup.py (path:/tmp/pip-cnR8qQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:26:56 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)) 03:26:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:26:56 INFO - Running setup.py (path:/tmp/pip-UMGcfr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:26:56 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)) 03:26:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:26:56 INFO - Running setup.py (path:/tmp/pip-eYuExJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:26:57 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)) 03:26:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:26:57 INFO - Running setup.py (path:/tmp/pip-Jw5e3d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:26:57 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)) 03:26:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:26:57 INFO - Running setup.py (path:/tmp/pip-z3teaD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:26:57 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)) 03:26:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:26:57 INFO - Running setup.py (path:/tmp/pip-YhOUiL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:26:57 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)) 03:26:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:26:57 INFO - Running setup.py (path:/tmp/pip-yZg9aS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:26:57 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)) 03:26:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:26:57 INFO - Running setup.py (path:/tmp/pip-zXOOJL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:26:57 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)) 03:26:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:26:57 INFO - Running setup.py (path:/tmp/pip-VHja2W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:26:57 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)) 03:26:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:26:57 INFO - Running setup.py (path:/tmp/pip-ocAQLp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:26:57 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)) 03:26:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:26:57 INFO - Running setup.py (path:/tmp/pip-oAwogw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:26:57 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)) 03:26:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:26:57 INFO - Running setup.py (path:/tmp/pip-DYWY_v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:26:57 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)) 03:26:57 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)) 03:26:57 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)) 03:26:57 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)) 03:26:57 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)) 03:26:57 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)) 03:26:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:26:57 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 03:26:57 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 03:26:57 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 03:26:57 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 03:26:57 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 03:26:57 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 03:26:59 INFO - Downloading blessings-1.6.tar.gz 03:26:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:26:59 INFO - Installing collected packages: blessings 03:26:59 INFO - Running setup.py install for blessings 03:26:59 INFO - Successfully installed blessings 03:26:59 INFO - Cleaning up... 03:26:59 INFO - Return code: 0 03:26:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:26:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:26:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:27:00 INFO - Reading from file tmpfile_stdout 03:27:00 INFO - Current package versions: 03:27:00 INFO - argparse == 1.2.1 03:27:00 INFO - blessings == 1.6 03:27:00 INFO - blobuploader == 1.2.4 03:27:00 INFO - docopt == 0.6.1 03:27:00 INFO - manifestparser == 1.1 03:27:00 INFO - mozInstall == 1.12 03:27:00 INFO - mozcrash == 0.17 03:27:00 INFO - mozdebug == 0.1 03:27:00 INFO - mozdevice == 0.48 03:27:00 INFO - mozfile == 1.2 03:27:00 INFO - mozhttpd == 0.7 03:27:00 INFO - mozinfo == 0.9 03:27:00 INFO - mozleak == 0.1 03:27:00 INFO - mozlog == 3.1 03:27:00 INFO - moznetwork == 0.27 03:27:00 INFO - mozprocess == 0.22 03:27:00 INFO - mozprofile == 0.28 03:27:00 INFO - mozrunner == 6.11 03:27:00 INFO - mozscreenshot == 0.1 03:27:00 INFO - mozsystemmonitor == 0.0 03:27:00 INFO - moztest == 0.7 03:27:00 INFO - mozversion == 1.4 03:27:00 INFO - psutil == 3.1.1 03:27:00 INFO - requests == 1.2.3 03:27:00 INFO - wsgiref == 0.1.2 03:27:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:27:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:27:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:27:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:27:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:27:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27:00 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 0x7f3cc5e3bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13515a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e0410>, '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 0x13e1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13e17a0>, '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': '523ca41ca1e0623de333ad52000001bf-1461406961.573527-667212725', '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 03:27:00 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 03:27:00 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 03:27:00 INFO - Using env: {'DISPLAY': ':0', 03:27:00 INFO - 'HOME': '/home/cltbld', 03:27:00 INFO - 'LANG': 'en_US.UTF-8', 03:27:00 INFO - 'LANGUAGE': 'en_US:en', 03:27:00 INFO - 'LOGNAME': 'cltbld', 03:27:00 INFO - 'MAIL': '/var/mail/cltbld', 03:27:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:27:00 INFO - 'MOZ_NO_REMOTE': '1', 03:27:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:27:00 INFO - 'NO_EM_RESTART': '1', 03:27:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:27:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:27:00 INFO - 'PWD': '/builds/slave/test', 03:27:00 INFO - 'SHELL': '/bin/bash', 03:27:00 INFO - 'SHLVL': '1', 03:27:00 INFO - 'TERM': 'linux', 03:27:00 INFO - 'TMOUT': '86400', 03:27:00 INFO - 'USER': 'cltbld', 03:27:00 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1461406961.573527-667212725', 03:27:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:27:00 INFO - '_': '/tools/buildbot/bin/python'} 03:27:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:27:00 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)) 03:27:00 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)) 03:27:00 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)) 03:27:00 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)) 03:27:00 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)) 03:27:00 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)) 03:27:00 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)) 03:27:00 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)) 03:27:00 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)) 03:27:00 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)) 03:27:00 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)) 03:27:00 INFO - Cleaning up... 03:27:00 INFO - Return code: 0 03:27:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:27:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:27:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:27:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:27:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:27:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3cc5e3bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13515a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e0410>, '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 0x13e1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13e17a0>, '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': '523ca41ca1e0623de333ad52000001bf-1461406961.573527-667212725', '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 03:27:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:27:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:27:00 INFO - Using env: {'DISPLAY': ':0', 03:27:00 INFO - 'HOME': '/home/cltbld', 03:27:00 INFO - 'LANG': 'en_US.UTF-8', 03:27:00 INFO - 'LANGUAGE': 'en_US:en', 03:27:00 INFO - 'LOGNAME': 'cltbld', 03:27:00 INFO - 'MAIL': '/var/mail/cltbld', 03:27:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:27:00 INFO - 'MOZ_NO_REMOTE': '1', 03:27:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:27:00 INFO - 'NO_EM_RESTART': '1', 03:27:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:27:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:27:00 INFO - 'PWD': '/builds/slave/test', 03:27:00 INFO - 'SHELL': '/bin/bash', 03:27:00 INFO - 'SHLVL': '1', 03:27:00 INFO - 'TERM': 'linux', 03:27:00 INFO - 'TMOUT': '86400', 03:27:00 INFO - 'USER': 'cltbld', 03:27:00 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1461406961.573527-667212725', 03:27:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:27:00 INFO - '_': '/tools/buildbot/bin/python'} 03:27:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:27:00 INFO - Downloading/unpacking jsonschema 03:27:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:27:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:27:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:27:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:27:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:27:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:27:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:27:02 INFO - Downloading/unpacking functools32 (from jsonschema) 03:27:02 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 03:27:02 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 03:27:02 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 03:27:02 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 03:27:02 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 03:27:02 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 03:27:02 INFO - Downloading functools32-3.2.3-2.tar.gz 03:27:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:27:02 INFO - warning: no files found matching '*.txt' 03:27:02 INFO - no previously-included directories found matching 'build' 03:27:02 INFO - no previously-included directories found matching 'dist' 03:27:02 INFO - no previously-included directories found matching '.git*' 03:27:02 INFO - Installing collected packages: jsonschema, functools32 03:27:02 INFO - Running setup.py install for functools32 03:27:02 INFO - warning: no files found matching '*.txt' 03:27:02 INFO - no previously-included directories found matching 'build' 03:27:02 INFO - no previously-included directories found matching 'dist' 03:27:02 INFO - no previously-included directories found matching '.git*' 03:27:02 INFO - Successfully installed jsonschema functools32 03:27:02 INFO - Cleaning up... 03:27:02 INFO - Return code: 0 03:27:02 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:27:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:27:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:27:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:27:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:27:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27:02 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 0x7f3cc5e3bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13515a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e0410>, '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 0x13e1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13e17a0>, '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': '523ca41ca1e0623de333ad52000001bf-1461406961.573527-667212725', '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 03:27:02 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 03:27:02 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 03:27:02 INFO - Using env: {'DISPLAY': ':0', 03:27:02 INFO - 'HOME': '/home/cltbld', 03:27:02 INFO - 'LANG': 'en_US.UTF-8', 03:27:02 INFO - 'LANGUAGE': 'en_US:en', 03:27:02 INFO - 'LOGNAME': 'cltbld', 03:27:02 INFO - 'MAIL': '/var/mail/cltbld', 03:27:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:27:02 INFO - 'MOZ_NO_REMOTE': '1', 03:27:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:27:02 INFO - 'NO_EM_RESTART': '1', 03:27:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:27:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:27:02 INFO - 'PWD': '/builds/slave/test', 03:27:02 INFO - 'SHELL': '/bin/bash', 03:27:02 INFO - 'SHLVL': '1', 03:27:02 INFO - 'TERM': 'linux', 03:27:02 INFO - 'TMOUT': '86400', 03:27:02 INFO - 'USER': 'cltbld', 03:27:02 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1461406961.573527-667212725', 03:27:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:27:02 INFO - '_': '/tools/buildbot/bin/python'} 03:27:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:27:03 INFO - Downloading/unpacking flake8 03:27:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:27:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:27:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:27:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:27:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:27:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:27:04 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:27:04 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:27: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 03:27: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 03:27: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 03:27: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 03:27: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 03:27: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 03:27:05 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:27:05 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:27:05 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 03:27:05 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 03:27:05 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 03:27:05 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 03:27:05 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 03:27:05 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 03:27:05 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:27:05 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 03:27:05 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 03:27:05 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 03:27:05 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 03:27:05 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 03:27:05 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 03:27:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:27:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:27:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:27:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:27:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:27:05 INFO - no previously-included directories found matching 'docs/_build' 03:27:05 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:27:05 INFO - Running setup.py install for pep8 03:27:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:27:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:27:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:27:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:27:05 INFO - no previously-included directories found matching 'docs/_build' 03:27:05 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:27:05 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:27:05 INFO - Cleaning up... 03:27:05 INFO - Return code: 0 03:27:05 INFO - Running post-action listener: _resource_record_post_action 03:27:05 INFO - Running post-action listener: _start_resource_monitoring 03:27:05 INFO - Starting resource monitoring. 03:27:05 INFO - ##### 03:27:05 INFO - ##### Running install step. 03:27:05 INFO - ##### 03:27:05 INFO - Running pre-action listener: _resource_record_pre_action 03:27:05 INFO - Running main action method: install 03:27:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:27:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:27:06 INFO - Reading from file tmpfile_stdout 03:27:06 INFO - Detecting whether we're running mozinstall >=1.0... 03:27:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:27:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:27:06 INFO - Reading from file tmpfile_stdout 03:27:06 INFO - Output received: 03:27:06 INFO - Usage: mozinstall [options] installer 03:27:06 INFO - Options: 03:27:06 INFO - -h, --help show this help message and exit 03:27:06 INFO - -d DEST, --destination=DEST 03:27:06 INFO - Directory to install application into. [default: 03:27:06 INFO - "/builds/slave/test"] 03:27:06 INFO - --app=APP Application being installed. [default: firefox] 03:27:06 INFO - mkdir: /builds/slave/test/build/application 03:27:06 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'] 03:27:06 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 03:27:21 INFO - Reading from file tmpfile_stdout 03:27:21 INFO - Output received: 03:27:21 INFO - /builds/slave/test/build/application/firefox/firefox 03:27:21 INFO - Running post-action listener: _resource_record_post_action 03:27:21 INFO - ##### 03:27:21 INFO - ##### Running run-tests step. 03:27:21 INFO - ##### 03:27:21 INFO - Running pre-action listener: _resource_record_pre_action 03:27:21 INFO - Running main action method: run_tests 03:27:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:27:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:27:21 INFO - Python 2.7.3 03:27:21 INFO - Return code: 0 03:27:21 INFO - grabbing minidump binary from tooltool 03:27:21 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')]} 03:27:21 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 0x13e0410>, '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 0x13e1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13e17a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:27:21 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 03:27:21 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 03:27:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:27:21 INFO - Return code: 0 03:27:21 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:27:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:27:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:27:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:27:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:27:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:27:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:27:22 INFO - Return code: 0 03:27:22 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/FvIk4Y5qTbu7jFUuU9ikjA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--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 03:27:22 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/FvIk4Y5qTbu7jFUuU9ikjA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-065 --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 03:27:22 INFO - Using env: {'DISPLAY': ':0', 03:27:22 INFO - 'HOME': '/home/cltbld', 03:27:22 INFO - 'LANG': 'en_US.UTF-8', 03:27:22 INFO - 'LANGUAGE': 'en_US:en', 03:27:22 INFO - 'LOGNAME': 'cltbld', 03:27:22 INFO - 'MAIL': '/var/mail/cltbld', 03:27:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:27:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:27:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:27:22 INFO - 'MOZ_NO_REMOTE': '1', 03:27:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:27:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:27:22 INFO - 'NO_EM_RESTART': '1', 03:27:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:27:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:27:22 INFO - 'PWD': '/builds/slave/test', 03:27:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:27:22 INFO - 'SHELL': '/bin/bash', 03:27:22 INFO - 'SHLVL': '1', 03:27:22 INFO - 'TERM': 'linux', 03:27:22 INFO - 'TMOUT': '86400', 03:27:22 INFO - 'USER': 'cltbld', 03:27:22 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1461406961.573527-667212725', 03:27:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:27:22 INFO - '_': '/tools/buildbot/bin/python'} 03:27:22 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/FvIk4Y5qTbu7jFUuU9ikjA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--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 03:27:23 INFO - mozversion application_buildid: 20160423024847 03:27:23 INFO - mozversion application_changeset: ad71189f79aa732acb0ad2518d33d46387386045 03:27:23 INFO - mozversion application_display_name: Nightly 03:27:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:27:23 INFO - mozversion application_name: Firefox 03:27:23 INFO - mozversion application_remotingname: firefox 03:27:23 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 03:27:23 INFO - mozversion application_vendor: Mozilla 03:27:23 INFO - mozversion application_version: 48.0a1 03:27:23 INFO - mozversion platform_buildid: 20160423024847 03:27:23 INFO - mozversion platform_changeset: ad71189f79aa732acb0ad2518d33d46387386045 03:27:23 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 03:27:23 INFO - mozversion platform_version: 48.0a1 03:27:23 INFO - using testdate: 1461407243 03:27:23 INFO - actual date: 1461407243 03:27:23 INFO - starting webserver on 'localhost:56609' 03:27:23 INFO - SUITE-START | Running 2 tests 03:27:23 INFO - TEST-START | dromaeo_css 03:27:23 INFO - operating with platform_type : linux_ 03:27:23 INFO - Initialising browser for dromaeo_css test... 03:27:23 INFO - TEST-INFO | started process 26147 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcaNvtG/profile http://localhost:56609/getInfo.html) 03:27:26 INFO - PROCESS | 26147 | 03:27:26 INFO - PROCESS | 26147 | (process:26214): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:27:27 INFO - PROCESS | 26147 | __metrics Screen width/height:1600/1200 03:27:27 INFO - PROCESS | 26147 | colorDepth:24 03:27:27 INFO - PROCESS | 26147 | Browser inner width/height: 1024/697 03:27:27 INFO - PROCESS | 26147 | __metrics 03:27:28 ERROR - PROCESS | 26147 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 03:27:29 INFO - TEST-INFO | 26147: exit 0 03:27:29 INFO - Browser initialized. 03:27:29 INFO - Running cycle 1/1 for dromaeo_css test... 03:27:29 INFO - TEST-INFO | started process 26265 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcaNvtG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:27:31 INFO - PROCESS | 26265 | 03:27:31 INFO - PROCESS | 26265 | (process:26326): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:27:41 INFO - PROCESS | 26265 | RSS: Main: 165896192 03:27:41 INFO - PROCESS | 26265 | 03:28:30 INFO - PROCESS | 26265 | 1461407310791 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] 03:30:42 INFO - PROCESS | 26265 | Cycle 1(1): loaded http://localhost:56609/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56609/tests/dromaeo/cssquery-ext.html) 03:30:43 INFO - PROCESS | 26265 | RSS: Main: 169906176 03:30:43 INFO - PROCESS | 26265 | 03:33:45 INFO - PROCESS | 26265 | Cycle 1(1): loaded http://localhost:56609/tests/dromaeo/cssquery-ext.html (next: http://localhost:56609/tests/dromaeo/cssquery-jquery.html) 03:33:46 INFO - PROCESS | 26265 | RSS: Main: 166256640 03:33:46 INFO - PROCESS | 26265 | 03:36:48 INFO - PROCESS | 26265 | Cycle 1(1): loaded http://localhost:56609/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56609/tests/dromaeo/cssquery-mootools.html) 03:36:48 INFO - PROCESS | 26265 | RSS: Main: 167419904 03:36:48 INFO - PROCESS | 26265 | 03:39:50 INFO - PROCESS | 26265 | Cycle 1(1): loaded http://localhost:56609/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56609/tests/dromaeo/cssquery-prototype.html) 03:39:51 INFO - PROCESS | 26265 | RSS: Main: 165105664 03:39:51 INFO - PROCESS | 26265 | 03:42:54 INFO - PROCESS | 26265 | Cycle 1(1): loaded http://localhost:56609/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56609/tests/dromaeo/cssquery-yui.html) 03:42:54 INFO - PROCESS | 26265 | RSS: Main: 166387712 03:42:54 INFO - PROCESS | 26265 | 03:45:57 INFO - PROCESS | 26265 | Cycle 1(1): loaded http://localhost:56609/tests/dromaeo/cssquery-yui.html (next: http://localhost:56609/tests/dromaeo/cssquery-dojo.html) 03:45:57 INFO - PROCESS | 26265 | RSS: Main: 169164800 03:45:57 INFO - PROCESS | 26265 | 03:45:57 INFO - PROCESS | 26265 | __start_tp_report 03:45:57 INFO - PROCESS | 26265 | _x_x_mozilla_page_load 03:45:57 INFO - PROCESS | 26265 | _x_x_mozilla_page_load_details 03:45:57 INFO - PROCESS | 26265 | |i|pagename|runs| 03:45:57 INFO - PROCESS | 26265 | |0;dojo.html;2609.9869500652494;2693.5555633320505;2727.672679278487;2736.575830746235;2743.149623616679;4774.140654682155;4791.281307803831;4807.495213002637;4823.807047718092;4858.392700912386;4705.482396936334;4739.786709598067;4805.975970120145;4842.12841688496;4895.5838753705975;4370.366296886949;4407.427034485529;4447.5552444755585;4467.687261891669;4503.707259028152;631.4501375697515;4032.5967403259588;4341.587549182823;4398.450193725785;4399.05420334628;4374.081442896995;4385.583369579885;4403.669724770655;4417.845375411845;4446.9994251293365;4388.7147335423415;4389.429374181336;4393.956060439386;4416.3596278539435;4436.7116137451285;4302.526722060571;4369.366441865912;4371.344298355272;4371.759553224571;4408.030233348658;4691.581223686648;4740.644451666104;4741.5732584067255;4762.714237145782;4762.809487620491;5049.267856160836;5109.795608175668;5195.506426889439;5196.818111366122;5239.973800131013;5195.220716892459;5200.401953775288;5218.086834803932;5247.895042099137;5263.6841789492755;4849.369581954394;4857.222844344923;4859.246816743411;4867.634927380461;4909.0672772173175;5225.686458812407;5315.282436870973;5326.866828329245;5338.839834804962;5367.973160134253;5138.409082955433;5141.76862041209;5153.819616313411;5158.329417175743;5175.120229560984;5241.240020197126;5251.894962100813;5256.6320357574605;5260.815871444558;5295.443978382292;4958.404991401055;5031.119554078022;5190.870228244324;5192.376914770176;5211.869703257373;4977.502249774993;4988.6009119270375;4991.950080499221;5025.874353141201;5039.748012599355;4332.090261045216;4336.479622445327;4339.153864996296;4367.650587952956;4386.539413361615;3691.7231207658997;3749.1564398010773;3824.158685089276;3879.9418008729326;3929.233799409145;4377.146456441027;4399.560043995639;4426.336049592587;4437.5784300491405;4457.487388950312;5187.844364669066;5197.558207552324;5198.662086964335;5207.2449494823795;5227.424983251839;4298.484181898192;4368.584984426474;4443.400140980991;4444.200043992112;4470.798814053375;4603.9079218415445;4624.722516649012;4625.583697467244;4635.559621835921;4666.346711460398;4808.230683090689;4819.734914579732;4833.830815921426;4835.032993401333;4858.05267972742;5072.1123803335;5094.898102037864;5127.6410651254055;5128.769095416998;5152.149895267239;4783;4808.663393562417;4814.855554333376;4817.325574419654;4860.489648586848;5029.798808047637;5037.571806396498;5064.721440320818;5086.389633243886;5113.181890897587;5139.177731562932;5183.844484665316;5208.8437346879655;5235.397929238186;5262.710550919736;5013.573846223112;5024.472430394756;5026.874328141679;5037.319961805109;5050.444451110301;4955.876103097451;5029.119904016856;5034.0686972910125;5042.168042272984;5062.797488100435;4931.3589233399425;4988.401391833003;5011.574016208663;5030.773615187399;5039.974800125976;5126.384833819965;5184.144616138295;5185.870353241048;5202.453742356998;5237.476252374732;4850.078485087822;4907.77914993819;4944.085344211332;5046.899062018812;5069.5944324454695 03:45:57 INFO - PROCESS | 26265 | |1;ext.html;560.4479587606207;600.8888355654204;613.0803794308537;625.6152466233265;632.9905051424226;34857.47713784292;35954.64045359546;36194.276114477696;36237;36275.63724362752;35701;36046.09884752876;36112.097197570074;36236;36271.2745745085;7702.73040443586;7837.6864925402915;7860.489068210577;7871.370290376756;7896.249856263646;7745;7811.843763124734;7820.648070836797;7878.330341920943;7879.054513458393;7819.491733037363;7837.4121940854375;7886.132525422199;7888.013998250219;7889.053313602376;7830.373570114406;7856;7868.527888326718;7874.763757087297;7876.291133797957;7761.068671759425;7845.137034926153;7846.019247594051;7855.96072019642;7863.410244231705;29564.556531652044;36326.818365908;36814.631853681654;36878.078048049014;36952.81523592392;3074.123874695701;3107.922301942447;3170.2074481379655;3609.7112231021456;3813.523309586302;23964.400889977715;24102.27693169208;24243.272701818973;24436.755632443805;25286.49427011468;3275.5452584485083;3296.225387034045;3312.4865645824934;3317.4692049272003;3357.832108394595;189630;191020;191459;192592;193674.03162984236;31482.842585786926;31913.202169945936;32019.51970720441;32071.51892721611;32657.83671081677;32065;32165.35669286601;32233.838830805696;32294.19264518406;32307.838460807547;10429.739256518647;10477;10503.789924201474;10530.36817790935;10538.20963427746;9419.058094190526;9421.670241541513;9456.243500519942;9491.240700743923;9524.8571271431;7952.761417157494;8201.466904651179;8226.383021273428;8252.752417427488;8303.4602750821;3216.8391580420885;3223.693749093832;3267.36286424145;3282.3927573398996;3285.1130194847256;920.6547544670749;943.9952800235955;1012.6708819633649;1051.222095649214;1083.106437189322;27348.316292092855;29034.854825726157;29142.854285728437;29308.26729331741;29400.558991615144;954.1222075690381;982;996.9830772611896;1032.9741756455999;1050.968470945873;14648.487302944346;15241;15301.846981530041;15495.612609684622;15754.9212253938;375572;379202;381301;381361;383258.08370958525;49501.504984949686;51245.231321530206;51302.230466543035;51358.22962655563;51510.74244628753;1202.0744027099086;1256.9371531423576;1263.3051821498138;1268.4165283969478;1271.0721173543366;27451.725482745715;28114.578281325386;28185.71814281831;28210.15369538917;28946;43189.568104318554;43240.78379608082;43622.781886090364;43717;43795.12409751851;313627;315906;320414;320972;322300;25192.74807251904;25654.486910262065;25702.742972570784;25704;25753.356166095997;42189.367159493246;43031;43353.3496997539;43716.56283437125;44252.11495770131;37083.44374834433;37270;37398.439023415216;37745.24509509849;37811.81094094512;36304.27391452209;36741.26517469582;36819.81590092032;37259.44110838285;37381.25237495289;36347.63652363443;36503.26993460063;36748.44877326789;36973.26053478861;37072.25855482929;32111.839440802647;33697.663023370435;33776.15559611029;33818.830905845316;34125;25428.872855635604;25671.486570268862;25745.356366090247;25824.612630810927;26006.219813405627 03:45:57 INFO - PROCESS | 26265 | |2;jquery.html;380.08210172433576;389.92981263372593;390.3734506117681;395.7645201105343;403.53794904833984;15141.883314842034;16904.40834570787;17701.557461063465;17761.111944402794;17814.910925445387;10455.163586913048;15700.21498925052;15917.602059948507;15978.121203333812;16042.35830566776;4589.24277494213;4731.716097034189;4766.428028636568;4770.928436073462;4772.856814295559;3511.859525618985;5234.214867769827;5521.696306703129;5532.087205611069;5536.916946245809;5420.6747595144225;5511.22842802008;5530.419305972875;5538.806141785039;5539.446055394448;5487.122060470326;5567.415421380758;5568.66588004717;5574.219609254707;5585.748641311151;5137.460566640486;5312.4687531246955;5366.570674346082;5366.865828354284;5374.973125134388;19144.329948451737;19899;20098.39704808858;20104.09531571068;20126.39620811378;1888.5845114075019;1955.3418137378692;2011.1452632631074;2011.3161525081543;2039.1027947702962;8778.956105219497;8920.420172688755;9200.631974721004;9300.418928782055;9350.205232555241;1789.8478629316523;1802.737747171477;1812.5378028602754;1853.6107417442354;1863.3664554051688;63615;65037;65500.672496637686;66193.66903165453;66758.33241667619;9860.950695246478;9989.80020399588;10158.288919775692;10319.122874555747;10343.9482802587;14220.146791192561;14265.358058887376;14385.928070359581;14392.20842853653;14407.63980900465;6900.7929762107215;6933.5493192942295;6945.166580010431;7036.713068252839;7117.857642847114;6313.053042043638;6352.396522330371;6432.71052802625;6507.837304067436;6512.088307636935;4363.716358436755;4465.933011004838;4470.150671372494;4512.458504979423;4556.248219043887;1731.6277000444713;1811.9615432638282;1813.3834496271331;1879.2389082421369;1900.7338972543855;833.0503226321998;849.8257857139272;885.274075258282;920.1764420843308;975.1029053271008;15296.158711270988;16035.358585656677;16073.115978621288;16254.51236462908;16439.26023328953;801.579170935252;815.1888870573698;852.4927668037508;856.2293935458138;931.902150274225;6955.721771129098;9093.681721139728;9161.725148245563;9197;9358.22193783179;367332;382639;384097;385759;388637;75250;77834;78034;78421;80170.59914700506;951.191487235844;955.1165172215673;962.5187406296851;967.4002118686459;969.2633598465217;14651.413943442143;14674.192919389536;14703.191324477257;14787.334569944593;15080;33139.337213255116;33610;34840.82579587086;34999.475007875415;35248.295034098664;42991.355129673706;44755.552444475135;47678.28482572695;49228.753856231924;49484;7492.925070749223;7544.245575442412;7709.0749110107145;7738.92261077382;7834;10751.408672523086;10805.405702686428;10814.729631759268;11286.66140015801;11388.886111138783;9400.623975041195;9523.23814094857;9853.802923941625;9977.10206081456;10224.795504090025;9723.416595004039;9791.265655075755;9839.655612053544;9869.654562090293;9922.40465572068;9733.58862964852;9880.160186384237;10214.336068155546;10309.07218350352;10374.844377334497;7172.39034682037;7446.70213191488;7824.413169012233;7871.724489642835;7885.723999659985;9261.305402094735;9661.71014869555;9972.551235194578;10177.338472999232;10308.896911030793 03:45:57 INFO - PROCESS | 26265 | |3;mootools.html;1430.8426073131957;1485.7994170786944;1589.507252751647;1714.202895653521;1761.9295228190872;7011.719531218745;7656.617169141548;7703.460757746953;7969.242921922408;7969.442139050268;7707.807304817382;7732.110807257167;7778.299953004229;7804.29761321481;7818.374530037598;2206.2498750424893;2231.877246751428;2232;2232.430730163806;2238.272561417538;2188.9452763680874;2205.6250437425674;2213.3691897809126;2219.533897881447;2221.766714494979;2138.347803919804;2145.141943222716;2145.3778404262744;2158.7301587301586;2190.080166330137;2133.5626196629655;2149.118861266889;2150.4516348331153;2152.35429371188;2153.2356013615176;2130.20117455954;2201.9229326973477;2202.1521714140013;2206.360155554887;2207.845450818443;7893.921060789376;7951.284384405373;7969.362451003905;7970.043594768606;7974.481658692166;4602.125596136723;4717;4723.36234608327;4724.338592597039;4742.264948932886;3050.527168288919;3106.456370135217;3142.6543080261154;3173.0639461358955;3213.678632136791;939.9436033837924;946.7017889364897;957.8563215517659;962.8603852441357;975.1808480876098;10939.56241750329;10963.068139208177;10986.395748233765;10997.285176463503;10998.175136864767;4170.624643782075;4201.474815648044;4342.0664557119735;4350.695451318377;4448.065906159743;9278.396904201205;9283.90716092844;9287.303452241109;9314.48770317639;9339.159475647088;4726.95273047272;4743.739094349844;4759.119562880878;4764.2615394613895;4767.785449654774;3841.8079096045085;4225.049363893099;4263.126059157865;4288.399624052635;4308.418363520947;3693.6675699187203;3732.9440058399146;3819.102510909934;3823.1397935464297;3845.0771814764257;1230.870758570355;1239.8388209532702;1260.0423678004781;1262.236347010064;1273.2360583649922;792.904851417822;837.4723923928008;838.0446291228005;850.8085680721788;857.3569822633025;5436.347638283352;5567.164925261243;5622.325320961429;5630.465105814941;5693.658380497183;874.9387542872065;891.9821603567892;898.6180873128894;953.1136043479491;953.9189168920719;3675.7059435245114;3683.7605555638797;3698.815059247027;3703.7407381483577;3952;9346.11211934865;9587.808243835085;9662.275329350327;9679.128878400978;9788.265880059023;9614.71155865325;9765.804683906283;9805.264605154642;9843.803123937625;9877.654282100091;7306.415486761046;7493.737719179911;7507.361874240642;7550.207228241065;7559.659815308324;5411.78352865881;5448.782048718007;5495.505404513613;5562.7774889005605;5627.493525582717;8842.778930526789;8855.3801233913;8902.554872256233;8948.955255223942;8962.641494340154;8133.633986470505;8544.273736732448;8588.05531391534;8893.021767605687;8920.643174272956;6779.2542820288745;7285.635718214174;7355.080614923135;7523.699052037857;7560.621968901423;7446.478746487694;7558.622068896643;7581;7585.279398457358;7612.238776122344;6624.768133115318;6828.897566536407;6858.074159988338;6975.023496710363;6994.160700715946;6499.122618446449;6665.333466653296;6678.532502724957;6722.294159113223;6936.930630693831;6577.112089867998;6643.40209381158;6713.1944166700305;6722.19333679942;6757.594544327356;4712.7643617818285;4717.740524271198;4794.856154315376;4820.276958456259;4849.2726091086615;4760.404949381327;4839.467658557626;4943.209086546135;4984.700917944935;4994 03:45:57 INFO - PROCESS | 26265 | |4;prototype.html;310.59312300885836;318.0680605824932;320.77064898597513;323.40816306159735;326.22033340316665;5428.864278393037;5507.614466987303;5514.5864060195445;5517.117261238198;5540.584456165789;5424.728763561816;5427.891442171154;5440.211169380437;5442.564594832414;5454.127339625661;4016.7991600419937;4090.2228576570506;4179.979100104495;4180.101278225181;4220;4152.190322887038;4162.812673429703;4217.388478670591;4224.30299000666;4224.61978421942;4187.120704652027;4192.895177620553;4205.810738516774;4206.47419072616;4211.347241177622;4114.40341150533;4204.642605378546;4206.957930420687;4209.726367786115;4234.364845273203;3712.795796231206;3716.888493345204;3725.497057897176;3726.5341832270965;3726.9440958385644;5188.688678679291;5210.192420174841;5219.164933610604;5229.398619158769;5234.8691282717855;4734.360861283717;4833.371661683994;4840.080384726891;4868.537488938545;4877.292792545061;5680.147977803321;5681.119426488901;5702.5723070769445;5706.172604972297;5712.457316554921;4087.1621317629815;4091.161311931047;4099.139180772041;4103.384492326145;4106.466159399259;5606.495415412592;5914.378990206053;5918.437748413894;5988.431099045583;6003.489703375175;4045.474088368552;4060.837566497307;4066.837326506966;4070.470838790938;4078.7144899857317;4124.587541245852;4124.979375103106;4127.669786417079;4129.91740165195;4148.688848336326;4573.6569757268335;4758.881027974328;4761.833335833229;4773.331733557305;4882.707037577757;5655.6606603603095;5698.2592263005545;5711.400302968212;5737.512311453574;5765.682887441147;1475.8745506631842;1491.4779827060443;1496.865282124614;1504.292982298318;1513.5081098642765;946.5030858799186;989.9653512127041;993.7664648807524;1015.5125539740966;1046.4453839465095;4775.785089670903;4820.758962051884;4863.683860549053;4868;4876.268559716071;5803.82588522345;5828.562857785599;5837.7157025454335;5843.853903652443;5849.2103566018895;4732.479427262998;4840.975795121002;4856.757162141878;4859.392575928009;4964.90070198594;3159.984200078985;3179.459491886385;3185.394774992744;3190.9042728718177;3195.3769015041844;5528.391876893538;5534.584906132056;5551.111822108443;5551.611387202938;5583.106702927512;5932.79235226765;6029.427204415573;6053.51571874249;6074.331823499411;6091.48222401092;5487.067198576252;5501.394846566955;5517.586181036439;5524.861878453071;5560.91658625129;5727.4845263926445;5861.413858614104;5888.793892213752;5911.615744976562;5928.911066334094;5833;5845.766169353348;5847.853803654943;5860.267466566679;5863.794767183128;5493.862653433696;5524.33707955048;5547.1679248113105;5551.278333816578;5551.306086739158;3943.9014024649614;4015.9598404015587;4043.757374557536;4055.1078762672164;4064.1058967027207;5916.7041647918295;5919.289685237799;5922.2597175353085;5929.733162007807;5942.465178133989;5715.485606295453;5719.170720245458;5737.512311453574;5741.885162296647;5756.798512052058;5454.918176227439;5766;5768.480836724715;5771.7114144293455;5785.4214578541805;5316.308879845596;5628.971855140698;5634.295713035871;5635.436456354331;5639.548836093185;5589.80435684749;5783.884322313446;5784.595078344475;5811.215485909348;5811.854703632274;5551.225166886556;5614.24207731951;5614.522765564972;5614.943850561605;5615 03:45:57 INFO - PROCESS | 26265 | |5;yui.html;657.4017643944011;678.6708446403496;712.579578048951;736.8489459660764;748.2405358561061;10490.527926243318;10544.314619549743;11063.059639930605;11262.155338349636;11399.3730344831;13371.799423008662;13461.865381346184;13475.124116932393;13512.729745405086;13528.864711352884;822.9711960081383;827;830.4809494066209;832.7918020494876;836.6277006732007;815.1725998111921;815.3232816762103;817.513579420244;817.7955511122219;822.1901427094307;855.3499340501232;859.6561375449838;863.3999370437548;864.394923553512;866.8309679612478;838.3460900497591;838.4131108224267;841.7685136587427;844.9281811046069;853.9871901921445;615.9753609855601;617.9536534759866;620.5780069552702;620.8913440147955;624.1044101714054;11335.036521895649;11626.651200463999;11765.235259708092;11770.764584708259;11875.703107422383;12442.564510242099;12527.686807829787;12741.17182383142;12762;12915.612531624067;10006.89993100067;10077;10100.545475453622;10278.640247591373;10337.0696637303;3377.9493307600405;3404.710599599037;3447.9482807757654;3456.7753096048928;3529.0471572675233;41353.793231033655;44469.55530444686;44559.77720111411;48574;48984.265236021485;10462.372257664565;10490.42302673345;10553.525091370906;10602.0544841631;10719.249652524404;18452;18499.260029598667;18515.259389624534;18527.351542695942;18563.628727425377;7012.423624243716;7365.668544915492;7431.368333691588;7439.479236453504;7457.552546847207;3963.1677347757295;4010.7794071325775;4022.235775202702;4071.2671719090254;4079.143379890197;2893.5804308375587;2927.4437856807563;2950.9114726558237;2956.187048561663;2959.4525012872687;530.7187190788889;533.9385970613429;546.2243614068033;547.7124509632475;549.9422560631076;536.9006733754268;571.6220522625856;611.6116266171014;620.2123303404651;623.7536173211556;7701;7962.562059086806;8072.425876953937;8269.000168472021;8347.332213422911;494.36967865970456;572.1478430026316;578.5776383240258;579.1775678536488;631.5863109663178;3891.338472459632;3982.123932734794;4003.479547658844;4036.3138266494766;4080.836766529365;44944.77527612341;44969.55030449654;45040.77479612581;46498.302525462146;54026.729866351205;34813;34887;35041;41822.79088604599;42837.14325713468;34986.65013349834;35118.29763404769;36654.450183247274;38997.805010974764;39331.606683933365;8137.389695772722;8171.101178870438;8176.7955801105445;8267.462614930251;8818.779530511532;26998.46003079888;27175.72824271732;27486.587701184097;27566.5865012021;27576.483293419056;29293;31818.090914545202;36917;37046.62953370432;37419.62580374161;10878.94560527224;10879.619213327496;10928.235023548275;10929.18031147683;11310.095192384753;11615.941920290345;11809.763804723685;12013.279203247834;12061.456748896268;12205.87794122083;10861.076808471369;11073.446327683745;11226.438678066228;11942.16404851652;12011;10497.790044199226;10509.842352364567;10919.12646988223;10969.396683182502;11003.61487347939;7589.886151707618;7589.924100759143;7855.60721963888;7899.368050556057;8157.877631835646;9594.328397012143;9691.176250018827;9922.454265015493;9931.453770042717;9939.353941994037;9415.387999779992;9501.144896959308;9636.566354513923;9637.37357071788;9672.468014259282 03:45:57 INFO - PROCESS | 26265 | __end_tp_report 03:45:57 INFO - PROCESS | 26265 | __start_cc_report 03:45:57 INFO - PROCESS | 26265 | _x_x_mozilla_cycle_collect,369 03:45:57 INFO - PROCESS | 26265 | __end_cc_report 03:45:57 INFO - PROCESS | 26265 | __startTimestamp1461408357599__endTimestamp 03:45:57 INFO - PROCESS | 26265 | 03:45:57 INFO - PROCESS | 26265 | ------- Summary: start ------- 03:45:57 INFO - PROCESS | 26265 | Number of tests: 6 03:45:57 INFO - PROCESS | 26265 | 03:45:57 INFO - PROCESS | 26265 | [#0] dojo.html Cycles:165 Average:4739.34 Median:4867.63 stddev:606.23 (12.5%) stddev-sans-first:584.62 03:45:57 INFO - PROCESS | 26265 | Values: 2610.0 2693.6 2727.7 2736.6 2743.1 4774.1 4791.3 4807.5 4823.8 4858.4 4705.5 4739.8 4806.0 4842.1 4895.6 4370.4 4407.4 4447.6 4467.7 4503.7 631.5 4032.6 4341.6 4398.5 4399.1 4374.1 4385.6 4403.7 4417.8 4447.0 4388.7 4389.4 4394.0 4416.4 4436.7 4302.5 4369.4 4371.3 4371.8 4408.0 4691.6 4740.6 4741.6 4762.7 4762.8 5049.3 5109.8 5195.5 5196.8 5240.0 5195.2 5200.4 5218.1 5247.9 5263.7 4849.4 4857.2 4859.2 4867.6 4909.1 5225.7 5315.3 5326.9 5338.8 5368.0 5138.4 5141.8 5153.8 5158.3 5175.1 5241.2 5251.9 5256.6 5260.8 5295.4 4958.4 5031.1 5190.9 5192.4 5211.9 4977.5 4988.6 4992.0 5025.9 5039.7 4332.1 4336.5 4339.2 4367.7 4386.5 3691.7 3749.2 3824.2 3879.9 3929.2 4377.1 4399.6 4426.3 4437.6 4457.5 5187.8 5197.6 5198.7 5207.2 5227.4 4298.5 4368.6 4443.4 4444.2 4470.8 4603.9 4624.7 4625.6 4635.6 4666.3 4808.2 4819.7 4833.8 4835.0 4858.1 5072.1 5094.9 5127.6 5128.8 5152.1 4783.0 4808.7 4814.9 4817.3 4860.5 5029.8 5037.6 5064.7 5086.4 5113.2 5139.2 5183.8 5208.8 5235.4 5262.7 5013.6 5024.5 5026.9 5037.3 5050.4 4955.9 5029.1 5034.1 5042.2 5062.8 4931.4 4988.4 5011.6 5030.8 5040.0 5126.4 5184.1 5185.9 5202.5 5237.5 4850.1 4907.8 4944.1 5046.9 5069.6 03:45:57 INFO - PROCESS | 26265 | 03:45:57 INFO - PROCESS | 26265 | [#1] ext.html Cycles:180 Average:43711.13 Median:36215.14 stddev:81177.93 (224.2%) stddev-sans-first:81341.00 03:45:57 INFO - PROCESS | 26265 | Values: 560.4 600.9 613.1 625.6 633.0 34857.5 35954.6 36194.3 36237.0 36275.6 35701.0 36046.1 36112.1 36236.0 36271.3 7702.7 7837.7 7860.5 7871.4 7896.2 7745.0 7811.8 7820.6 7878.3 7879.1 7819.5 7837.4 7886.1 7888.0 7889.1 7830.4 7856.0 7868.5 7874.8 7876.3 7761.1 7845.1 7846.0 7856.0 7863.4 29564.6 36326.8 36814.6 36878.1 36952.8 3074.1 3107.9 3170.2 3609.7 3813.5 23964.4 24102.3 24243.3 24436.8 25286.5 3275.5 3296.2 3312.5 3317.5 3357.8 189630.0 191020.0 191459.0 192592.0 193674.0 31482.8 31913.2 32019.5 32071.5 32657.8 32065.0 32165.4 32233.8 32294.2 32307.8 10429.7 10477.0 10503.8 10530.4 10538.2 9419.1 9421.7 9456.2 9491.2 9524.9 7952.8 8201.5 8226.4 8252.8 8303.5 3216.8 3223.7 3267.4 3282.4 3285.1 920.7 944.0 1012.7 1051.2 1083.1 27348.3 29034.9 29142.9 29308.3 29400.6 954.1 982.0 997.0 1033.0 1051.0 14648.5 15241.0 15301.8 15495.6 15754.9 375572.0 379202.0 381301.0 381361.0 383258.1 49501.5 51245.2 51302.2 51358.2 51510.7 1202.1 1256.9 1263.3 1268.4 1271.1 27451.7 28114.6 28185.7 28210.2 28946.0 43189.6 43240.8 43622.8 43717.0 43795.1 313627.0 315906.0 320414.0 320972.0 322300.0 25192.7 25654.5 25702.7 25704.0 25753.4 42189.4 43031.0 43353.3 43716.6 44252.1 37083.4 37270.0 37398.4 37745.2 37811.8 36304.3 36741.3 36819.8 37259.4 37381.3 36347.6 36503.3 36748.4 36973.3 37072.3 32111.8 33697.7 33776.2 33818.8 34125.0 25428.9 25671.5 25745.4 25824.6 26006.2 03:45:57 INFO - PROCESS | 26265 | 03:45:57 INFO - PROCESS | 26265 | [#2] jquery.html Cycles:180 Average:23606.70 Median:5185.84 stddev:63017.83 (1215.2%) stddev-sans-first:63170.48 03:45:57 INFO - PROCESS | 26265 | Values: 380.1 389.9 390.4 395.8 403.5 15141.9 16904.4 17701.6 17761.1 17814.9 10455.2 15700.2 15917.6 15978.1 16042.4 4589.2 4731.7 4766.4 4770.9 4772.9 3511.9 5234.2 5521.7 5532.1 5536.9 5420.7 5511.2 5530.4 5538.8 5539.4 5487.1 5567.4 5568.7 5574.2 5585.7 5137.5 5312.5 5366.6 5366.9 5375.0 19144.3 19899.0 20098.4 20104.1 20126.4 1888.6 1955.3 2011.1 2011.3 2039.1 8779.0 8920.4 9200.6 9300.4 9350.2 1789.8 1802.7 1812.5 1853.6 1863.4 63615.0 65037.0 65500.7 66193.7 66758.3 9861.0 9989.8 10158.3 10319.1 10343.9 14220.1 14265.4 14385.9 14392.2 14407.6 6900.8 6933.5 6945.2 7036.7 7117.9 6313.1 6352.4 6432.7 6507.8 6512.1 4363.7 4465.9 4470.2 4512.5 4556.2 1731.6 1812.0 1813.4 1879.2 1900.7 833.1 849.8 885.3 920.2 975.1 15296.2 16035.4 16073.1 16254.5 16439.3 801.6 815.2 852.5 856.2 931.9 6955.7 9093.7 9161.7 9197.0 9358.2 367332.0 382639.0 384097.0 385759.0 388637.0 75250.0 77834.0 78034.0 78421.0 80170.6 951.2 955.1 962.5 967.4 969.3 14651.4 14674.2 14703.2 14787.3 15080.0 33139.3 33610.0 34840.8 34999.5 35248.3 42991.4 44755.6 47678.3 49228.8 49484.0 7492.9 7544.2 7709.1 7738.9 7834.0 10751.4 10805.4 10814.7 11286.7 11388.9 9400.6 9523.2 9853.8 9977.1 10224.8 9723.4 9791.3 9839.7 9869.7 9922.4 9733.6 9880.2 10214.3 10309.1 10374.8 7172.4 7446.7 7824.4 7871.7 7885.7 9261.3 9661.7 9972.6 10177.3 10308.9 03:45:57 INFO - PROCESS | 26265 | 03:45:57 INFO - PROCESS | 26265 | [#3] mootools.html Cycles:180 Average:5250.76 Median:5594.75 stddev:2892.89 (51.7%) stddev-sans-first:2886.76 03:45:57 INFO - PROCESS | 26265 | Values: 1430.8 1485.8 1589.5 1714.2 1761.9 7011.7 7656.6 7703.5 7969.2 7969.4 7707.8 7732.1 7778.3 7804.3 7818.4 2206.2 2231.9 2232.0 2232.4 2238.3 2188.9 2205.6 2213.4 2219.5 2221.8 2138.3 2145.1 2145.4 2158.7 2190.1 2133.6 2149.1 2150.5 2152.4 2153.2 2130.2 2201.9 2202.2 2206.4 2207.8 7893.9 7951.3 7969.4 7970.0 7974.5 4602.1 4717.0 4723.4 4724.3 4742.3 3050.5 3106.5 3142.7 3173.1 3213.7 939.9 946.7 957.9 962.9 975.2 10939.6 10963.1 10986.4 10997.3 10998.2 4170.6 4201.5 4342.1 4350.7 4448.1 9278.4 9283.9 9287.3 9314.5 9339.2 4727.0 4743.7 4759.1 4764.3 4767.8 3841.8 4225.0 4263.1 4288.4 4308.4 3693.7 3732.9 3819.1 3823.1 3845.1 1230.9 1239.8 1260.0 1262.2 1273.2 792.9 837.5 838.0 850.8 857.4 5436.3 5567.2 5622.3 5630.5 5693.7 874.9 892.0 898.6 953.1 953.9 3675.7 3683.8 3698.8 3703.7 3952.0 9346.1 9587.8 9662.3 9679.1 9788.3 9614.7 9765.8 9805.3 9843.8 9877.7 7306.4 7493.7 7507.4 7550.2 7559.7 5411.8 5448.8 5495.5 5562.8 5627.5 8842.8 8855.4 8902.6 8949.0 8962.6 8133.6 8544.3 8588.1 8893.0 8920.6 6779.3 7285.6 7355.1 7523.7 7560.6 7446.5 7558.6 7581.0 7585.3 7612.2 6624.8 6828.9 6858.1 6975.0 6994.2 6499.1 6665.3 6678.5 6722.3 6936.9 6577.1 6643.4 6713.2 6722.2 6757.6 4712.8 4717.7 4794.9 4820.3 4849.3 4760.4 4839.5 4943.2 4984.7 4994.0 03:45:57 INFO - PROCESS | 26265 | 03:45:57 INFO - PROCESS | 26265 | [#4] prototype.html Cycles:180 Average:4721.47 Median:5434.54 stddev:1380.01 (25.4%) stddev-sans-first:1343.58 03:45:57 INFO - PROCESS | 26265 | Values: 310.6 318.1 320.8 323.4 326.2 5428.9 5507.6 5514.6 5517.1 5540.6 5424.7 5427.9 5440.2 5442.6 5454.1 4016.8 4090.2 4180.0 4180.1 4220.0 4152.2 4162.8 4217.4 4224.3 4224.6 4187.1 4192.9 4205.8 4206.5 4211.3 4114.4 4204.6 4207.0 4209.7 4234.4 3712.8 3716.9 3725.5 3726.5 3726.9 5188.7 5210.2 5219.2 5229.4 5234.9 4734.4 4833.4 4840.1 4868.5 4877.3 5680.1 5681.1 5702.6 5706.2 5712.5 4087.2 4091.2 4099.1 4103.4 4106.5 5606.5 5914.4 5918.4 5988.4 6003.5 4045.5 4060.8 4066.8 4070.5 4078.7 4124.6 4125.0 4127.7 4129.9 4148.7 4573.7 4758.9 4761.8 4773.3 4882.7 5655.7 5698.3 5711.4 5737.5 5765.7 1475.9 1491.5 1496.9 1504.3 1513.5 946.5 990.0 993.8 1015.5 1046.4 4775.8 4820.8 4863.7 4868.0 4876.3 5803.8 5828.6 5837.7 5843.9 5849.2 4732.5 4841.0 4856.8 4859.4 4964.9 3160.0 3179.5 3185.4 3190.9 3195.4 5528.4 5534.6 5551.1 5551.6 5583.1 5932.8 6029.4 6053.5 6074.3 6091.5 5487.1 5501.4 5517.6 5524.9 5560.9 5727.5 5861.4 5888.8 5911.6 5928.9 5833.0 5845.8 5847.9 5860.3 5863.8 5493.9 5524.3 5547.2 5551.3 5551.3 3943.9 4016.0 4043.8 4055.1 4064.1 5916.7 5919.3 5922.3 5929.7 5942.5 5715.5 5719.2 5737.5 5741.9 5756.8 5454.9 5766.0 5768.5 5771.7 5785.4 5316.3 5629.0 5634.3 5635.4 5639.5 5589.8 5783.9 5784.6 5811.2 5811.9 5551.2 5614.2 5614.5 5614.9 5615.0 03:45:57 INFO - PROCESS | 26265 | 03:45:57 INFO - PROCESS | 26265 | [#5] yui.html Cycles:180 Average:12064.16 Median:4075.21 stddev:12957.18 (318.0%) stddev-sans-first:12965.21 03:45:57 INFO - PROCESS | 26265 | Values: 657.4 678.7 712.6 736.8 748.2 10490.5 10544.3 11063.1 11262.2 11399.4 13371.8 13461.9 13475.1 13512.7 13528.9 823.0 827.0 830.5 832.8 836.6 815.2 815.3 817.5 817.8 822.2 855.3 859.7 863.4 864.4 866.8 838.3 838.4 841.8 844.9 854.0 616.0 618.0 620.6 620.9 624.1 11335.0 11626.7 11765.2 11770.8 11875.7 12442.6 12527.7 12741.2 12762.0 12915.6 10006.9 10077.0 10100.5 10278.6 10337.1 3377.9 3404.7 3447.9 3456.8 3529.0 41353.8 44469.6 44559.8 48574.0 48984.3 10462.4 10490.4 10553.5 10602.1 10719.2 18452.0 18499.3 18515.3 18527.4 18563.6 7012.4 7365.7 7431.4 7439.5 7457.6 3963.2 4010.8 4022.2 4071.3 4079.1 2893.6 2927.4 2950.9 2956.2 2959.5 530.7 533.9 546.2 547.7 549.9 536.9 571.6 611.6 620.2 623.8 7701.0 7962.6 8072.4 8269.0 8347.3 494.4 572.1 578.6 579.2 631.6 3891.3 3982.1 4003.5 4036.3 4080.8 44944.8 44969.6 45040.8 46498.3 54026.7 34813.0 34887.0 35041.0 41822.8 42837.1 34986.7 35118.3 36654.5 38997.8 39331.6 8137.4 8171.1 8176.8 8267.5 8818.8 26998.5 27175.7 27486.6 27566.6 27576.5 29293.0 31818.1 36917.0 37046.6 37419.6 10878.9 10879.6 10928.2 10929.2 11310.1 11615.9 11809.8 12013.3 12061.5 12205.9 10861.1 11073.4 11226.4 11942.2 12011.0 10497.8 10509.8 10919.1 10969.4 11003.6 7589.9 7589.9 7855.6 7899.4 8157.9 9594.3 9691.2 9922.5 9931.5 9939.4 9415.4 9501.1 9636.6 9637.4 9672.5 03:45:57 INFO - PROCESS | 26265 | -------- Summary: end -------- 03:45:57 INFO - PROCESS | 26265 | 03:45:58 INFO - TEST-INFO | 26265: exit 0 03:45:58 INFO - TEST-OK | dromaeo_css | took 1115191ms 03:45:58 INFO - TEST-START | kraken 03:45:58 INFO - operating with platform_type : linux_ 03:45:58 INFO - Initialising browser for kraken test... 03:45:58 INFO - TEST-INFO | started process 26500 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSaUTW9/profile http://localhost:56609/getInfo.html) 03:46:01 INFO - PROCESS | 26500 | 03:46:01 INFO - PROCESS | 26500 | (process:26568): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:46:02 INFO - PROCESS | 26500 | __metrics Screen width/height:1600/1200 03:46:02 INFO - PROCESS | 26500 | colorDepth:24 03:46:02 INFO - PROCESS | 26500 | Browser inner width/height: 1024/697 03:46:02 INFO - PROCESS | 26500 | __metrics 03:46:03 ERROR - PROCESS | 26500 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 03:46:04 INFO - TEST-INFO | 26500: exit 0 03:46:04 INFO - Browser initialized. 03:46:04 INFO - Running cycle 1/1 for kraken test... 03:46:04 INFO - TEST-INFO | started process 26619 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSaUTW9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:46:06 INFO - PROCESS | 26619 | 03:46:06 INFO - PROCESS | 26619 | (process:26680): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:46:16 INFO - PROCESS | 26619 | RSS: Main: 165908480 03:46:16 INFO - PROCESS | 26619 | 03:46:18 INFO - PROCESS | 26619 | Cycle 1(1): loaded http://localhost:56609/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56609/tests/kraken/driver.html?testName=audio-beat-detection) 03:46:19 INFO - PROCESS | 26619 | RSS: Main: 170090496 03:46:19 INFO - PROCESS | 26619 | 03:46:22 INFO - PROCESS | 26619 | Cycle 1(1): loaded http://localhost:56609/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56609/tests/kraken/driver.html?testName=audio-dft) 03:46:23 INFO - PROCESS | 26619 | RSS: Main: 173510656 03:46:23 INFO - PROCESS | 26619 | 03:46:26 INFO - PROCESS | 26619 | Cycle 1(1): loaded http://localhost:56609/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56609/tests/kraken/driver.html?testName=audio-fft) 03:46:26 INFO - PROCESS | 26619 | RSS: Main: 163430400 03:46:26 INFO - PROCESS | 26619 | 03:46:29 INFO - PROCESS | 26619 | Cycle 1(1): loaded http://localhost:56609/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56609/tests/kraken/driver.html?testName=audio-oscillator) 03:46:29 INFO - PROCESS | 26619 | RSS: Main: 164495360 03:46:29 INFO - PROCESS | 26619 | 03:46:31 INFO - PROCESS | 26619 | Cycle 1(1): loaded http://localhost:56609/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56609/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:46:32 INFO - PROCESS | 26619 | RSS: Main: 165347328 03:46:32 INFO - PROCESS | 26619 | 03:46:35 INFO - PROCESS | 26619 | Cycle 1(1): loaded http://localhost:56609/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56609/tests/kraken/driver.html?testName=imaging-darkroom) 03:46:36 INFO - PROCESS | 26619 | RSS: Main: 165863424 03:46:36 INFO - PROCESS | 26619 | 03:46:39 INFO - PROCESS | 26619 | Cycle 1(1): loaded http://localhost:56609/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56609/tests/kraken/driver.html?testName=imaging-desaturate) 03:46:40 INFO - PROCESS | 26619 | RSS: Main: 163778560 03:46:40 INFO - PROCESS | 26619 | 03:46:43 INFO - PROCESS | 26619 | Cycle 1(1): loaded http://localhost:56609/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56609/tests/kraken/driver.html?testName=json-parse-financial) 03:46:44 INFO - PROCESS | 26619 | RSS: Main: 164655104 03:46:44 INFO - PROCESS | 26619 | 03:46:45 INFO - PROCESS | 26619 | Cycle 1(1): loaded http://localhost:56609/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56609/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:46:46 INFO - PROCESS | 26619 | RSS: Main: 165081088 03:46:46 INFO - PROCESS | 26619 | 03:46:48 INFO - PROCESS | 26619 | Cycle 1(1): loaded http://localhost:56609/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56609/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:46:49 INFO - PROCESS | 26619 | RSS: Main: 165031936 03:46:49 INFO - PROCESS | 26619 | 03:46:51 INFO - PROCESS | 26619 | Cycle 1(1): loaded http://localhost:56609/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56609/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:46:51 INFO - PROCESS | 26619 | RSS: Main: 165421056 03:46:51 INFO - PROCESS | 26619 | 03:46:54 INFO - PROCESS | 26619 | Cycle 1(1): loaded http://localhost:56609/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56609/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:46:55 INFO - PROCESS | 26619 | RSS: Main: 165761024 03:46:55 INFO - PROCESS | 26619 | 03:46:58 INFO - PROCESS | 26619 | Cycle 1(1): loaded http://localhost:56609/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56609/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:46:59 INFO - PROCESS | 26619 | RSS: Main: 165650432 03:46:59 INFO - PROCESS | 26619 | 03:47:00 INFO - PROCESS | 26619 | Cycle 1(1): loaded http://localhost:56609/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56609/tests/kraken/driver.html?testName=ai-astar) 03:47:01 INFO - PROCESS | 26619 | RSS: Main: 167170048 03:47:01 INFO - PROCESS | 26619 | 03:47:01 INFO - PROCESS | 26619 | __start_tp_report 03:47:01 INFO - PROCESS | 26619 | _x_x_mozilla_page_load 03:47:01 INFO - PROCESS | 26619 | _x_x_mozilla_page_load_details 03:47:01 INFO - PROCESS | 26619 | |i|pagename|runs| 03:47:01 INFO - PROCESS | 26619 | |0;ai-astar;114;109;113;117;115;127;115;116;114;115 03:47:01 INFO - PROCESS | 26619 | |1;audio-beat-detection;163;132;152;186;137;161;159;133;183;135 03:47:01 INFO - PROCESS | 26619 | |2;audio-dft;163;163;167;168;167;162;162;162;165;163 03:47:01 INFO - PROCESS | 26619 | |3;audio-fft;78;74;76;156;76;75;73;73;152;74 03:47:01 INFO - PROCESS | 26619 | |4;audio-oscillator;95;94;152;95;95;95;139;95;97;143 03:47:01 INFO - PROCESS | 26619 | |5;imaging-gaussian-blur;117;118;118;117;117;118;118;118;118;118 03:47:01 INFO - PROCESS | 26619 | |6;imaging-darkroom;147;147;148;147;146;148;147;148;148;149 03:47:01 INFO - PROCESS | 26619 | |7;imaging-desaturate;95;96;95;95;95;95;96;97;95;95 03:47:01 INFO - PROCESS | 26619 | |8;json-parse-financial;68;67;68;67;67;67;67;67;68;67 03:47:01 INFO - PROCESS | 26619 | |9;json-stringify-tinderbox;66;66;65;66;66;67;66;65;65;65 03:47:01 INFO - PROCESS | 26619 | |10;stanford-crypto-aes;80;78;78;79;80;80;80;80;113;88 03:47:01 INFO - PROCESS | 26619 | |11;stanford-crypto-ccm;141;137;137;141;138;147;143;146;138;143 03:47:01 INFO - PROCESS | 26619 | |12;stanford-crypto-pbkdf2;174;171;173;172;173;174;179;176;173;174 03:47:01 INFO - PROCESS | 26619 | |13;stanford-crypto-sha256-iterative;74;74;75;75;74;72;72;72;72;74 03:47:01 INFO - PROCESS | 26619 | __end_tp_report 03:47:01 INFO - PROCESS | 26619 | __start_cc_report 03:47:01 INFO - PROCESS | 26619 | _x_x_mozilla_cycle_collect,927 03:47:01 INFO - PROCESS | 26619 | __end_cc_report 03:47:01 INFO - PROCESS | 26619 | __startTimestamp1461408421087__endTimestamp 03:47:01 INFO - PROCESS | 26619 | 03:47:01 INFO - PROCESS | 26619 | ------- Summary: start ------- 03:47:01 INFO - PROCESS | 26619 | Number of tests: 14 03:47:01 INFO - PROCESS | 26619 | 03:47:01 INFO - PROCESS | 26619 | [#0] ai-astar Cycles:10 Average:115.50 Median:115.00 stddev:4.58 (4.0%) stddev-sans-first:4.82 03:47:01 INFO - PROCESS | 26619 | Values: 114.0 109.0 113.0 117.0 115.0 127.0 115.0 116.0 114.0 115.0 03:47:01 INFO - PROCESS | 26619 | 03:47:01 INFO - PROCESS | 26619 | [#1] audio-beat-detection Cycles:10 Average:154.10 Median:160.00 stddev:20.00 (12.5%) stddev-sans-first:20.95 03:47:01 INFO - PROCESS | 26619 | Values: 163.0 132.0 152.0 186.0 137.0 161.0 159.0 133.0 183.0 135.0 03:47:01 INFO - PROCESS | 26619 | 03:47:01 INFO - PROCESS | 26619 | [#2] audio-dft Cycles:10 Average:164.20 Median:164.00 stddev:2.35 (1.4%) stddev-sans-first:2.45 03:47:01 INFO - PROCESS | 26619 | Values: 163.0 163.0 167.0 168.0 167.0 162.0 162.0 162.0 165.0 163.0 03:47:01 INFO - PROCESS | 26619 | 03:47:01 INFO - PROCESS | 26619 | [#3] audio-fft Cycles:10 Average:90.70 Median:74.50 stddev:33.41 (44.8%) stddev-sans-first:35.12 03:47:01 INFO - PROCESS | 26619 | Values: 78.0 74.0 76.0 156.0 76.0 75.0 73.0 73.0 152.0 74.0 03:47:01 INFO - PROCESS | 26619 | 03:47:01 INFO - PROCESS | 26619 | [#4] audio-oscillator Cycles:10 Average:110.00 Median:95.00 stddev:24.14 (25.4%) stddev-sans-first:24.98 03:47:01 INFO - PROCESS | 26619 | Values: 95.0 94.0 152.0 95.0 95.0 95.0 139.0 95.0 97.0 143.0 03:47:01 INFO - PROCESS | 26619 | 03:47:01 INFO - PROCESS | 26619 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 03:47:01 INFO - PROCESS | 26619 | Values: 117.0 118.0 118.0 117.0 117.0 118.0 118.0 118.0 118.0 118.0 03:47:01 INFO - PROCESS | 26619 | 03:47:01 INFO - PROCESS | 26619 | [#6] imaging-darkroom Cycles:10 Average:147.50 Median:148.00 stddev:0.85 (0.6%) stddev-sans-first:0.88 03:47:01 INFO - PROCESS | 26619 | Values: 147.0 147.0 148.0 147.0 146.0 148.0 147.0 148.0 148.0 149.0 03:47:01 INFO - PROCESS | 26619 | 03:47:01 INFO - PROCESS | 26619 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 03:47:01 INFO - PROCESS | 26619 | Values: 95.0 96.0 95.0 95.0 95.0 95.0 96.0 97.0 95.0 95.0 03:47:01 INFO - PROCESS | 26619 | 03:47:01 INFO - PROCESS | 26619 | [#8] json-parse-financial Cycles:10 Average:67.30 Median:67.00 stddev:0.48 (0.7%) stddev-sans-first:0.44 03:47:01 INFO - PROCESS | 26619 | Values: 68.0 67.0 68.0 67.0 67.0 67.0 67.0 67.0 68.0 67.0 03:47:01 INFO - PROCESS | 26619 | 03:47:01 INFO - PROCESS | 26619 | [#9] json-stringify-tinderbox Cycles:10 Average:65.70 Median:66.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 03:47:01 INFO - PROCESS | 26619 | Values: 66.0 66.0 65.0 66.0 66.0 67.0 66.0 65.0 65.0 65.0 03:47:01 INFO - PROCESS | 26619 | 03:47:01 INFO - PROCESS | 26619 | [#10] stanford-crypto-aes Cycles:10 Average:83.60 Median:80.00 stddev:10.71 (13.4%) stddev-sans-first:11.28 03:47:01 INFO - PROCESS | 26619 | Values: 80.0 78.0 78.0 79.0 80.0 80.0 80.0 80.0 113.0 88.0 03:47:01 INFO - PROCESS | 26619 | 03:47:01 INFO - PROCESS | 26619 | [#11] stanford-crypto-ccm Cycles:10 Average:141.10 Median:142.00 stddev:3.63 (2.6%) stddev-sans-first:3.86 03:47:01 INFO - PROCESS | 26619 | Values: 141.0 137.0 137.0 141.0 138.0 147.0 143.0 146.0 138.0 143.0 03:47:01 INFO - PROCESS | 26619 | 03:47:01 INFO - PROCESS | 26619 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.90 Median:174.00 stddev:2.23 (1.3%) stddev-sans-first:2.37 03:47:01 INFO - PROCESS | 26619 | Values: 174.0 171.0 173.0 172.0 173.0 174.0 179.0 176.0 173.0 174.0 03:47:01 INFO - PROCESS | 26619 | 03:47:01 INFO - PROCESS | 26619 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.40 Median:74.00 stddev:1.26 (1.7%) stddev-sans-first:1.32 03:47:01 INFO - PROCESS | 26619 | Values: 74.0 74.0 75.0 75.0 74.0 72.0 72.0 72.0 72.0 74.0 03:47:01 INFO - PROCESS | 26619 | -------- Summary: end -------- 03:47:01 INFO - PROCESS | 26619 | 03:47:02 INFO - TEST-INFO | 26619: exit 0 03:47:02 INFO - TEST-OK | kraken | took 63797ms 03:47:02 INFO - SUITE-END | took 1178s 03:47:02 INFO - Completed test suite (00:19:39) 03:47:02 INFO - javascript benchmark 03:47:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2609.9869500652494, 2693.5555633320505, 2727.672679278487, 2736.575830746235, 2743.149623616679, 4774.140654682155, 4791.281307803831, 4807.495213002637, 4823.807047718092, 4858.392700912386, 4705.482396936334, 4739.786709598067, 4805.975970120145, 4842.12841688496, 4895.5838753705975, 4370.366296886949, 4407.427034485529, 4447.5552444755585, 4467.687261891669, 4503.707259028152, 631.4501375697515, 4032.5967403259588, 4341.587549182823, 4398.450193725785, 4399.05420334628, 4374.081442896995, 4385.583369579885, 4403.669724770655, 4417.845375411845, 4446.9994251293365, 4388.7147335423415, 4389.429374181336, 4393.956060439386, 4416.3596278539435, 4436.7116137451285, 4302.526722060571, 4369.366441865912, 4371.344298355272, 4371.759553224571, 4408.030233348658, 4691.581223686648, 4740.644451666104, 4741.5732584067255, 4762.714237145782, 4762.809487620491, 5049.267856160836, 5109.795608175668, 5195.506426889439, 5196.818111366122, 5239.973800131013, 5195.220716892459, 5200.401953775288, 5218.086834803932, 5247.895042099137, 5263.6841789492755, 4849.369581954394, 4857.222844344923, 4859.246816743411, 4867.634927380461, 4909.0672772173175, 5225.686458812407, 5315.282436870973, 5326.866828329245, 5338.839834804962, 5367.973160134253, 5138.409082955433, 5141.76862041209, 5153.819616313411, 5158.329417175743, 5175.120229560984, 5241.240020197126, 5251.894962100813, 5256.6320357574605, 5260.815871444558, 5295.443978382292, 4958.404991401055, 5031.119554078022, 5190.870228244324, 5192.376914770176, 5211.869703257373, 4977.502249774993, 4988.6009119270375, 4991.950080499221, 5025.874353141201, 5039.748012599355, 4332.090261045216, 4336.479622445327, 4339.153864996296, 4367.650587952956, 4386.539413361615, 3691.7231207658997, 3749.1564398010773, 3824.158685089276, 3879.9418008729326, 3929.233799409145, 4377.146456441027, 4399.560043995639, 4426.336049592587, 4437.5784300491405, 4457.487388950312, 5187.844364669066, 5197.558207552324, 5198.662086964335, 5207.2449494823795, 5227.424983251839, 4298.484181898192, 4368.584984426474, 4443.400140980991, 4444.200043992112, 4470.798814053375, 4603.9079218415445, 4624.722516649012, 4625.583697467244, 4635.559621835921, 4666.346711460398, 4808.230683090689, 4819.734914579732, 4833.830815921426, 4835.032993401333, 4858.05267972742, 5072.1123803335, 5094.898102037864, 5127.6410651254055, 5128.769095416998, 5152.149895267239, 4783.0, 4808.663393562417, 4814.855554333376, 4817.325574419654, 4860.489648586848, 5029.798808047637, 5037.571806396498, 5064.721440320818, 5086.389633243886, 5113.181890897587, 5139.177731562932, 5183.844484665316, 5208.8437346879655, 5235.397929238186, 5262.710550919736, 5013.573846223112, 5024.472430394756, 5026.874328141679, 5037.319961805109, 5050.444451110301, 4955.876103097451, 5029.119904016856, 5034.0686972910125, 5042.168042272984, 5062.797488100435, 4931.3589233399425, 4988.401391833003, 5011.574016208663, 5030.773615187399, 5039.974800125976, 5126.384833819965, 5184.144616138295, 5185.870353241048, 5202.453742356998, 5237.476252374732, 4850.078485087822, 4907.77914993819, 4944.085344211332, 5046.899062018812, 5069.5944324454695], "value": 4701.399604983429, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [560.4479587606207, 600.8888355654204, 613.0803794308537, 625.6152466233265, 632.9905051424226, 34857.47713784292, 35954.64045359546, 36194.276114477696, 36237.0, 36275.63724362752, 35701.0, 36046.09884752876, 36112.097197570074, 36236.0, 36271.2745745085, 7702.73040443586, 7837.6864925402915, 7860.489068210577, 7871.370290376756, 7896.249856263646, 7745.0, 7811.843763124734, 7820.648070836797, 7878.330341920943, 7879.054513458393, 7819.491733037363, 7837.4121940854375, 7886.132525422199, 7888.013998250219, 7889.053313602376, 7830.373570114406, 7856.0, 7868.527888326718, 7874.763757087297, 7876.291133797957, 7761.068671759425, 7845.137034926153, 7846.019247594051, 7855.96072019642, 7863.410244231705, 29564.556531652044, 36326.818365908, 36814.631853681654, 36878.078048049014, 36952.81523592392, 3074.123874695701, 3107.922301942447, 3170.2074481379655, 3609.7112231021456, 3813.523309586302, 23964.400889977715, 24102.27693169208, 24243.272701818973, 24436.755632443805, 25286.49427011468, 3275.5452584485083, 3296.225387034045, 3312.4865645824934, 3317.4692049272003, 3357.832108394595, 189630.0, 191020.0, 191459.0, 192592.0, 193674.03162984236, 31482.842585786926, 31913.202169945936, 32019.51970720441, 32071.51892721611, 32657.83671081677, 32065.0, 32165.35669286601, 32233.838830805696, 32294.19264518406, 32307.838460807547, 10429.739256518647, 10477.0, 10503.789924201474, 10530.36817790935, 10538.20963427746, 9419.058094190526, 9421.670241541513, 9456.243500519942, 9491.240700743923, 9524.8571271431, 7952.761417157494, 8201.466904651179, 8226.383021273428, 8252.752417427488, 8303.4602750821, 3216.8391580420885, 3223.693749093832, 3267.36286424145, 3282.3927573398996, 3285.1130194847256, 920.6547544670749, 943.9952800235955, 1012.6708819633649, 1051.222095649214, 1083.106437189322, 27348.316292092855, 29034.854825726157, 29142.854285728437, 29308.26729331741, 29400.558991615144, 954.1222075690381, 982.0, 996.9830772611896, 1032.9741756455999, 1050.968470945873, 14648.487302944346, 15241.0, 15301.846981530041, 15495.612609684622, 15754.9212253938, 375572.0, 379202.0, 381301.0, 381361.0, 383258.08370958525, 49501.504984949686, 51245.231321530206, 51302.230466543035, 51358.22962655563, 51510.74244628753, 1202.0744027099086, 1256.9371531423576, 1263.3051821498138, 1268.4165283969478, 1271.0721173543366, 27451.725482745715, 28114.578281325386, 28185.71814281831, 28210.15369538917, 28946.0, 43189.568104318554, 43240.78379608082, 43622.781886090364, 43717.0, 43795.12409751851, 313627.0, 315906.0, 320414.0, 320972.0, 322300.0, 25192.74807251904, 25654.486910262065, 25702.742972570784, 25704.0, 25753.356166095997, 42189.367159493246, 43031.0, 43353.3496997539, 43716.56283437125, 44252.11495770131, 37083.44374834433, 37270.0, 37398.439023415216, 37745.24509509849, 37811.81094094512, 36304.27391452209, 36741.26517469582, 36819.81590092032, 37259.44110838285, 37381.25237495289, 36347.63652363443, 36503.26993460063, 36748.44877326789, 36973.26053478861, 37072.25855482929, 32111.839440802647, 33697.663023370435, 33776.15559611029, 33818.830905845316, 34125.0, 25428.872855635604, 25671.486570268862, 25745.356366090247, 25824.612630810927, 26006.219813405627], "value": 16032.50572158695, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [380.08210172433576, 389.92981263372593, 390.3734506117681, 395.7645201105343, 403.53794904833984, 15141.883314842034, 16904.40834570787, 17701.557461063465, 17761.111944402794, 17814.910925445387, 10455.163586913048, 15700.21498925052, 15917.602059948507, 15978.121203333812, 16042.35830566776, 4589.24277494213, 4731.716097034189, 4766.428028636568, 4770.928436073462, 4772.856814295559, 3511.859525618985, 5234.214867769827, 5521.696306703129, 5532.087205611069, 5536.916946245809, 5420.6747595144225, 5511.22842802008, 5530.419305972875, 5538.806141785039, 5539.446055394448, 5487.122060470326, 5567.415421380758, 5568.66588004717, 5574.219609254707, 5585.748641311151, 5137.460566640486, 5312.4687531246955, 5366.570674346082, 5366.865828354284, 5374.973125134388, 19144.329948451737, 19899.0, 20098.39704808858, 20104.09531571068, 20126.39620811378, 1888.5845114075019, 1955.3418137378692, 2011.1452632631074, 2011.3161525081543, 2039.1027947702962, 8778.956105219497, 8920.420172688755, 9200.631974721004, 9300.418928782055, 9350.205232555241, 1789.8478629316523, 1802.737747171477, 1812.5378028602754, 1853.6107417442354, 1863.3664554051688, 63615.0, 65037.0, 65500.672496637686, 66193.66903165453, 66758.33241667619, 9860.950695246478, 9989.80020399588, 10158.288919775692, 10319.122874555747, 10343.9482802587, 14220.146791192561, 14265.358058887376, 14385.928070359581, 14392.20842853653, 14407.63980900465, 6900.7929762107215, 6933.5493192942295, 6945.166580010431, 7036.713068252839, 7117.857642847114, 6313.053042043638, 6352.396522330371, 6432.71052802625, 6507.837304067436, 6512.088307636935, 4363.716358436755, 4465.933011004838, 4470.150671372494, 4512.458504979423, 4556.248219043887, 1731.6277000444713, 1811.9615432638282, 1813.3834496271331, 1879.2389082421369, 1900.7338972543855, 833.0503226321998, 849.8257857139272, 885.274075258282, 920.1764420843308, 975.1029053271008, 15296.158711270988, 16035.358585656677, 16073.115978621288, 16254.51236462908, 16439.26023328953, 801.579170935252, 815.1888870573698, 852.4927668037508, 856.2293935458138, 931.902150274225, 6955.721771129098, 9093.681721139728, 9161.725148245563, 9197.0, 9358.22193783179, 367332.0, 382639.0, 384097.0, 385759.0, 388637.0, 75250.0, 77834.0, 78034.0, 78421.0, 80170.59914700506, 951.191487235844, 955.1165172215673, 962.5187406296851, 967.4002118686459, 969.2633598465217, 14651.413943442143, 14674.192919389536, 14703.191324477257, 14787.334569944593, 15080.0, 33139.337213255116, 33610.0, 34840.82579587086, 34999.475007875415, 35248.295034098664, 42991.355129673706, 44755.552444475135, 47678.28482572695, 49228.753856231924, 49484.0, 7492.925070749223, 7544.245575442412, 7709.0749110107145, 7738.92261077382, 7834.0, 10751.408672523086, 10805.405702686428, 10814.729631759268, 11286.66140015801, 11388.886111138783, 9400.623975041195, 9523.23814094857, 9853.802923941625, 9977.10206081456, 10224.795504090025, 9723.416595004039, 9791.265655075755, 9839.655612053544, 9869.654562090293, 9922.40465572068, 9733.58862964852, 9880.160186384237, 10214.336068155546, 10309.07218350352, 10374.844377334497, 7172.39034682037, 7446.70213191488, 7824.413169012233, 7871.724489642835, 7885.723999659985, 9261.305402094735, 9661.71014869555, 9972.551235194578, 10177.338472999232, 10308.896911030793], "value": 8045.30912160072, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1430.8426073131957, 1485.7994170786944, 1589.507252751647, 1714.202895653521, 1761.9295228190872, 7011.719531218745, 7656.617169141548, 7703.460757746953, 7969.242921922408, 7969.442139050268, 7707.807304817382, 7732.110807257167, 7778.299953004229, 7804.29761321481, 7818.374530037598, 2206.2498750424893, 2231.877246751428, 2232.0, 2232.430730163806, 2238.272561417538, 2188.9452763680874, 2205.6250437425674, 2213.3691897809126, 2219.533897881447, 2221.766714494979, 2138.347803919804, 2145.141943222716, 2145.3778404262744, 2158.7301587301586, 2190.080166330137, 2133.5626196629655, 2149.118861266889, 2150.4516348331153, 2152.35429371188, 2153.2356013615176, 2130.20117455954, 2201.9229326973477, 2202.1521714140013, 2206.360155554887, 2207.845450818443, 7893.921060789376, 7951.284384405373, 7969.362451003905, 7970.043594768606, 7974.481658692166, 4602.125596136723, 4717.0, 4723.36234608327, 4724.338592597039, 4742.264948932886, 3050.527168288919, 3106.456370135217, 3142.6543080261154, 3173.0639461358955, 3213.678632136791, 939.9436033837924, 946.7017889364897, 957.8563215517659, 962.8603852441357, 975.1808480876098, 10939.56241750329, 10963.068139208177, 10986.395748233765, 10997.285176463503, 10998.175136864767, 4170.624643782075, 4201.474815648044, 4342.0664557119735, 4350.695451318377, 4448.065906159743, 9278.396904201205, 9283.90716092844, 9287.303452241109, 9314.48770317639, 9339.159475647088, 4726.95273047272, 4743.739094349844, 4759.119562880878, 4764.2615394613895, 4767.785449654774, 3841.8079096045085, 4225.049363893099, 4263.126059157865, 4288.399624052635, 4308.418363520947, 3693.6675699187203, 3732.9440058399146, 3819.102510909934, 3823.1397935464297, 3845.0771814764257, 1230.870758570355, 1239.8388209532702, 1260.0423678004781, 1262.236347010064, 1273.2360583649922, 792.904851417822, 837.4723923928008, 838.0446291228005, 850.8085680721788, 857.3569822633025, 5436.347638283352, 5567.164925261243, 5622.325320961429, 5630.465105814941, 5693.658380497183, 874.9387542872065, 891.9821603567892, 898.6180873128894, 953.1136043479491, 953.9189168920719, 3675.7059435245114, 3683.7605555638797, 3698.815059247027, 3703.7407381483577, 3952.0, 9346.11211934865, 9587.808243835085, 9662.275329350327, 9679.128878400978, 9788.265880059023, 9614.71155865325, 9765.804683906283, 9805.264605154642, 9843.803123937625, 9877.654282100091, 7306.415486761046, 7493.737719179911, 7507.361874240642, 7550.207228241065, 7559.659815308324, 5411.78352865881, 5448.782048718007, 5495.505404513613, 5562.7774889005605, 5627.493525582717, 8842.778930526789, 8855.3801233913, 8902.554872256233, 8948.955255223942, 8962.641494340154, 8133.633986470505, 8544.273736732448, 8588.05531391534, 8893.021767605687, 8920.643174272956, 6779.2542820288745, 7285.635718214174, 7355.080614923135, 7523.699052037857, 7560.621968901423, 7446.478746487694, 7558.622068896643, 7581.0, 7585.279398457358, 7612.238776122344, 6624.768133115318, 6828.897566536407, 6858.074159988338, 6975.023496710363, 6994.160700715946, 6499.122618446449, 6665.333466653296, 6678.532502724957, 6722.294159113223, 6936.930630693831, 6577.112089867998, 6643.40209381158, 6713.1944166700305, 6722.19333679942, 6757.594544327356, 4712.7643617818285, 4717.740524271198, 4794.856154315376, 4820.276958456259, 4849.2726091086615, 4760.404949381327, 4839.467658557626, 4943.209086546135, 4984.700917944935, 4994.0], "value": 4249.510233022899, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [310.59312300885836, 318.0680605824932, 320.77064898597513, 323.40816306159735, 326.22033340316665, 5428.864278393037, 5507.614466987303, 5514.5864060195445, 5517.117261238198, 5540.584456165789, 5424.728763561816, 5427.891442171154, 5440.211169380437, 5442.564594832414, 5454.127339625661, 4016.7991600419937, 4090.2228576570506, 4179.979100104495, 4180.101278225181, 4220.0, 4152.190322887038, 4162.812673429703, 4217.388478670591, 4224.30299000666, 4224.61978421942, 4187.120704652027, 4192.895177620553, 4205.810738516774, 4206.47419072616, 4211.347241177622, 4114.40341150533, 4204.642605378546, 4206.957930420687, 4209.726367786115, 4234.364845273203, 3712.795796231206, 3716.888493345204, 3725.497057897176, 3726.5341832270965, 3726.9440958385644, 5188.688678679291, 5210.192420174841, 5219.164933610604, 5229.398619158769, 5234.8691282717855, 4734.360861283717, 4833.371661683994, 4840.080384726891, 4868.537488938545, 4877.292792545061, 5680.147977803321, 5681.119426488901, 5702.5723070769445, 5706.172604972297, 5712.457316554921, 4087.1621317629815, 4091.161311931047, 4099.139180772041, 4103.384492326145, 4106.466159399259, 5606.495415412592, 5914.378990206053, 5918.437748413894, 5988.431099045583, 6003.489703375175, 4045.474088368552, 4060.837566497307, 4066.837326506966, 4070.470838790938, 4078.7144899857317, 4124.587541245852, 4124.979375103106, 4127.669786417079, 4129.91740165195, 4148.688848336326, 4573.6569757268335, 4758.881027974328, 4761.833335833229, 4773.331733557305, 4882.707037577757, 5655.6606603603095, 5698.2592263005545, 5711.400302968212, 5737.512311453574, 5765.682887441147, 1475.8745506631842, 1491.4779827060443, 1496.865282124614, 1504.292982298318, 1513.5081098642765, 946.5030858799186, 989.9653512127041, 993.7664648807524, 1015.5125539740966, 1046.4453839465095, 4775.785089670903, 4820.758962051884, 4863.683860549053, 4868.0, 4876.268559716071, 5803.82588522345, 5828.562857785599, 5837.7157025454335, 5843.853903652443, 5849.2103566018895, 4732.479427262998, 4840.975795121002, 4856.757162141878, 4859.392575928009, 4964.90070198594, 3159.984200078985, 3179.459491886385, 3185.394774992744, 3190.9042728718177, 3195.3769015041844, 5528.391876893538, 5534.584906132056, 5551.111822108443, 5551.611387202938, 5583.106702927512, 5932.79235226765, 6029.427204415573, 6053.51571874249, 6074.331823499411, 6091.48222401092, 5487.067198576252, 5501.394846566955, 5517.586181036439, 5524.861878453071, 5560.91658625129, 5727.4845263926445, 5861.413858614104, 5888.793892213752, 5911.615744976562, 5928.911066334094, 5833.0, 5845.766169353348, 5847.853803654943, 5860.267466566679, 5863.794767183128, 5493.862653433696, 5524.33707955048, 5547.1679248113105, 5551.278333816578, 5551.306086739158, 3943.9014024649614, 4015.9598404015587, 4043.757374557536, 4055.1078762672164, 4064.1058967027207, 5916.7041647918295, 5919.289685237799, 5922.2597175353085, 5929.733162007807, 5942.465178133989, 5715.485606295453, 5719.170720245458, 5737.512311453574, 5741.885162296647, 5756.798512052058, 5454.918176227439, 5766.0, 5768.480836724715, 5771.7114144293455, 5785.4214578541805, 5316.308879845596, 5628.971855140698, 5634.295713035871, 5635.436456354331, 5639.548836093185, 5589.80435684749, 5783.884322313446, 5784.595078344475, 5811.215485909348, 5811.854703632274, 5551.225166886556, 5614.24207731951, 5614.522765564972, 5614.943850561605, 5615.0], "value": 4282.845510957566, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [657.4017643944011, 678.6708446403496, 712.579578048951, 736.8489459660764, 748.2405358561061, 10490.527926243318, 10544.314619549743, 11063.059639930605, 11262.155338349636, 11399.3730344831, 13371.799423008662, 13461.865381346184, 13475.124116932393, 13512.729745405086, 13528.864711352884, 822.9711960081383, 827.0, 830.4809494066209, 832.7918020494876, 836.6277006732007, 815.1725998111921, 815.3232816762103, 817.513579420244, 817.7955511122219, 822.1901427094307, 855.3499340501232, 859.6561375449838, 863.3999370437548, 864.394923553512, 866.8309679612478, 838.3460900497591, 838.4131108224267, 841.7685136587427, 844.9281811046069, 853.9871901921445, 615.9753609855601, 617.9536534759866, 620.5780069552702, 620.8913440147955, 624.1044101714054, 11335.036521895649, 11626.651200463999, 11765.235259708092, 11770.764584708259, 11875.703107422383, 12442.564510242099, 12527.686807829787, 12741.17182383142, 12762.0, 12915.612531624067, 10006.89993100067, 10077.0, 10100.545475453622, 10278.640247591373, 10337.0696637303, 3377.9493307600405, 3404.710599599037, 3447.9482807757654, 3456.7753096048928, 3529.0471572675233, 41353.793231033655, 44469.55530444686, 44559.77720111411, 48574.0, 48984.265236021485, 10462.372257664565, 10490.42302673345, 10553.525091370906, 10602.0544841631, 10719.249652524404, 18452.0, 18499.260029598667, 18515.259389624534, 18527.351542695942, 18563.628727425377, 7012.423624243716, 7365.668544915492, 7431.368333691588, 7439.479236453504, 7457.552546847207, 3963.1677347757295, 4010.7794071325775, 4022.235775202702, 4071.2671719090254, 4079.143379890197, 2893.5804308375587, 2927.4437856807563, 2950.9114726558237, 2956.187048561663, 2959.4525012872687, 530.7187190788889, 533.9385970613429, 546.2243614068033, 547.7124509632475, 549.9422560631076, 536.9006733754268, 571.6220522625856, 611.6116266171014, 620.2123303404651, 623.7536173211556, 7701.0, 7962.562059086806, 8072.425876953937, 8269.000168472021, 8347.332213422911, 494.36967865970456, 572.1478430026316, 578.5776383240258, 579.1775678536488, 631.5863109663178, 3891.338472459632, 3982.123932734794, 4003.479547658844, 4036.3138266494766, 4080.836766529365, 44944.77527612341, 44969.55030449654, 45040.77479612581, 46498.302525462146, 54026.729866351205, 34813.0, 34887.0, 35041.0, 41822.79088604599, 42837.14325713468, 34986.65013349834, 35118.29763404769, 36654.450183247274, 38997.805010974764, 39331.606683933365, 8137.389695772722, 8171.101178870438, 8176.7955801105445, 8267.462614930251, 8818.779530511532, 26998.46003079888, 27175.72824271732, 27486.587701184097, 27566.5865012021, 27576.483293419056, 29293.0, 31818.090914545202, 36917.0, 37046.62953370432, 37419.62580374161, 10878.94560527224, 10879.619213327496, 10928.235023548275, 10929.18031147683, 11310.095192384753, 11615.941920290345, 11809.763804723685, 12013.279203247834, 12061.456748896268, 12205.87794122083, 10861.076808471369, 11073.446327683745, 11226.438678066228, 11942.16404851652, 12011.0, 10497.790044199226, 10509.842352364567, 10919.12646988223, 10969.396683182502, 11003.61487347939, 7589.886151707618, 7589.924100759143, 7855.60721963888, 7899.368050556057, 8157.877631835646, 9594.328397012143, 9691.176250018827, 9922.454265015493, 9931.453770042717, 9939.353941994037, 9415.387999779992, 9501.144896959308, 9636.566354513923, 9637.37357071788, 9672.468014259282], "value": 5870.535274298125, "unit": "score"}], "name": "dromaeo_css", "value": 6337.627243259355, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 109.0, 113.0, 117.0, 115.0, 127.0, 115.0, 116.0, 114.0, 115.0], "value": 115.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 132.0, 152.0, 186.0, 137.0, 161.0, 159.0, 133.0, 183.0, 135.0], "value": 154.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 167.0, 168.0, 167.0, 162.0, 162.0, 162.0, 165.0, 163.0], "value": 164.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 74.0, 76.0, 156.0, 76.0, 75.0, 73.0, 73.0, 152.0, 74.0], "value": 90.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 152.0, 95.0, 95.0, 95.0, 139.0, 95.0, 97.0, 143.0], "value": 110.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 117.0, 117.0, 118.0, 118.0, 118.0, 118.0, 118.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 148.0, 147.0, 146.0, 148.0, 147.0, 148.0, 148.0, 149.0], "value": 147.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 96.0, 97.0, 95.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 68.0, 67.0, 67.0, 67.0, 67.0, 67.0, 68.0, 67.0], "value": 67.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 65.0, 66.0, 66.0, 67.0, 66.0, 65.0, 65.0, 65.0], "value": 65.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 78.0, 78.0, 79.0, 80.0, 80.0, 80.0, 80.0, 113.0, 88.0], "value": 83.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 137.0, 137.0, 141.0, 138.0, 147.0, 143.0, 146.0, 138.0, 143.0], "value": 141.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 171.0, 173.0, 172.0, 173.0, 174.0, 179.0, 176.0, 173.0, 174.0], "value": 173.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 75.0, 75.0, 74.0, 72.0, 72.0, 72.0, 72.0, 74.0], "value": 73.4, "unit": "score"}], "name": "kraken", "value": 1600.1000000000001, "alertThreshold": 2.0}]} 03:47:02 INFO - Return code: 0 03:47:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:47:02 ERROR - # TBPL SUCCESS # 03:47:02 INFO - Running post-action listener: _resource_record_post_action 03:47:02 INFO - Running post-run listener: _resource_record_post_run 03:47:03 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 4096; Write bytes: 518692864; Read time: 4; Write time: 445632 03:47:03 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 234758144; Read time: 0; Write time: 273344 03:47:03 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 4096; Write bytes: 283934720; Read time: 4; Write time: 172288 03:47:03 INFO - Running post-run listener: _upload_blobber_files 03:47:03 INFO - Blob upload gear active. 03:47:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:47:03 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 03:47:03 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'] 03:47:03 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 03:47:03 INFO - (blobuploader) - INFO - Open directory for files ... 03:47:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:47:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:47:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:47:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:47:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:47:04 INFO - (blobuploader) - INFO - Done attempting. 03:47:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:47:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:47:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:47:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:47:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:47:05 INFO - (blobuploader) - INFO - Done attempting. 03:47:05 INFO - (blobuploader) - INFO - Iteration through files over. 03:47:05 INFO - Return code: 0 03:47:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:47:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:47:05 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ef40505b28f9a4217335c3ba7bbc4df0f4495e5abf244e7e4ce7524c9f715edd9adb34e694644516c53fd0bdeebbc8e264a76230400e46c7880fde34aa6347f7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4a75d77f96e225acacb9786deff89742a8f6f3b7b2794b168205c5674e6d7978b1a607dc322fa22891b203931d4a4dd9a2f73c46c5481dc0aedfbb8639795706"} 03:47:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:47:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:47:05 INFO - Contents: 03:47:05 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ef40505b28f9a4217335c3ba7bbc4df0f4495e5abf244e7e4ce7524c9f715edd9adb34e694644516c53fd0bdeebbc8e264a76230400e46c7880fde34aa6347f7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4a75d77f96e225acacb9786deff89742a8f6f3b7b2794b168205c5674e6d7978b1a607dc322fa22891b203931d4a4dd9a2f73c46c5481dc0aedfbb8639795706"} 03:47:05 INFO - Running post-run listener: copy_logs_to_upload_dir 03:47:05 INFO - Copying logs to upload dir... 03:47:05 INFO - mkdir: /builds/slave/test/build/upload/logs 03:47:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.006222 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-04-23 03:47:04.139151) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-23 03:47:04.143079) ========= 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=523ca41ca1e0623de333ad52000001bf-1461406961.573527-667212725 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/ef40505b28f9a4217335c3ba7bbc4df0f4495e5abf244e7e4ce7524c9f715edd9adb34e694644516c53fd0bdeebbc8e264a76230400e46c7880fde34aa6347f7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4a75d77f96e225acacb9786deff89742a8f6f3b7b2794b168205c5674e6d7978b1a607dc322fa22891b203931d4a4dd9a2f73c46c5481dc0aedfbb8639795706"} build_url:https://queue.taskcluster.net/v1/task/FvIk4Y5qTbu7jFUuU9ikjA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011391 build_url: 'https://queue.taskcluster.net/v1/task/FvIk4Y5qTbu7jFUuU9ikjA/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/ef40505b28f9a4217335c3ba7bbc4df0f4495e5abf244e7e4ce7524c9f715edd9adb34e694644516c53fd0bdeebbc8e264a76230400e46c7880fde34aa6347f7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4a75d77f96e225acacb9786deff89742a8f6f3b7b2794b168205c5674e6d7978b1a607dc322fa22891b203931d4a4dd9a2f73c46c5481dc0aedfbb8639795706"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-23 03:47:04.171050) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 03:47:04.171815) ========= 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=523ca41ca1e0623de333ad52000001bf-1461406961.573527-667212725 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004473 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 03:47:04.255153) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-23 03:47:04.255867) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-23 03:47:04.256373) ========= ========= Total master_lag: 0.17 =========