builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-062 starttime: 1462511673.1 results: success (0) buildid: 20160505214925 builduid: ef0313fd05754ae5aad901b1a73f6cf6 revision: 8fd42cc5e8c4595c1d9d3fd67f30aef8f9e3bc5c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-05 22:14:33.102588) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-05 22:14:33.102984) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-05 22:14:33.103261) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-05 22:14:33.175704) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 22:14:33.175990) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1462510044.673532-1926271636 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-05 22:14:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 113M=0s 2016-05-05 22:14:33 (113 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.103812 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 22:14:33.296315) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 22:14:33.297195) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1462510044.673532-1926271636 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022698 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 22:14:33.353857) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 22:14:33.354568) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 8fd42cc5e8c4595c1d9d3fd67f30aef8f9e3bc5c --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 8fd42cc5e8c4595c1d9d3fd67f30aef8f9e3bc5c --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=a4ce256d2ec601f24a60a71e000001bc-1462510044.673532-1926271636 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-05 22:14:33,781 truncating revision to first 12 chars 2016-05-05 22:14:33,781 Setting DEBUG logging. 2016-05-05 22:14:33,781 attempt 1/10 2016-05-05 22:14:33,781 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/8fd42cc5e8c4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-05 22:14:34,042 unpacking tar archive at: fx-team-8fd42cc5e8c4/testing/mozharness/ program finished with exit code 0 elapsedTime=0.525599 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 22:14:33.894716) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-05 22:14:33.895048) ========= script_repo_revision: 8fd42cc5e8c4595c1d9d3fd67f30aef8f9e3bc5c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-05 22:14:33.895468) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-05 22:14:33.895755) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-05 22:14:33.905897) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-05-05 22:14:33.906152) ========= /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=a4ce256d2ec601f24a60a71e000001bc-1462510044.673532-1926271636 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:14:34 INFO - MultiFileLogger online at 20160505 22:14:34 in /builds/slave/test 22:14:34 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 22:14:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:14:34 INFO - {'append_to_log': False, 22:14:34 INFO - 'base_work_dir': '/builds/slave/test', 22:14:34 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 22:14:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:14:34 INFO - 'branch': 'Fx-Team-Non-PGO', 22:14:34 INFO - 'buildbot_json_path': 'buildprops.json', 22:14:34 INFO - 'config_files': ('talos/linux_config.py',), 22:14:34 INFO - 'default_actions': ('clobber', 22:14:34 INFO - 'read-buildbot-config', 22:14:34 INFO - 'download-and-extract', 22:14:34 INFO - 'populate-webroot', 22:14:34 INFO - 'create-virtualenv', 22:14:34 INFO - 'install', 22:14:34 INFO - 'run-tests'), 22:14:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:14:34 INFO - 'download_minidump_stackwalk': True, 22:14:34 INFO - 'download_symbols': 'ondemand', 22:14:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:14:34 INFO - 'tooltool.py': '/tools/tooltool.py', 22:14:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:14:34 INFO - '/tools/misc-python/virtualenv.py')}, 22:14:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:14:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:14:34 INFO - 'installer_path': 'installer.exe', 22:14:34 INFO - 'log_level': 'info', 22:14:34 INFO - 'log_name': 'talos', 22:14:34 INFO - 'log_to_console': True, 22:14:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:14:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:14:34 INFO - 'opt_config_files': (), 22:14:34 INFO - 'pip_index': False, 22:14:34 INFO - 'sps_profile': False, 22:14:34 INFO - 'sps_profile_interval': 0, 22:14:34 INFO - 'suite': 'dromaeojs-e10s', 22:14:34 INFO - 'system_bits': '32', 22:14:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:14:34 INFO - 'title': 'talos-linux64-ix-062', 22:14:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:14:34 INFO - 'use_talos_json': True, 22:14:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:14:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:14:34 INFO - 'work_dir': 'build'} 22:14:34 INFO - ##### 22:14:34 INFO - ##### Running clobber step. 22:14:34 INFO - ##### 22:14:34 INFO - Running pre-action listener: _resource_record_pre_action 22:14:34 INFO - Running main action method: clobber 22:14:34 INFO - rmtree: /builds/slave/test/build 22:14:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:14:34 INFO - Running post-action listener: _resource_record_post_action 22:14:34 INFO - ##### 22:14:34 INFO - ##### Running read-buildbot-config step. 22:14:34 INFO - ##### 22:14:34 INFO - Running pre-action listener: _resource_record_pre_action 22:14:34 INFO - Running main action method: read_buildbot_config 22:14:34 INFO - Using buildbot properties: 22:14:34 INFO - { 22:14:34 INFO - "project": "", 22:14:34 INFO - "product": "firefox", 22:14:34 INFO - "script_repo_revision": "production", 22:14:34 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 22:14:34 INFO - "repository": "", 22:14:34 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 22:14:34 INFO - "buildid": "20160505214925", 22:14:34 INFO - "pgo_build": "False", 22:14:34 INFO - "basedir": "/builds/slave/test", 22:14:34 INFO - "buildnumber": 1252, 22:14:34 INFO - "slavename": "talos-linux64-ix-062", 22:14:34 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 22:14:34 INFO - "platform": "ubuntu64_hw", 22:14:34 INFO - "scheduler": "tests-fx-team-linux64-talos", 22:14:34 INFO - "branch": "fx-team", 22:14:34 INFO - "repo_path": "integration/fx-team", 22:14:34 INFO - "revision": "8fd42cc5e8c4595c1d9d3fd67f30aef8f9e3bc5c", 22:14:34 INFO - "stage_platform": "linux64", 22:14:34 INFO - "builduid": "ef0313fd05754ae5aad901b1a73f6cf6", 22:14:34 INFO - "slavebuilddir": "test" 22:14:34 INFO - } 22:14:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/Xea2NRyzQOeIuXv9TlRWKQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 22:14:34 INFO - Running post-action listener: _resource_record_post_action 22:14:34 INFO - ##### 22:14:34 INFO - ##### Running download-and-extract step. 22:14:34 INFO - ##### 22:14:34 INFO - Running pre-action listener: _resource_record_pre_action 22:14:34 INFO - Running main action method: download_and_extract 22:14:34 INFO - mkdir: /builds/slave/test/build/tests 22:14: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')]} 22:14:34 INFO - https://queue.taskcluster.net/v1/task/Xea2NRyzQOeIuXv9TlRWKQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 22:14:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xea2NRyzQOeIuXv9TlRWKQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 22:14:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xea2NRyzQOeIuXv9TlRWKQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 22:14:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xea2NRyzQOeIuXv9TlRWKQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 22:14:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xea2NRyzQOeIuXv9TlRWKQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 22:14:37 INFO - Downloaded 1361 bytes. 22:14:37 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 22:14:37 INFO - Using the following test package requirements: 22:14:37 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 22:14:37 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 22:14:37 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:14:37 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 22:14:37 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:14:37 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 22:14:37 INFO - u'jsshell-linux-x86_64.zip'], 22:14:37 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 22:14:37 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:14:37 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 22:14:37 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 22:14:37 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:14:37 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 22:14:37 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:14:37 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 22:14:37 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:14:37 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 22:14:37 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:14:37 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:14: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')]} 22:14:37 INFO - https://queue.taskcluster.net/v1/task/Xea2NRyzQOeIuXv9TlRWKQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:14:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xea2NRyzQOeIuXv9TlRWKQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 22:14:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xea2NRyzQOeIuXv9TlRWKQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 22:14:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xea2NRyzQOeIuXv9TlRWKQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 22:14:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xea2NRyzQOeIuXv9TlRWKQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:14:38 INFO - Downloaded 22321773 bytes. 22:14:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:14:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 22:14:39 INFO - Return code: 0 22:14:39 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 22:14: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')]} 22:14:39 INFO - https://queue.taskcluster.net/v1/task/Xea2NRyzQOeIuXv9TlRWKQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:14:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xea2NRyzQOeIuXv9TlRWKQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 22:14:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xea2NRyzQOeIuXv9TlRWKQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 22:14:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xea2NRyzQOeIuXv9TlRWKQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 22:14:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xea2NRyzQOeIuXv9TlRWKQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:14:42 INFO - Downloaded 22321773 bytes. 22:14:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:14:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 22:14:43 INFO - Return code: 0 22:14:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:14:43 INFO - https://queue.taskcluster.net/v1/task/Xea2NRyzQOeIuXv9TlRWKQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:14:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xea2NRyzQOeIuXv9TlRWKQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 22:14:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xea2NRyzQOeIuXv9TlRWKQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 22:14:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xea2NRyzQOeIuXv9TlRWKQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 22:14:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xea2NRyzQOeIuXv9TlRWKQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 22:14:45 INFO - Downloaded 10840152 bytes. 22:14:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:14:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 22:14:45 INFO - Return code: 0 22:14:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:14:45 INFO - https://queue.taskcluster.net/v1/task/Xea2NRyzQOeIuXv9TlRWKQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:14:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xea2NRyzQOeIuXv9TlRWKQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 22:14:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xea2NRyzQOeIuXv9TlRWKQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 22:14:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xea2NRyzQOeIuXv9TlRWKQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 22:14:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xea2NRyzQOeIuXv9TlRWKQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 22:14:46 INFO - Downloaded 54835680 bytes. 22:14:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Xea2NRyzQOeIuXv9TlRWKQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 22:14:46 INFO - mkdir: /builds/slave/test/properties 22:14:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:14:46 INFO - Writing to file /builds/slave/test/properties/build_url 22:14:46 INFO - Contents: 22:14:46 INFO - build_url:https://queue.taskcluster.net/v1/task/Xea2NRyzQOeIuXv9TlRWKQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 22:14:47 INFO - Running post-action listener: _resource_record_post_action 22:14:47 INFO - Running post-action listener: set_extra_try_arguments 22:14:47 INFO - ##### 22:14:47 INFO - ##### Running populate-webroot step. 22:14:47 INFO - ##### 22:14:47 INFO - Running pre-action listener: _resource_record_pre_action 22:14:47 INFO - Running main action method: populate_webroot 22:14:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:14:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:14:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:14:47 INFO - '--tppagecycles', 22:14:47 INFO - '7'], 22:14:47 INFO - 'tests': ['tsvgm']}}, 22:14:47 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:14:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:14:47 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:14:47 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:14:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:14:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:14:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:14:47 INFO - 'talos_options': ['--disable-e10s'], 22:14:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:14:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:14:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:14:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:14:47 INFO - 'talos_options': ['--disable-e10s'], 22:14:47 INFO - 'tests': ['damp', 'tps']}, 22:14:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:14:47 INFO - 'tests': ['damp', 'tps']}, 22:14:47 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:14:47 INFO - 'tests': ['dromaeo_dom']}, 22:14:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:14:47 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:14:47 INFO - 'tests': ['a11yr', 22:14:47 INFO - 'ts_paint', 22:14:47 INFO - 'tpaint', 22:14:47 INFO - 'sessionrestore', 22:14:47 INFO - 'sessionrestore_no_auto_restore', 22:14:47 INFO - 'tabpaint']}, 22:14:47 INFO - 'other-e10s': {'tests': ['a11yr', 22:14:47 INFO - 'ts_paint', 22:14:47 INFO - 'tpaint', 22:14:47 INFO - 'sessionrestore', 22:14:47 INFO - 'sessionrestore_no_auto_restore', 22:14:47 INFO - 'tabpaint']}, 22:14:47 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:14:47 INFO - 'ts_paint', 22:14:47 INFO - 'tpaint', 22:14:47 INFO - 'sessionrestore', 22:14:47 INFO - 'sessionrestore_no_auto_restore', 22:14:47 INFO - 'tabpaint']}, 22:14:47 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:14:47 INFO - 'ts_paint', 22:14:47 INFO - 'tpaint', 22:14:47 INFO - 'sessionrestore', 22:14:47 INFO - 'sessionrestore_no_auto_restore', 22:14:47 INFO - 'tabpaint']}, 22:14:47 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:14:47 INFO - 'tests': ['a11yr', 22:14:47 INFO - 'ts_paint', 22:14:47 INFO - 'tpaint', 22:14:47 INFO - 'sessionrestore', 22:14:47 INFO - 'sessionrestore_no_auto_restore', 22:14:47 INFO - 'tabpaint']}, 22:14:47 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:14:47 INFO - 'tests': ['a11yr', 22:14:47 INFO - 'ts_paint', 22:14:47 INFO - 'tpaint', 22:14:47 INFO - 'sessionrestore', 22:14:47 INFO - 'sessionrestore_no_auto_restore', 22:14:47 INFO - 'tabpaint']}, 22:14:47 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:14:47 INFO - 'tests': ['tsvgx', 22:14:47 INFO - 'tsvgr_opacity', 22:14:47 INFO - 'tart', 22:14:47 INFO - 'tscrollx', 22:14:47 INFO - 'cart']}, 22:14:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:14:47 INFO - 'tsvgr_opacity', 22:14:47 INFO - 'tart', 22:14:47 INFO - 'tscrollx', 22:14:47 INFO - 'cart']}, 22:14:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:14:47 INFO - 'talos_options': ['--disable-e10s'], 22:14:47 INFO - 'tests': ['tp5o']}, 22:14:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:14:47 INFO - 'tests': ['tp5o']}, 22:14:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:14:47 INFO - 'talos_options': ['--disable-e10s', 22:14:47 INFO - '--xperf_path', 22:14:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:14:47 INFO - 'tests': ['tp5n']}, 22:14:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:14:47 INFO - 'talos_options': ['--xperf_path', 22:14:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:14:47 INFO - 'tests': ['tp5n']}}, 22:14:47 INFO - 'talos.zip': {'path': '', 22:14:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:14:47 INFO - Running post-action listener: _resource_record_post_action 22:14:47 INFO - ##### 22:14:47 INFO - ##### Running create-virtualenv step. 22:14:47 INFO - ##### 22:14:47 INFO - Running pre-action listener: _resource_record_pre_action 22:14:47 INFO - Running main action method: create_virtualenv 22:14:47 INFO - Creating virtualenv /builds/slave/test/build/venv 22:14:47 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 22:14:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:14:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:14:47 INFO - Using real prefix '/usr' 22:14:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:14:47 INFO - Installing distribute.............................................................................................................................................................................................done. 22:14:49 INFO - Installing pip.................done. 22:14:49 INFO - Return code: 0 22:14:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:14: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')]} 22:14:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:14:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:14: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')]} 22:14:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:14:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:14: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffc21cc9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11a55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1234410>, '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 0x1235310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12357a0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1462510044.673532-1926271636', '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 22:14: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', 'pip>=1.5'] in /builds/slave/test/build 22:14: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 pip>=1.5 22:14:49 INFO - Using env: {'DISPLAY': ':0', 22:14:49 INFO - 'HOME': '/home/cltbld', 22:14:49 INFO - 'LANG': 'en_US.UTF-8', 22:14:49 INFO - 'LANGUAGE': 'en_US:en', 22:14:49 INFO - 'LOGNAME': 'cltbld', 22:14:49 INFO - 'MAIL': '/var/mail/cltbld', 22:14:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:14:49 INFO - 'MOZ_NO_REMOTE': '1', 22:14:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:14:49 INFO - 'NO_EM_RESTART': '1', 22:14:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:14:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:14:49 INFO - 'PWD': '/builds/slave/test', 22:14:49 INFO - 'SHELL': '/bin/bash', 22:14:49 INFO - 'SHLVL': '1', 22:14:49 INFO - 'TERM': 'linux', 22:14:49 INFO - 'TMOUT': '86400', 22:14:49 INFO - 'USER': 'cltbld', 22:14:49 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1462510044.673532-1926271636', 22:14:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:14:49 INFO - '_': '/tools/buildbot/bin/python'} 22:14:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:14:50 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 22:14:50 INFO - Cleaning up... 22:14:50 INFO - Return code: 0 22:14:50 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 22:14:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:14:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:14:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:14:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:14:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:14:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:14:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ffc21cc9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11a55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1234410>, '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 0x1235310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12357a0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1462510044.673532-1926271636', '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 22:14:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 22:14:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 22:14:50 INFO - Using env: {'DISPLAY': ':0', 22:14:50 INFO - 'HOME': '/home/cltbld', 22:14:50 INFO - 'LANG': 'en_US.UTF-8', 22:14:50 INFO - 'LANGUAGE': 'en_US:en', 22:14:50 INFO - 'LOGNAME': 'cltbld', 22:14:50 INFO - 'MAIL': '/var/mail/cltbld', 22:14:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:14:50 INFO - 'MOZ_NO_REMOTE': '1', 22:14:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:14:50 INFO - 'NO_EM_RESTART': '1', 22:14:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:14:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:14:50 INFO - 'PWD': '/builds/slave/test', 22:14:50 INFO - 'SHELL': '/bin/bash', 22:14:50 INFO - 'SHLVL': '1', 22:14:50 INFO - 'TERM': 'linux', 22:14:50 INFO - 'TMOUT': '86400', 22:14:50 INFO - 'USER': 'cltbld', 22:14:50 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1462510044.673532-1926271636', 22:14:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:14:50 INFO - '_': '/tools/buildbot/bin/python'} 22:14:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:14:50 INFO - Downloading/unpacking psutil>=0.7.1 22:14:50 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 22:14:50 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 22:14:50 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 22:14:50 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 22:14:50 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 22:14:50 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 22:14:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:14:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:14:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:14:52 INFO - Installing collected packages: psutil 22:14:52 INFO - Running setup.py install for psutil 22:14:52 INFO - building 'psutil._psutil_linux' extension 22:14:52 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 22:14:52 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 22:14:52 INFO - building 'psutil._psutil_posix' extension 22:14:52 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 22:14:52 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 22:14:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:14:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:14:52 INFO - Successfully installed psutil 22:14:52 INFO - Cleaning up... 22:14:52 INFO - Return code: 0 22:14:52 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 22:14:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:14:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:14:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:14:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:14:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:14:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:14:52 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 0x7ffc21cc9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11a55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1234410>, '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 0x1235310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12357a0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1462510044.673532-1926271636', '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 22:14:52 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 22:14:52 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 22:14:52 INFO - Using env: {'DISPLAY': ':0', 22:14:52 INFO - 'HOME': '/home/cltbld', 22:14:52 INFO - 'LANG': 'en_US.UTF-8', 22:14:52 INFO - 'LANGUAGE': 'en_US:en', 22:14:52 INFO - 'LOGNAME': 'cltbld', 22:14:52 INFO - 'MAIL': '/var/mail/cltbld', 22:14:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:14:52 INFO - 'MOZ_NO_REMOTE': '1', 22:14:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:14:52 INFO - 'NO_EM_RESTART': '1', 22:14:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:14:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:14:52 INFO - 'PWD': '/builds/slave/test', 22:14:52 INFO - 'SHELL': '/bin/bash', 22:14:52 INFO - 'SHLVL': '1', 22:14:52 INFO - 'TERM': 'linux', 22:14:52 INFO - 'TMOUT': '86400', 22:14:52 INFO - 'USER': 'cltbld', 22:14:52 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1462510044.673532-1926271636', 22:14:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:14:52 INFO - '_': '/tools/buildbot/bin/python'} 22:14:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:14:53 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:14:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:14:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:14:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:14:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:14:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:14:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:14:54 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:14:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:14:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 22:14:54 INFO - Installing collected packages: mozsystemmonitor 22:14:54 INFO - Running setup.py install for mozsystemmonitor 22:14:55 INFO - Successfully installed mozsystemmonitor 22:14:55 INFO - Cleaning up... 22:14:55 INFO - Return code: 0 22:14:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:14:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:14:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:14:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:14:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:14:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:14:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:14:55 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 0x7ffc21cc9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11a55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1234410>, '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 0x1235310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12357a0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1462510044.673532-1926271636', '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 22:14:55 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 22:14:55 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 22:14:55 INFO - Using env: {'DISPLAY': ':0', 22:14:55 INFO - 'HOME': '/home/cltbld', 22:14:55 INFO - 'LANG': 'en_US.UTF-8', 22:14:55 INFO - 'LANGUAGE': 'en_US:en', 22:14:55 INFO - 'LOGNAME': 'cltbld', 22:14:55 INFO - 'MAIL': '/var/mail/cltbld', 22:14:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:14:55 INFO - 'MOZ_NO_REMOTE': '1', 22:14:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:14:55 INFO - 'NO_EM_RESTART': '1', 22:14:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:14:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:14:55 INFO - 'PWD': '/builds/slave/test', 22:14:55 INFO - 'SHELL': '/bin/bash', 22:14:55 INFO - 'SHLVL': '1', 22:14:55 INFO - 'TERM': 'linux', 22:14:55 INFO - 'TMOUT': '86400', 22:14:55 INFO - 'USER': 'cltbld', 22:14:55 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1462510044.673532-1926271636', 22:14:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:14:55 INFO - '_': '/tools/buildbot/bin/python'} 22:14:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:14:55 INFO - Downloading/unpacking blobuploader==1.2.4 22:14:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:14:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:14:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:14:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:14:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:14:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:14:57 INFO - Downloading blobuploader-1.2.4.tar.gz 22:14:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:14:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:14: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 22:14: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 22:14: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 22:14: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 22:14: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 22:14: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 22:14:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:14:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:14: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 22:14: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 22:14: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 22:14: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 22:14: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 22:14: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 22:14:57 INFO - Downloading docopt-0.6.1.tar.gz 22:14:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:14:57 INFO - Installing collected packages: blobuploader, requests, docopt 22:14:57 INFO - Running setup.py install for blobuploader 22:14:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:14:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:14:58 INFO - Running setup.py install for requests 22:14:58 INFO - Running setup.py install for docopt 22:14:58 INFO - Successfully installed blobuploader requests docopt 22:14:58 INFO - Cleaning up... 22:14:58 INFO - Return code: 0 22:14:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:14:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:14:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:14:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:14:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:14:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:14:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:14:58 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 0x7ffc21cc9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11a55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1234410>, '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 0x1235310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12357a0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1462510044.673532-1926271636', '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 22:14:58 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 22:14:58 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 22:14:58 INFO - Using env: {'DISPLAY': ':0', 22:14:58 INFO - 'HOME': '/home/cltbld', 22:14:58 INFO - 'LANG': 'en_US.UTF-8', 22:14:58 INFO - 'LANGUAGE': 'en_US:en', 22:14:58 INFO - 'LOGNAME': 'cltbld', 22:14:58 INFO - 'MAIL': '/var/mail/cltbld', 22:14:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:14:58 INFO - 'MOZ_NO_REMOTE': '1', 22:14:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:14:58 INFO - 'NO_EM_RESTART': '1', 22:14:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:14:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:14:58 INFO - 'PWD': '/builds/slave/test', 22:14:58 INFO - 'SHELL': '/bin/bash', 22:14:58 INFO - 'SHLVL': '1', 22:14:58 INFO - 'TERM': 'linux', 22:14:58 INFO - 'TMOUT': '86400', 22:14:58 INFO - 'USER': 'cltbld', 22:14:58 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1462510044.673532-1926271636', 22:14:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:14:58 INFO - '_': '/tools/buildbot/bin/python'} 22:14:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:14:58 INFO - Running setup.py (path:/tmp/pip-AVOjFn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:14:58 INFO - Running setup.py (path:/tmp/pip-jAzqqa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:14:58 INFO - Running setup.py (path:/tmp/pip-Fy4gNv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:14:58 INFO - Running setup.py (path:/tmp/pip-nY5MqE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:14:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:14:59 INFO - Running setup.py (path:/tmp/pip-8umNBY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:14:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:14:59 INFO - Running setup.py (path:/tmp/pip-qfJplW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:14:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:14:59 INFO - Running setup.py (path:/tmp/pip-KVWK7n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:14:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:14:59 INFO - Running setup.py (path:/tmp/pip-QWBZrt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:14:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:14:59 INFO - Running setup.py (path:/tmp/pip-HFY9tX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:14:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:14:59 INFO - Running setup.py (path:/tmp/pip-4AKkLi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:14:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:14:59 INFO - Running setup.py (path:/tmp/pip-Ilr8dy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:14:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:14:59 INFO - Running setup.py (path:/tmp/pip-HQDZUf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:14:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:14:59 INFO - Running setup.py (path:/tmp/pip-LUkE8v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:14:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:14:59 INFO - Running setup.py (path:/tmp/pip-rvsIBN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:14:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:14:59 INFO - Running setup.py (path:/tmp/pip-h9ejET-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:14:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:14:59 INFO - Running setup.py (path:/tmp/pip-RAZC6R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:14:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:14:59 INFO - Running setup.py (path:/tmp/pip-pbEhkC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:15:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:15:00 INFO - Running setup.py install for manifestparser 22:15:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:15:00 INFO - Running setup.py install for mozcrash 22:15:00 INFO - Running setup.py install for mozdebug 22:15:00 INFO - Running setup.py install for mozdevice 22:15:00 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:15:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:15:00 INFO - Running setup.py install for mozfile 22:15:00 INFO - Running setup.py install for mozhttpd 22:15:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:15:00 INFO - Running setup.py install for mozinfo 22:15:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:15:00 INFO - Running setup.py install for mozInstall 22:15:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:15:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:15:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:15:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:15:00 INFO - Running setup.py install for mozleak 22:15:00 INFO - Running setup.py install for mozlog 22:15:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:15:01 INFO - Running setup.py install for moznetwork 22:15:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:15:01 INFO - Running setup.py install for mozprocess 22:15:01 INFO - Running setup.py install for mozprofile 22:15:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:15:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:15:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:15:01 INFO - Running setup.py install for mozrunner 22:15:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:15:01 INFO - Running setup.py install for mozscreenshot 22:15:01 INFO - Running setup.py install for moztest 22:15:01 INFO - Running setup.py install for mozversion 22:15:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:15:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:15:01 INFO - Cleaning up... 22:15:01 INFO - Return code: 0 22:15:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:15:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:15:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:15:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:15:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:15:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:15:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:15:01 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 0x7ffc21cc9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11a55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1234410>, '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 0x1235310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12357a0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1462510044.673532-1926271636', '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 22:15:01 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 22:15:01 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 22:15:01 INFO - Using env: {'DISPLAY': ':0', 22:15:01 INFO - 'HOME': '/home/cltbld', 22:15:01 INFO - 'LANG': 'en_US.UTF-8', 22:15:01 INFO - 'LANGUAGE': 'en_US:en', 22:15:01 INFO - 'LOGNAME': 'cltbld', 22:15:01 INFO - 'MAIL': '/var/mail/cltbld', 22:15:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:15:01 INFO - 'MOZ_NO_REMOTE': '1', 22:15:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:15:01 INFO - 'NO_EM_RESTART': '1', 22:15:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:15:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:15:01 INFO - 'PWD': '/builds/slave/test', 22:15:01 INFO - 'SHELL': '/bin/bash', 22:15:01 INFO - 'SHLVL': '1', 22:15:01 INFO - 'TERM': 'linux', 22:15:01 INFO - 'TMOUT': '86400', 22:15:01 INFO - 'USER': 'cltbld', 22:15:01 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1462510044.673532-1926271636', 22:15:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:15:01 INFO - '_': '/tools/buildbot/bin/python'} 22:15:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:15:02 INFO - Running setup.py (path:/tmp/pip-Yq4_Iq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:15:02 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)) 22:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:15:02 INFO - Running setup.py (path:/tmp/pip-NE5ZSm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:15:02 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)) 22:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:15:02 INFO - Running setup.py (path:/tmp/pip-dYJzOv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:15:02 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)) 22:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:15:02 INFO - Running setup.py (path:/tmp/pip-KcSzbj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:15:02 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)) 22:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:15:02 INFO - Running setup.py (path:/tmp/pip-c9nzN7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:15:02 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)) 22:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:15:02 INFO - Running setup.py (path:/tmp/pip-E87cKN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:15:02 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)) 22:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:15:02 INFO - Running setup.py (path:/tmp/pip-zvM34m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:15:02 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)) 22:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:15:02 INFO - Running setup.py (path:/tmp/pip-_0iatm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:15:02 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)) 22:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:15:02 INFO - Running setup.py (path:/tmp/pip-8KbqiE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:15:02 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)) 22:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:15:02 INFO - Running setup.py (path:/tmp/pip-Fc640R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:15:02 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)) 22:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:15:02 INFO - Running setup.py (path:/tmp/pip-9swRMh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:15:02 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)) 22:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:15:02 INFO - Running setup.py (path:/tmp/pip-1VPn6o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:15:02 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)) 22:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:15:02 INFO - Running setup.py (path:/tmp/pip-VQplEN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:15:02 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)) 22:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:15:02 INFO - Running setup.py (path:/tmp/pip-ljYjoF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:15:03 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)) 22:15:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:15:03 INFO - Running setup.py (path:/tmp/pip-3sYJD0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:15:03 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)) 22:15:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:15:03 INFO - Running setup.py (path:/tmp/pip-IvGYDM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:15:03 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)) 22:15:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:15:03 INFO - Running setup.py (path:/tmp/pip-iCsDlO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:15:03 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)) 22:15:03 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)) 22:15:03 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)) 22:15:03 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)) 22:15:03 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)) 22:15:03 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)) 22:15:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:15: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 22:15: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 22:15: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 22:15: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 22:15: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 22:15: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 22:15:05 INFO - Downloading blessings-1.6.tar.gz 22:15:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:15:05 INFO - Installing collected packages: blessings 22:15:05 INFO - Running setup.py install for blessings 22:15:05 INFO - Successfully installed blessings 22:15:05 INFO - Cleaning up... 22:15:05 INFO - Return code: 0 22:15:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:15:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:15:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:15:05 INFO - Reading from file tmpfile_stdout 22:15:05 INFO - Current package versions: 22:15:05 INFO - argparse == 1.2.1 22:15:05 INFO - blessings == 1.6 22:15:05 INFO - blobuploader == 1.2.4 22:15:05 INFO - docopt == 0.6.1 22:15:05 INFO - manifestparser == 1.1 22:15:05 INFO - mozInstall == 1.12 22:15:05 INFO - mozcrash == 0.17 22:15:05 INFO - mozdebug == 0.1 22:15:05 INFO - mozdevice == 0.48 22:15:05 INFO - mozfile == 1.2 22:15:05 INFO - mozhttpd == 0.7 22:15:05 INFO - mozinfo == 0.9 22:15:05 INFO - mozleak == 0.1 22:15:05 INFO - mozlog == 3.1 22:15:05 INFO - moznetwork == 0.27 22:15:05 INFO - mozprocess == 0.22 22:15:05 INFO - mozprofile == 0.28 22:15:05 INFO - mozrunner == 6.11 22:15:05 INFO - mozscreenshot == 0.1 22:15:05 INFO - mozsystemmonitor == 0.0 22:15:05 INFO - moztest == 0.7 22:15:05 INFO - mozversion == 1.4 22:15:05 INFO - psutil == 3.1.1 22:15:05 INFO - requests == 1.2.3 22:15:05 INFO - wsgiref == 0.1.2 22:15:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:15:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:15:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:15:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:15:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:15:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:15:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:15:05 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 0x7ffc21cc9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11a55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1234410>, '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 0x1235310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12357a0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1462510044.673532-1926271636', '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 22:15:05 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 22:15:05 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 22:15:05 INFO - Using env: {'DISPLAY': ':0', 22:15:05 INFO - 'HOME': '/home/cltbld', 22:15:05 INFO - 'LANG': 'en_US.UTF-8', 22:15:05 INFO - 'LANGUAGE': 'en_US:en', 22:15:05 INFO - 'LOGNAME': 'cltbld', 22:15:05 INFO - 'MAIL': '/var/mail/cltbld', 22:15:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:15:05 INFO - 'MOZ_NO_REMOTE': '1', 22:15:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:15:05 INFO - 'NO_EM_RESTART': '1', 22:15:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:15:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:15:05 INFO - 'PWD': '/builds/slave/test', 22:15:05 INFO - 'SHELL': '/bin/bash', 22:15:05 INFO - 'SHLVL': '1', 22:15:05 INFO - 'TERM': 'linux', 22:15:05 INFO - 'TMOUT': '86400', 22:15:05 INFO - 'USER': 'cltbld', 22:15:05 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1462510044.673532-1926271636', 22:15:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:15:05 INFO - '_': '/tools/buildbot/bin/python'} 22:15:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:15:05 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)) 22:15:05 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)) 22:15:05 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)) 22:15:05 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)) 22:15:05 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)) 22:15:05 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)) 22:15:05 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)) 22:15:05 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)) 22:15:05 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)) 22:15:05 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)) 22:15:05 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)) 22:15:05 INFO - Cleaning up... 22:15:05 INFO - Return code: 0 22:15:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:15:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:15:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:15:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:15:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:15:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:15:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:15:05 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 0x7ffc21cc9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11a55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1234410>, '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 0x1235310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12357a0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1462510044.673532-1926271636', '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 22:15:05 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 22:15:05 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 22:15:05 INFO - Using env: {'DISPLAY': ':0', 22:15:05 INFO - 'HOME': '/home/cltbld', 22:15:05 INFO - 'LANG': 'en_US.UTF-8', 22:15:05 INFO - 'LANGUAGE': 'en_US:en', 22:15:05 INFO - 'LOGNAME': 'cltbld', 22:15:05 INFO - 'MAIL': '/var/mail/cltbld', 22:15:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:15:05 INFO - 'MOZ_NO_REMOTE': '1', 22:15:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:15:05 INFO - 'NO_EM_RESTART': '1', 22:15:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:15:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:15:05 INFO - 'PWD': '/builds/slave/test', 22:15:05 INFO - 'SHELL': '/bin/bash', 22:15:05 INFO - 'SHLVL': '1', 22:15:05 INFO - 'TERM': 'linux', 22:15:05 INFO - 'TMOUT': '86400', 22:15:05 INFO - 'USER': 'cltbld', 22:15:05 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1462510044.673532-1926271636', 22:15:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:15:05 INFO - '_': '/tools/buildbot/bin/python'} 22:15:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:15:06 INFO - Downloading/unpacking jsonschema 22:15:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:15:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:15:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:15:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:15:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:15:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:15:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:15:07 INFO - Downloading/unpacking functools32 (from jsonschema) 22:15:07 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 22:15:07 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 22:15:07 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 22:15:07 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 22:15:07 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 22:15:07 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 22:15:08 INFO - Downloading functools32-3.2.3-2.tar.gz 22:15:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:15:08 INFO - warning: no files found matching '*.txt' 22:15:08 INFO - no previously-included directories found matching 'build' 22:15:08 INFO - no previously-included directories found matching 'dist' 22:15:08 INFO - no previously-included directories found matching '.git*' 22:15:08 INFO - Installing collected packages: jsonschema, functools32 22:15:08 INFO - Running setup.py install for functools32 22:15:08 INFO - warning: no files found matching '*.txt' 22:15:08 INFO - no previously-included directories found matching 'build' 22:15:08 INFO - no previously-included directories found matching 'dist' 22:15:08 INFO - no previously-included directories found matching '.git*' 22:15:08 INFO - Successfully installed jsonschema functools32 22:15:08 INFO - Cleaning up... 22:15:08 INFO - Return code: 0 22:15:08 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 22:15:08 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')]} 22:15:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:15:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:15:08 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')]} 22:15:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:15:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:15:08 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 0x7ffc21cc9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11a55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1234410>, '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 0x1235310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12357a0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1462510044.673532-1926271636', '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 22:15:08 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 22:15:08 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 22:15:08 INFO - Using env: {'DISPLAY': ':0', 22:15:08 INFO - 'HOME': '/home/cltbld', 22:15:08 INFO - 'LANG': 'en_US.UTF-8', 22:15:08 INFO - 'LANGUAGE': 'en_US:en', 22:15:08 INFO - 'LOGNAME': 'cltbld', 22:15:08 INFO - 'MAIL': '/var/mail/cltbld', 22:15:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:15:08 INFO - 'MOZ_NO_REMOTE': '1', 22:15:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:15:08 INFO - 'NO_EM_RESTART': '1', 22:15:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:15:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:15:08 INFO - 'PWD': '/builds/slave/test', 22:15:08 INFO - 'SHELL': '/bin/bash', 22:15:08 INFO - 'SHLVL': '1', 22:15:08 INFO - 'TERM': 'linux', 22:15:08 INFO - 'TMOUT': '86400', 22:15:08 INFO - 'USER': 'cltbld', 22:15:08 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1462510044.673532-1926271636', 22:15:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:15:08 INFO - '_': '/tools/buildbot/bin/python'} 22:15:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:15:08 INFO - Downloading/unpacking flake8 22:15:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:15:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:15:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:15:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:15:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:15:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:15:10 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:15:10 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:15:10 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 22:15:10 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 22:15:10 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 22:15:10 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 22:15:10 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 22:15:10 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 22:15:10 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:15:10 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:15:10 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 22:15:10 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 22:15:10 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 22:15:10 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 22:15:10 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 22:15:10 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 22:15:10 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:15:10 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 22:15:10 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 22:15:10 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 22:15:10 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 22:15:10 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 22:15:10 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 22:15:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 22:15:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:15:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:15:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:15:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:15:11 INFO - no previously-included directories found matching 'docs/_build' 22:15:11 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:15:11 INFO - Running setup.py install for pep8 22:15:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:15:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:15:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:15:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:15:11 INFO - no previously-included directories found matching 'docs/_build' 22:15:11 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 22:15:11 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:15:11 INFO - Cleaning up... 22:15:11 INFO - Return code: 0 22:15:11 INFO - Running post-action listener: _resource_record_post_action 22:15:11 INFO - Running post-action listener: _start_resource_monitoring 22:15:11 INFO - Starting resource monitoring. 22:15:11 INFO - ##### 22:15:11 INFO - ##### Running install step. 22:15:11 INFO - ##### 22:15:11 INFO - Running pre-action listener: _resource_record_pre_action 22:15:11 INFO - Running main action method: install 22:15:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:15:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:15:11 INFO - Reading from file tmpfile_stdout 22:15:11 INFO - Detecting whether we're running mozinstall >=1.0... 22:15:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:15:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:15:11 INFO - Reading from file tmpfile_stdout 22:15:11 INFO - Output received: 22:15:11 INFO - Usage: mozinstall [options] installer 22:15:11 INFO - Options: 22:15:11 INFO - -h, --help show this help message and exit 22:15:11 INFO - -d DEST, --destination=DEST 22:15:11 INFO - Directory to install application into. [default: 22:15:11 INFO - "/builds/slave/test"] 22:15:11 INFO - --app=APP Application being installed. [default: firefox] 22:15:11 INFO - mkdir: /builds/slave/test/build/application 22:15:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 22:15:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 22:15:27 INFO - Reading from file tmpfile_stdout 22:15:27 INFO - Output received: 22:15:27 INFO - /builds/slave/test/build/application/firefox/firefox 22:15:27 INFO - Running post-action listener: _resource_record_post_action 22:15:27 INFO - ##### 22:15:27 INFO - ##### Running run-tests step. 22:15:27 INFO - ##### 22:15:27 INFO - Running pre-action listener: _resource_record_pre_action 22:15:27 INFO - Running main action method: run_tests 22:15:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:15:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:15:27 INFO - Python 2.7.3 22:15:27 INFO - Return code: 0 22:15:27 INFO - grabbing minidump binary from tooltool 22:15:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:15:27 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 0x1234410>, '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 0x1235310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12357a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:15:27 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 22:15:27 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 22:15:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:15:27 INFO - Return code: 0 22:15:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:15:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:15:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:15:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:15:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:15:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 22:15:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 22:15:28 INFO - Return code: 0 22:15:28 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/Xea2NRyzQOeIuXv9TlRWKQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--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 22:15:28 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/Xea2NRyzQOeIuXv9TlRWKQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-062 --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 22:15:28 INFO - Using env: {'DISPLAY': ':0', 22:15:28 INFO - 'HOME': '/home/cltbld', 22:15:28 INFO - 'LANG': 'en_US.UTF-8', 22:15:28 INFO - 'LANGUAGE': 'en_US:en', 22:15:28 INFO - 'LOGNAME': 'cltbld', 22:15:28 INFO - 'MAIL': '/var/mail/cltbld', 22:15:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:15:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:15:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:15:28 INFO - 'MOZ_NO_REMOTE': '1', 22:15:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:15:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:15:28 INFO - 'NO_EM_RESTART': '1', 22:15:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:15:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:15:28 INFO - 'PWD': '/builds/slave/test', 22:15:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:15:28 INFO - 'SHELL': '/bin/bash', 22:15:28 INFO - 'SHLVL': '1', 22:15:28 INFO - 'TERM': 'linux', 22:15:28 INFO - 'TMOUT': '86400', 22:15:28 INFO - 'USER': 'cltbld', 22:15:28 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1462510044.673532-1926271636', 22:15:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:15:28 INFO - '_': '/tools/buildbot/bin/python'} 22:15:28 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/Xea2NRyzQOeIuXv9TlRWKQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--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 22:15:28 INFO - mozversion application_buildid: 20160505214925 22:15:28 INFO - mozversion application_changeset: 8fd42cc5e8c4595c1d9d3fd67f30aef8f9e3bc5c 22:15:28 INFO - mozversion application_display_name: Nightly 22:15:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:15:28 INFO - mozversion application_name: Firefox 22:15:28 INFO - mozversion application_remotingname: firefox 22:15:28 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 22:15:28 INFO - mozversion application_vendor: Mozilla 22:15:28 INFO - mozversion application_version: 49.0a1 22:15:28 INFO - mozversion platform_buildid: 20160505214925 22:15:28 INFO - mozversion platform_changeset: 8fd42cc5e8c4595c1d9d3fd67f30aef8f9e3bc5c 22:15:28 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 22:15:28 INFO - mozversion platform_version: 49.0a1 22:15:28 INFO - using testdate: 1462511728 22:15:28 INFO - actual date: 1462511728 22:15:28 INFO - starting webserver on 'localhost:51067' 22:15:28 INFO - SUITE-START | Running 2 tests 22:15:28 INFO - TEST-START | dromaeo_css 22:15:28 INFO - operating with platform_type : linux_ 22:15:28 INFO - Initialising browser for dromaeo_css test... 22:15:28 INFO - TEST-INFO | started process 14264 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpI7TygO/profile http://localhost:51067/getInfo.html) 22:15:32 INFO - PROCESS | 14264 | 22:15:32 INFO - PROCESS | 14264 | (process:14329): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:15:33 INFO - PROCESS | 14264 | __metrics Screen width/height:1600/1200 22:15:33 INFO - PROCESS | 14264 | colorDepth:24 22:15:33 INFO - PROCESS | 14264 | Browser inner width/height: 1024/697 22:15:33 INFO - PROCESS | 14264 | __metrics 22:15:34 ERROR - PROCESS | 14264 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 22:15:34 INFO - TEST-INFO | 14264: exit 0 22:15:34 INFO - Browser initialized. 22:15:34 INFO - Running cycle 1/1 for dromaeo_css test... 22:15:34 INFO - TEST-INFO | started process 14380 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpI7TygO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:15:37 INFO - PROCESS | 14380 | 22:15:37 INFO - PROCESS | 14380 | (process:14442): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:15:47 INFO - PROCESS | 14380 | RSS: Main: 164528128 22:15:47 INFO - PROCESS | 14380 | 22:16:36 INFO - PROCESS | 14380 | 1462511796652 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] 22:18:48 INFO - PROCESS | 14380 | Cycle 1(1): loaded http://localhost:51067/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51067/tests/dromaeo/cssquery-ext.html) 22:18:49 INFO - PROCESS | 14380 | RSS: Main: 167825408 22:18:49 INFO - PROCESS | 14380 | 22:21:51 INFO - PROCESS | 14380 | Cycle 1(1): loaded http://localhost:51067/tests/dromaeo/cssquery-ext.html (next: http://localhost:51067/tests/dromaeo/cssquery-jquery.html) 22:21:52 INFO - PROCESS | 14380 | RSS: Main: 167219200 22:21:52 INFO - PROCESS | 14380 | 22:24:54 INFO - PROCESS | 14380 | Cycle 1(1): loaded http://localhost:51067/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51067/tests/dromaeo/cssquery-mootools.html) 22:24:54 INFO - PROCESS | 14380 | RSS: Main: 168091648 22:24:54 INFO - PROCESS | 14380 | 22:27:56 INFO - PROCESS | 14380 | Cycle 1(1): loaded http://localhost:51067/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51067/tests/dromaeo/cssquery-prototype.html) 22:27:57 INFO - PROCESS | 14380 | RSS: Main: 165539840 22:27:57 INFO - PROCESS | 14380 | 22:31:00 INFO - PROCESS | 14380 | Cycle 1(1): loaded http://localhost:51067/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51067/tests/dromaeo/cssquery-yui.html) 22:31:00 INFO - PROCESS | 14380 | RSS: Main: 167538688 22:31:00 INFO - PROCESS | 14380 | 22:34:03 INFO - PROCESS | 14380 | Cycle 1(1): loaded http://localhost:51067/tests/dromaeo/cssquery-yui.html (next: http://localhost:51067/tests/dromaeo/cssquery-dojo.html) 22:34:03 INFO - PROCESS | 14380 | RSS: Main: 169447424 22:34:03 INFO - PROCESS | 14380 | 22:34:03 INFO - PROCESS | 14380 | __start_tp_report 22:34:03 INFO - PROCESS | 14380 | _x_x_mozilla_page_load 22:34:03 INFO - PROCESS | 14380 | _x_x_mozilla_page_load_details 22:34:03 INFO - PROCESS | 14380 | |i|pagename|runs| 22:34:03 INFO - PROCESS | 14380 | |0;dojo.html;2682.436688295458;2728.399752054547;2732.330579008143;2778.2359851040974;2792.958105628416;4731.195696731551;4839.661223714342;4882.51174882512;4902.803887844482;4911;4775.832845850396;4858.708477491344;4881.36542249508;4902.901941961159;4939.678920870141;4454.443194600675;4535.183666939949;4578.262735976206;4596.21864283071;4640.698354606957;4508.346289787979;4615.699979501322;4629.768511574424;4655.068986202756;4662.3705799716945;4392.231359512072;4465.977670111629;4478.619317358029;4519.367288579601;4564.338170965191;4451.087527056946;4452.465704115494;4455.064436468313;4461.732296062214;4469.9106017879785;4488.147252022105;4509.413776209105;4510.526394728539;4547.18150732868;4552;4671.579557839811;4733.100710864925;4740.478547359788;4766.571008609207;4782.258749893737;5169.095408303532;5210.296609957645;5211.452797456251;5214.582833373321;5266.894662106774;5156.303898973665;5239.449857764956;5252.133397989327;5255.947440525584;5260.421353651133;4813.109574728686;4824.5899098576665;4856.198727210041;4865.464798872121;4869;5311.176767601028;5315.813946511931;5346.331708536433;5357.624966252325;5360.088784906575;5051.722155281494;5095.8726031848755;5109.412417572027;5133.768980395891;5145.897082058338;5242.842714718565;5268.157094864803;5273.525382715574;5284.07528682479;5338.3060202173465;5053.166227572409;5059.114654935372;5074.264231686385;5125.513076257749;5139.691618502902;5021.548060674557;5125.359330083739;5191.922121168185;5200.193969934666;5202.687838729688;4447.977760111179;4484.618807401343;4505.594496495331;4532.9546704533195;4541.205289074464;3856.845726170922;3865.40086286626;3883.611638836094;3890.280298144852;3944.3886197639413;4395.252807022814;4462.642988560908;4476.149531588988;4556.703814252063;4574.039451715111;5335.466453354711;5355.678659280456;5396.568274538106;5410.242566040757;5412.621116521885;4551.613112885442;4560.224761790503;4590.219662657356;4610.884727881763;4635.397398338195;4655.998960223568;4675.532446755297;4695.835645752382;4827.25177597473;4862;4902.264660300983;4929.507049295042;4930.33440485537;4953.529414705597;4962.330085438492;5236;5243.868903277296;5248;5250.763715632882;5290.047791397586;4845.200541910686;4929.753512324298;4935.555799978019;4984.102861484967;4993.500649934977;5253.212018197301;5264.0261551613075;5267.4469180737005;5268.473152684701;5292.391374991926;5338.919916201183;5347.385050719217;5347.7593508293;5348.331458567679;5367.490088441748;4931.72875491837;4977.776000079933;5096.898062038665;5111.948880511296;5118.846434606968;5110.591152707849;5137.614678899023;5149.87125321855;5161.148410512224;5179.19722443022;5032.119379108714;5060.569851562658;5085.440601533903;5116.616253780907;5120.02719483297;4934.777934993006;5077.238414237894;5146.742662866767;5168;5194.220866869849;5037.017781532566;5054.241863720471;5083.669561478492;5092.923606145985;5098.79604815818 22:34:03 INFO - PROCESS | 14380 | |1;ext.html;563.1243416487363;597.4145337569182;603.1646170054474;605.4490413723511;633.4552285034872;36593;40980.795096024514;41122.177556448856;41143.58856411443;41188.382174267375;41059.17881642366;41299.38050929231;41605.58394416055;41681;41714.37428438576;7734.7679569613;7929.563873986928;7935.523868567904;7943.72196973106;7945.761627151166;7734.7679569613;7756.844863102735;7819.882701759479;7824.139344672081;7836.412269079813;7801.102873169573;7863;7873.842523149534;7887.329576985963;7892.60536973149;7802.804929876742;7818.4136189785995;7825.882611760828;7846.960765196166;7860.174681658401;7789.2989630932925;7855.803604909923;7862.606869656494;7874.251946065115;7895.763127106138;31459;37903.24193516114;38088.42867356992;38102.61897381046;38280.61719382798;3194.7923384979904;3231.7737758356925;3296.4231259529724;3303.1411832923372;3357;28718;29193.854030729923;29198.562021569694;30597.235069123228;32196.517052244235;3444.9311013779834;3454.4300190468543;3489.7208223342072;3561.216532362876;3579.910502237439;253484;257409;257604;257604;259484;34547.82726086354;35989.28021439609;61198.08202876872;61199.38800612026;61923;36948.630513694516;36970.81514592464;37056;37076.629233707856;37264.83248923872;14626.926865365605;14759.409623614934;14830.851691483163;14836.406543738129;14947.252637368088;12059.517619295306;12198.207116537396;12231.082668799698;12289.877101229053;12327.075469339656;8401.621927013299;8424.536650484282;8426.957865210634;8539.615717292736;8547.700830470903;3357.3956687795944;3366.5286859839644;3406.7104296135108;3412.675795799395;3447.3450044491465;910.3763921713647;937.7702462896634;949.924006079512;963.5663951221978;1015.7968406318765;27524;28922.421551568852;29170.854145729136;29367.412651746847;29401.11796646104;979.2606582030521;1024.8872624011353;1037.9117774989058;1080.983785243222;1086.9891301087046;15123.773143402857;15315;15504.30230639624;15553.844461555465;15880.52358429249;342721;345831;347149;347474;348010;51044.489555104716;52101.218481722804;52227.21659175115;52242.47757522452;52325.47674523206;1260.590308149855;1277.3740866975115;1287.3756228229302;1287.993560032194;1298.7921932490756;27164.32089197786;27987;28173.295667608472;28359.43281134407;28765;43403.565964339956;43533.12933741371;43545.78227108844;43576.12847743091;43658.781706091264;283301;289721;290461;290682;291575;26293.868530657226;26627.33431664224;26721.465570688866;26758.331041724112;26866.59700104461;42432;43543.564564353954;43579.128417432104;44110.11779764322;44743.10513789771;37613.2477350446;37628.24743505169;37633.435498467;37967.62032379751;38336.616633833306;36818;37382;37550;37574.43638345482;37928.620713793614;35945;36746.26507469889;36997.63002369942;37404.43893341657;37486.25027499489;32221.78580129372;33768.662313377536;33968.81109161266;34082;34175.65824341824;25686.357841054123;25857;26128.73871261263;26214.791264712127;26404.20787376382 22:34:03 INFO - PROCESS | 14380 | |2;jquery.html;371.9646633569811;371.97582157159786;373.74398537002173;378.9431585262212;390.1728335927833;16044.919775401122;16331.183440827956;16782.244798984044;17463.825361746378;17591.296348146076;15202.923985380057;15242.314095865684;15324.310406031727;15463.613409664764;15578.766318505232;5097.668651537648;5311.309529761125;5334.893302133955;5376.247325374451;5386.138217885139;5269.683818970855;5281.683099014072;5293.15309550472;5336.30628018359;5346.91979620306;5138.486151384869;5175.663581867167;5217.634765566412;5268.5521730652945;5295.0468915595175;5184.377874655028;5200.92198617021;5219.086659834533;5272.367315922113;5279.41926388097;4597.632189424838;4661.044485880387;4674.298855171717;4686.250199967989;4711.0342379812055;20255.392338229878;20480.795192048037;21007.684884726743;21112;21188;1954.9022548872642;1976.328048463515;2068.2037415594955;2135.9572808543744;2174.5626967366516;13329.266890321029;13442.462301507929;13490.797638035438;13633.931830340884;13875.306234688225;1737.2182517866884;1748.1084646830082;1765.0821572782081;1776.3427531813184;1967.9901600492049;61939.69030154865;61940.69029654868;66753.99999999952;68201;69755.30244697539;9820.508974551387;9894.55474503649;10064.245181611408;10092.646757363604;10230.744231394274;13906;13909.79135312971;13983.650408739863;14035.736783689314;14071.226082565558;7515.549067055994;7531.736389226351;7572.583507907118;7624.504407213513;7736.961315193501;7370.77887663371;7408.925910740823;7431.3683336916965;7570.16728159902;7580.0145981022115;4229;4309.1381723655395;4378.671599630041;4437.556244375602;4467.7319360838455;1838.2187570282576;1849.2787812753038;1881.2569035231281;1887.6413481438483;1897.5578560294;874.4534665833854;888.5646033443566;936.5270538378076;947.7535840681335;997.1374760831973;16680.74978875318;17104.57238569046;17295.827041729422;17576.38482653101;17702.468925932244;876.6931573949195;906.4380084347747;931.8928323242778;948.7296120605595;971.8930917599058;9685.32202745815;9812.95093524542;9840.606375745034;9937.602495900082;9967.451790151466;373726;380283;386718;388230;388439;81398;84574.57712711397;85002;86326;87035.56482217548;948.3551185193996;953.6328513522205;965.1844191658038;967.3180407812475;973.1436336024253;14946.476873309382;15392.538223853302;15628.687426251185;15751.842481575037;15869.444569440015;29979;35508.467372989944;36391.45412818757;36619.63380366162;36926.6307336934;48643.75678121587;50518.98962020812;51566;51825.04342964422;52079;7658.463907526642;7818.843623127392;7842.490238134503;7842.686292548234;7972.601369931364;6023.939760602338;7114.893276600752;10169.542370593193;10500.317479363817;10911;9395.530223488935;9447.385919915183;9526.285528585246;9530.904690953279;10081.395116293046;9588.56851441673;9806;9809.411435313905;9833.655822046194;10087.596496140366;9686.951565242129;10189.28674992773;10210.744731381776;10333.48332583383;10714.357138571711;7462.850742985219;7625.199354067743;7803.8829417557645;7863.252990965849;7922.683092676459;9891.752706182404;9960.452175130438;10003;10104.242181836245;10205.336653117523 22:34:03 INFO - PROCESS | 14380 | |3;mootools.html;1359.4562175129947;1480.740870347689;1635.4929971708764;1802.3061121468231;1817.7818661760598;6426.164598602175;7277.818054548639;7381.446391520644;7617.619119044047;7698.615069246536;7532.397408207344;7683.423743219253;7715.189905059972;7734.03324584427;7752.341051010657;2207.348832094528;2230.631945728953;2248.685184074231;2249.089118906837;2255.2444930948154;2158.956820863582;2161.6109100361928;2190.802827745503;2192.9342119736434;2193.5283913958497;2151.107290474451;2161.870287782738;2170.1536400803698;2179.6512557990723;2189.321310393775;2113.3131732187026;2136.4979229880964;2136.7329083864515;2141.2933731868447;2148.3125399872047;2091.4144039668918;2128.063651993118;2129.2760461443027;2134.551744133734;2136.145541783299;7698.076230852277;7729.304362607392;7760.767176984699;7767.844643107106;7788.376929845599;4277.2087163874785;4391.341298805205;4489;4550.931736023929;4557.407537020199;2717.184844546628;2862.842543660098;2872.195785180153;2883.3224192314788;2886.682464928856;920.9125133112343;928.0672923711627;935.6678379175431;936.8220038192721;968.3560432312504;9966.40201587907;10052.597896084148;10054.095131438205;10095.949520252425;10121.645742398981;4051.9392209116886;4089.672826173899;4100.897477563025;4109.486314210723;4120.887360412672;8741.825163496695;8745.475271483605;8769.166929141722;8799;8807.955960220286;4340.827976446341;4357.564243575617;4410.977945110254;4468.396766436555;4498.595126438636;3495.9300813984087;4015.31739604268;4046.838126474908;4119.711620186618;4268.210381079511;3592.8742494012586;3613.2050948791225;3701.759385639925;3744.344739670547;3871.9419208711893;1143.1369316166242;1203.554684766642;1204.7650708111835;1213.805791073424;1219.5000049979644;869.1482347299556;881.3918396306528;884.274894586433;895.0646574329841;927.5779520318239;5172.043172013115;5174.301469301596;5237.135872581058;5274.657147285414;5474.808381706701;911.3119594706087;919.2370332623906;920.4753290624279;943.4622265308845;956.1442508954585;3587.0673624857723;3798.4682144499793;3798.924021519554;3810.733248672622;3823.101571130782;9014.323925705598;9100.408473449204;9463.952680236693;9490.667826626035;9510.191633711074;9328.300377471716;9345.906540934504;9409.811803764023;9444.338896277195;9491.050894910592;7107.431405487549;7144.714211431485;7219.927800722031;7225.349718525253;7287.41700663935;5192.870178245574;5226.817061402832;5264.052470555183;5356.866078348073;5366.651167674088;8309.501429914224;8379.329653627574;8532.44539104981;8609.741707748777;8719.91280087191;8549.957250213709;8711.21599056088;8728.78178045554;8910.910890891008;8929.330300227379;5911.261092363455;6504.60972341661;6729.966350168218;6748.460123190232;6886.552374095668;7190.101237345332;7220.422366210585;7231.746888858865;7243.45674074457;7303.452241081834;6585.242697089896;6626.403623673892;6645.933540664531;6749.898751518633;6867.896981545381;6535.869282614226;6591.571547849375;6618.338166183343;6630.071789949315;6665.900011499734;6267.843303917256;6311.558190926775;6322.399372059647;6368.108464814837;6377.553571250153;4493.573110554492;4602.21762300403;4686.929696054493;4703.129920964632;4805.7597120143155;4398.428204333416;4474.9328760069275;4550.385697930737;4558.133954548758;4584.4498660161 22:34:03 INFO - PROCESS | 14380 | |4;prototype.html;296.361341309478;300.1311204064234;302.9348690031643;307.2870939420545;309.3658001097749;4826.686265392747;4866.562009419152;4936.753162341886;5004.124278251305;5105.208692652635;4818.27725841124;4910;4910.386201724785;4936.284238785374;4952.959878425535;3898.9805050974846;3929.3516569766025;3941.7043721720843;3951.0122469382654;3954.545227298854;3650.4524321351746;3932.1742434088874;3947.9537922450572;3958.366661334187;3960.782156981365;3811.7331786774935;3817.522809648794;3825.8087095645246;3826.426036094594;3835.5013848199833;3846.6345697159004;3846.807659617036;3850.5186851643543;3865.3042452358563;3883.970747751834;3387.6951074403178;3390.338883917637;3393.881214157517;3411.9317613647836;3412.4028295048265;4716.29255611661;4718.386609740712;4739.905201895943;4749.762511874427;4826.903461930777;4342.565743425664;4363.170997510495;4371.213181627306;4377.584129507692;4392.143532011227;5178.766955487012;5195.636305458619;5220.347456567929;5221.138512145491;5224.582033437316;3527.976886702853;3646.47126166707;3677.889663310105;3684.852605895761;3687;5458.0721277382545;5495.697736624484;5504.2018907258625;5543.390227075019;5562.805301814457;3722.571904230994;3758.191988722383;3767.434884767307;3768.2651882882574;3776.546814382237;3812;3816.8358650611276;3822.4648549203134;3826.8277927492773;3832.3676593362343;4217.915641687149;4310.676699247506;4330.848420305274;4356.607905288476;4361.280388735823;5237.73811309433;5241.50205730455;5255.369355677343;5271.341082364705;5295.523402893758;1220.725336799231;1240.1752834365227;1273.8471383434048;1277.9105462617713;1280.6030130659526;852.7910661887877;872.8609165039684;881.1452890696015;882.1619461511461;887.2857349833317;4420.977895110504;4440.422745043188;4448.199324121689;4457.910841783146;4519.480259770103;5124.769385377667;5144.382674079135;5174.008006917364;5228.816991405282;5241.68549887008;4417.53615870329;4418.668599855024;4422.248217802981;4471.776411179428;4495.2582823834355;2635.262126604554;2806.877249100376;2810.2693299741804;2821.3651928315967;2822.5907243449997;4912.091263116335;4990.128701736849;5002.874353270558;5038.193888977746;5053.494650534917;5277.683338999673;5404.081306177959;5439.564834813205;5445.128779395278;5486.286782718221;4995.350604421402;4999.100521697479;5006.949930500721;5007.799688012512;5011.924821127686;5173.689578625144;5283.762230699705;5294.814681486129;5340.198970154508;5341.946580534145;4978.576820970114;5208.192730126836;5227.366979948899;5241.868953276198;5265.340588291101;4911.484294149206;4913.606911447004;4942.308076869169;4946.7031978079995;4950.727709975986;3620.420732682758;3677.1542545214215;3682.8342724576924;3693.076730817296;3701.7979447778016;5120.155174396332;5278.4193738687945;5289.2330612061805;5314.681119132864;5427.348718153847;5220.791168353223;5241.580673546031;5242.633015688865;5252.842414727565;5290.761915713725;5201.557867581298;5259.579233661374;5281.815136470205;5288.418273989935;5291.391489978701;4851.781669824937;5182.481751824938;5202.453742356998;5207.3751149862255;5220.321358223407;5252.290940722954;5256.6320357574605;5293.338332708411;5316.308879845596;5396.46035396473;5194.246834208943;5200.869978250423;5207.479252074762;5225.372955245395;5246.291750613618 22:34:03 INFO - PROCESS | 14380 | |5;yui.html;779.1157036763271;782.6676504018022;784.4430454377392;800.879868019797;804.231958479652;10782.946085269583;11045.28205666633;11054.502547385368;11069.391183484915;11114;11747.823782643267;11846.703832404173;11861.940690296537;11900.880991190108;11959.342236177006;680.6936878404713;858.5921687198578;859.6260626627405;868.7958329792493;873.8732883731855;853.9615717292737;857.2199298638241;857.6440777077537;863.6890719341033;865.4547634989948;902.3773596218621;905.4657751926362;914.7301546043933;917.0600134861787;920.5075284722675;905.6875377994581;907.5054095517893;908.5411867007152;911.4349103555771;916.1983264643437;672.2504407585507;672.4418732452053;676.577139287945;677.0791723256367;677.9999500736424;11692.298462092302;11730.648080557512;11749.001334886545;11765.882341176564;11783.823242651368;12636.620901372973;12786.262396601522;12894.032947528973;12926.28905410202;13025.934870325682;9629.181519570844;9652.179564737005;9688.321817472779;9971.102600765893;9976.501174941224;3268.5587445694764;3277.901662950115;3284.310294838087;3348.3470723208984;3409.8636054558037;44300.77849610763;44788.55211447876;44810.77594612039;44814.32778508325;45183.548164518266;9850.556724947395;9911.7026489204;10091;10095.899041009643;10170.542325595366;18266.086695665163;18277.360292389967;18477;18480;18820.81179188218;6960.512764106464;6967.79096627102;7039.507234493639;7120;7212.423006159494;3841.539015318124;3897.142628621699;3924.2151569685607;3936.1340505088833;3948.072203032285;2575.9227223183334;2681.5575430053823;2682.2757855378936;2683.9194824155306;2685.3420911876715;507.9009593129304;509.03537795876605;516.6770768269831;520.9973950130225;521.5228066319276;598.3956204233668;626.6490765171518;629.9433051025429;634.8190765631773;637.1366797988659;7068.126946359219;7232.927670723226;7247.347738703542;7415.3326200642205;7671.769846904602;610.008735804318;612.2530512774408;614.3487902823022;617.4443001298778;617.9134921111048;3721.1813401051727;3743.9812800936365;3773.113318370181;3777.282316359938;3870.9419358709642;49241.26138107931;49901.25148122781;50123.24815127776;50652.240216396785;50679.23981140286;44807.32789008167;45363;45818.770906145925;46747.532524674316;47279.5272047282;42839.78580107142;42955.570444295154;42964.42213467202;43524;43816.78091609585;7249;7249.855002899807;7282.96358518204;7362.3741981932135;7414.184439711519;28424.431511369243;29110.854445727637;29454.410911781215;29764.255893602833;29773.702262977095;34940;36745.44881826828;37141.814290929455;37370.626293737805;37798.055048624;9392.95303523478;9453.527323633929;9511.904880951379;9649.951750241486;10009.299349045497;10027.799444010932;10046.447445390282;10084.443405004879;10175.806379501297;10268.229882758673;8965.7758556034;9204.539773011456;9353.158215760343;9434.386764860263;9631.229501639993;9297.116773906468;9352.719418417459;9355.25157987373;9356.485393303434;9699;8975.416597921114;9104.408213466104;9475.194608458358;9491.952540237255;9523.619055237712;8202.958985205036;8262.504249745034;8398.748037558884;8486.83026339482;8519.701810436605;8149.633266502903;8368.330533557179;8506.914930850613;8603.569821508774;8692 22:34:03 INFO - PROCESS | 14380 | __end_tp_report 22:34:03 INFO - PROCESS | 14380 | __start_cc_report 22:34:03 INFO - PROCESS | 14380 | _x_x_mozilla_cycle_collect,386 22:34:03 INFO - PROCESS | 14380 | __end_cc_report 22:34:03 INFO - PROCESS | 14380 | __startTimestamp1462512843400__endTimestamp 22:34:03 INFO - PROCESS | 14380 | 22:34:03 INFO - PROCESS | 14380 | ------- Summary: start ------- 22:34:03 INFO - PROCESS | 14380 | Number of tests: 6 22:34:03 INFO - PROCESS | 14380 | 22:34:03 INFO - PROCESS | 14380 | [#0] dojo.html Cycles:165 Average:4845.59 Median:4939.68 stddev:506.32 (10.2%) stddev-sans-first:478.59 22:34:03 INFO - PROCESS | 14380 | Values: 2682.4 2728.4 2732.3 2778.2 2793.0 4731.2 4839.7 4882.5 4902.8 4911.0 4775.8 4858.7 4881.4 4902.9 4939.7 4454.4 4535.2 4578.3 4596.2 4640.7 4508.3 4615.7 4629.8 4655.1 4662.4 4392.2 4466.0 4478.6 4519.4 4564.3 4451.1 4452.5 4455.1 4461.7 4469.9 4488.1 4509.4 4510.5 4547.2 4552.0 4671.6 4733.1 4740.5 4766.6 4782.3 5169.1 5210.3 5211.5 5214.6 5266.9 5156.3 5239.4 5252.1 5255.9 5260.4 4813.1 4824.6 4856.2 4865.5 4869.0 5311.2 5315.8 5346.3 5357.6 5360.1 5051.7 5095.9 5109.4 5133.8 5145.9 5242.8 5268.2 5273.5 5284.1 5338.3 5053.2 5059.1 5074.3 5125.5 5139.7 5021.5 5125.4 5191.9 5200.2 5202.7 4448.0 4484.6 4505.6 4533.0 4541.2 3856.8 3865.4 3883.6 3890.3 3944.4 4395.3 4462.6 4476.1 4556.7 4574.0 5335.5 5355.7 5396.6 5410.2 5412.6 4551.6 4560.2 4590.2 4610.9 4635.4 4656.0 4675.5 4695.8 4827.3 4862.0 4902.3 4929.5 4930.3 4953.5 4962.3 5236.0 5243.9 5248.0 5250.8 5290.0 4845.2 4929.8 4935.6 4984.1 4993.5 5253.2 5264.0 5267.4 5268.5 5292.4 5338.9 5347.4 5347.8 5348.3 5367.5 4931.7 4977.8 5096.9 5111.9 5118.8 5110.6 5137.6 5149.9 5161.1 5179.2 5032.1 5060.6 5085.4 5116.6 5120.0 4934.8 5077.2 5146.7 5168.0 5194.2 5037.0 5054.2 5083.7 5092.9 5098.8 22:34:03 INFO - PROCESS | 14380 | 22:34:03 INFO - PROCESS | 14380 | [#1] ext.html Cycles:180 Average:45221.34 Median:36782.13 stddev:78677.23 (213.9%) stddev-sans-first:78826.49 22:34:03 INFO - PROCESS | 14380 | Values: 563.1 597.4 603.2 605.4 633.5 36593.0 40980.8 41122.2 41143.6 41188.4 41059.2 41299.4 41605.6 41681.0 41714.4 7734.8 7929.6 7935.5 7943.7 7945.8 7734.8 7756.8 7819.9 7824.1 7836.4 7801.1 7863.0 7873.8 7887.3 7892.6 7802.8 7818.4 7825.9 7847.0 7860.2 7789.3 7855.8 7862.6 7874.3 7895.8 31459.0 37903.2 38088.4 38102.6 38280.6 3194.8 3231.8 3296.4 3303.1 3357.0 28718.0 29193.9 29198.6 30597.2 32196.5 3444.9 3454.4 3489.7 3561.2 3579.9 253484.0 257409.0 257604.0 257604.0 259484.0 34547.8 35989.3 61198.1 61199.4 61923.0 36948.6 36970.8 37056.0 37076.6 37264.8 14626.9 14759.4 14830.9 14836.4 14947.3 12059.5 12198.2 12231.1 12289.9 12327.1 8401.6 8424.5 8427.0 8539.6 8547.7 3357.4 3366.5 3406.7 3412.7 3447.3 910.4 937.8 949.9 963.6 1015.8 27524.0 28922.4 29170.9 29367.4 29401.1 979.3 1024.9 1037.9 1081.0 1087.0 15123.8 15315.0 15504.3 15553.8 15880.5 342721.0 345831.0 347149.0 347474.0 348010.0 51044.5 52101.2 52227.2 52242.5 52325.5 1260.6 1277.4 1287.4 1288.0 1298.8 27164.3 27987.0 28173.3 28359.4 28765.0 43403.6 43533.1 43545.8 43576.1 43658.8 283301.0 289721.0 290461.0 290682.0 291575.0 26293.9 26627.3 26721.5 26758.3 26866.6 42432.0 43543.6 43579.1 44110.1 44743.1 37613.2 37628.2 37633.4 37967.6 38336.6 36818.0 37382.0 37550.0 37574.4 37928.6 35945.0 36746.3 36997.6 37404.4 37486.3 32221.8 33768.7 33968.8 34082.0 34175.7 25686.4 25857.0 26128.7 26214.8 26404.2 22:34:03 INFO - PROCESS | 14380 | 22:34:03 INFO - PROCESS | 14380 | [#2] jquery.html Cycles:180 Average:24209.87 Median:49581.37 stddev:63488.98 (128.1%) stddev-sans-first:63641.85 22:34:03 INFO - PROCESS | 14380 | Values: 372.0 372.0 373.7 378.9 390.2 16044.9 16331.2 16782.2 17463.8 17591.3 15202.9 15242.3 15324.3 15463.6 15578.8 5097.7 5311.3 5334.9 5376.2 5386.1 5269.7 5281.7 5293.2 5336.3 5346.9 5138.5 5175.7 5217.6 5268.6 5295.0 5184.4 5200.9 5219.1 5272.4 5279.4 4597.6 4661.0 4674.3 4686.3 4711.0 20255.4 20480.8 21007.7 21112.0 21188.0 1954.9 1976.3 2068.2 2136.0 2174.6 13329.3 13442.5 13490.8 13633.9 13875.3 1737.2 1748.1 1765.1 1776.3 1968.0 61939.7 61940.7 66754.0 68201.0 69755.3 9820.5 9894.6 10064.2 10092.6 10230.7 13906.0 13909.8 13983.7 14035.7 14071.2 7515.5 7531.7 7572.6 7624.5 7737.0 7370.8 7408.9 7431.4 7570.2 7580.0 4229.0 4309.1 4378.7 4437.6 4467.7 1838.2 1849.3 1881.3 1887.6 1897.6 874.5 888.6 936.5 947.8 997.1 16680.7 17104.6 17295.8 17576.4 17702.5 876.7 906.4 931.9 948.7 971.9 9685.3 9813.0 9840.6 9937.6 9967.5 373726.0 380283.0 386718.0 388230.0 388439.0 81398.0 84574.6 85002.0 86326.0 87035.6 948.4 953.6 965.2 967.3 973.1 14946.5 15392.5 15628.7 15751.8 15869.4 29979.0 35508.5 36391.5 36619.6 36926.6 48643.8 50519.0 51566.0 51825.0 52079.0 7658.5 7818.8 7842.5 7842.7 7972.6 6023.9 7114.9 10169.5 10500.3 10911.0 9395.5 9447.4 9526.3 9530.9 10081.4 9588.6 9806.0 9809.4 9833.7 10087.6 9687.0 10189.3 10210.7 10333.5 10714.4 7462.9 7625.2 7803.9 7863.3 7922.7 9891.8 9960.5 10003.0 10104.2 10205.3 22:34:03 INFO - PROCESS | 14380 | 22:34:03 INFO - PROCESS | 14380 | [#3] mootools.html Cycles:180 Average:5043.64 Median:5315.76 stddev:2751.74 (51.8%) stddev-sans-first:2745.53 22:34:03 INFO - PROCESS | 14380 | Values: 1359.5 1480.7 1635.5 1802.3 1817.8 6426.2 7277.8 7381.4 7617.6 7698.6 7532.4 7683.4 7715.2 7734.0 7752.3 2207.3 2230.6 2248.7 2249.1 2255.2 2159.0 2161.6 2190.8 2192.9 2193.5 2151.1 2161.9 2170.2 2179.7 2189.3 2113.3 2136.5 2136.7 2141.3 2148.3 2091.4 2128.1 2129.3 2134.6 2136.1 7698.1 7729.3 7760.8 7767.8 7788.4 4277.2 4391.3 4489.0 4550.9 4557.4 2717.2 2862.8 2872.2 2883.3 2886.7 920.9 928.1 935.7 936.8 968.4 9966.4 10052.6 10054.1 10095.9 10121.6 4051.9 4089.7 4100.9 4109.5 4120.9 8741.8 8745.5 8769.2 8799.0 8808.0 4340.8 4357.6 4411.0 4468.4 4498.6 3495.9 4015.3 4046.8 4119.7 4268.2 3592.9 3613.2 3701.8 3744.3 3871.9 1143.1 1203.6 1204.8 1213.8 1219.5 869.1 881.4 884.3 895.1 927.6 5172.0 5174.3 5237.1 5274.7 5474.8 911.3 919.2 920.5 943.5 956.1 3587.1 3798.5 3798.9 3810.7 3823.1 9014.3 9100.4 9464.0 9490.7 9510.2 9328.3 9345.9 9409.8 9444.3 9491.1 7107.4 7144.7 7219.9 7225.3 7287.4 5192.9 5226.8 5264.1 5356.9 5366.7 8309.5 8379.3 8532.4 8609.7 8719.9 8550.0 8711.2 8728.8 8910.9 8929.3 5911.3 6504.6 6730.0 6748.5 6886.6 7190.1 7220.4 7231.7 7243.5 7303.5 6585.2 6626.4 6645.9 6749.9 6867.9 6535.9 6591.6 6618.3 6630.1 6665.9 6267.8 6311.6 6322.4 6368.1 6377.6 4493.6 4602.2 4686.9 4703.1 4805.8 4398.4 4474.9 4550.4 4558.1 4584.4 22:34:03 INFO - PROCESS | 14380 | 22:34:03 INFO - PROCESS | 14380 | [#4] prototype.html Cycles:180 Average:4295.76 Median:4910.94 stddev:1261.81 (25.7%) stddev-sans-first:1229.13 22:34:03 INFO - PROCESS | 14380 | Values: 296.4 300.1 302.9 307.3 309.4 4826.7 4866.6 4936.8 5004.1 5105.2 4818.3 4910.0 4910.4 4936.3 4953.0 3899.0 3929.4 3941.7 3951.0 3954.5 3650.5 3932.2 3948.0 3958.4 3960.8 3811.7 3817.5 3825.8 3826.4 3835.5 3846.6 3846.8 3850.5 3865.3 3884.0 3387.7 3390.3 3393.9 3411.9 3412.4 4716.3 4718.4 4739.9 4749.8 4826.9 4342.6 4363.2 4371.2 4377.6 4392.1 5178.8 5195.6 5220.3 5221.1 5224.6 3528.0 3646.5 3677.9 3684.9 3687.0 5458.1 5495.7 5504.2 5543.4 5562.8 3722.6 3758.2 3767.4 3768.3 3776.5 3812.0 3816.8 3822.5 3826.8 3832.4 4217.9 4310.7 4330.8 4356.6 4361.3 5237.7 5241.5 5255.4 5271.3 5295.5 1220.7 1240.2 1273.8 1277.9 1280.6 852.8 872.9 881.1 882.2 887.3 4421.0 4440.4 4448.2 4457.9 4519.5 5124.8 5144.4 5174.0 5228.8 5241.7 4417.5 4418.7 4422.2 4471.8 4495.3 2635.3 2806.9 2810.3 2821.4 2822.6 4912.1 4990.1 5002.9 5038.2 5053.5 5277.7 5404.1 5439.6 5445.1 5486.3 4995.4 4999.1 5006.9 5007.8 5011.9 5173.7 5283.8 5294.8 5340.2 5341.9 4978.6 5208.2 5227.4 5241.9 5265.3 4911.5 4913.6 4942.3 4946.7 4950.7 3620.4 3677.2 3682.8 3693.1 3701.8 5120.2 5278.4 5289.2 5314.7 5427.3 5220.8 5241.6 5242.6 5252.8 5290.8 5201.6 5259.6 5281.8 5288.4 5291.4 4851.8 5182.5 5202.5 5207.4 5220.3 5252.3 5256.6 5293.3 5316.3 5396.5 5194.2 5200.9 5207.5 5225.4 5246.3 22:34:03 INFO - PROCESS | 14380 | 22:34:03 INFO - PROCESS | 14380 | [#5] yui.html Cycles:180 Average:12296.54 Median:611.13 stddev:14166.57 (2318.1%) stddev-sans-first:14179.90 22:34:03 INFO - PROCESS | 14380 | Values: 779.1 782.7 784.4 800.9 804.2 10782.9 11045.3 11054.5 11069.4 11114.0 11747.8 11846.7 11861.9 11900.9 11959.3 680.7 858.6 859.6 868.8 873.9 854.0 857.2 857.6 863.7 865.5 902.4 905.5 914.7 917.1 920.5 905.7 907.5 908.5 911.4 916.2 672.3 672.4 676.6 677.1 678.0 11692.3 11730.6 11749.0 11765.9 11783.8 12636.6 12786.3 12894.0 12926.3 13025.9 9629.2 9652.2 9688.3 9971.1 9976.5 3268.6 3277.9 3284.3 3348.3 3409.9 44300.8 44788.6 44810.8 44814.3 45183.5 9850.6 9911.7 10091.0 10095.9 10170.5 18266.1 18277.4 18477.0 18480.0 18820.8 6960.5 6967.8 7039.5 7120.0 7212.4 3841.5 3897.1 3924.2 3936.1 3948.1 2575.9 2681.6 2682.3 2683.9 2685.3 507.9 509.0 516.7 521.0 521.5 598.4 626.6 629.9 634.8 637.1 7068.1 7232.9 7247.3 7415.3 7671.8 610.0 612.3 614.3 617.4 617.9 3721.2 3744.0 3773.1 3777.3 3870.9 49241.3 49901.3 50123.2 50652.2 50679.2 44807.3 45363.0 45818.8 46747.5 47279.5 42839.8 42955.6 42964.4 43524.0 43816.8 7249.0 7249.9 7283.0 7362.4 7414.2 28424.4 29110.9 29454.4 29764.3 29773.7 34940.0 36745.4 37141.8 37370.6 37798.1 9393.0 9453.5 9511.9 9650.0 10009.3 10027.8 10046.4 10084.4 10175.8 10268.2 8965.8 9204.5 9353.2 9434.4 9631.2 9297.1 9352.7 9355.3 9356.5 9699.0 8975.4 9104.4 9475.2 9492.0 9523.6 8203.0 8262.5 8398.7 8486.8 8519.7 8149.6 8368.3 8506.9 8603.6 8692.0 22:34:03 INFO - PROCESS | 14380 | -------- Summary: end -------- 22:34:03 INFO - PROCESS | 14380 | 22:34:04 INFO - TEST-INFO | 14380: exit 0 22:34:04 INFO - TEST-OK | dromaeo_css | took 1115336ms 22:34:04 INFO - TEST-START | kraken 22:34:04 INFO - operating with platform_type : linux_ 22:34:04 INFO - Initialising browser for kraken test... 22:34:04 INFO - TEST-INFO | started process 14614 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpi6w8wk/profile http://localhost:51067/getInfo.html) 22:34:07 INFO - PROCESS | 14614 | 22:34:07 INFO - PROCESS | 14614 | (process:14680): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:34:08 INFO - PROCESS | 14614 | __metrics Screen width/height:1600/1200 22:34:08 INFO - PROCESS | 14614 | colorDepth:24 22:34:08 INFO - PROCESS | 14614 | Browser inner width/height: 1024/697 22:34:08 INFO - PROCESS | 14614 | __metrics 22:34:09 ERROR - PROCESS | 14614 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 22:34:10 INFO - TEST-INFO | 14614: exit 0 22:34:10 INFO - Browser initialized. 22:34:10 INFO - Running cycle 1/1 for kraken test... 22:34:10 INFO - TEST-INFO | started process 14731 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpi6w8wk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:34:12 INFO - PROCESS | 14731 | 22:34:12 INFO - PROCESS | 14731 | (process:14793): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:34:22 INFO - PROCESS | 14731 | RSS: Main: 164397056 22:34:22 INFO - PROCESS | 14731 | 22:34:24 INFO - PROCESS | 14731 | Cycle 1(1): loaded http://localhost:51067/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51067/tests/kraken/driver.html?testName=audio-beat-detection) 22:34:25 INFO - PROCESS | 14731 | RSS: Main: 167788544 22:34:25 INFO - PROCESS | 14731 | 22:34:28 INFO - PROCESS | 14731 | Cycle 1(1): loaded http://localhost:51067/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51067/tests/kraken/driver.html?testName=audio-dft) 22:34:29 INFO - PROCESS | 14731 | RSS: Main: 167907328 22:34:29 INFO - PROCESS | 14731 | 22:34:32 INFO - PROCESS | 14731 | Cycle 1(1): loaded http://localhost:51067/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51067/tests/kraken/driver.html?testName=audio-fft) 22:34:32 INFO - PROCESS | 14731 | RSS: Main: 164495360 22:34:32 INFO - PROCESS | 14731 | 22:34:35 INFO - PROCESS | 14731 | Cycle 1(1): loaded http://localhost:51067/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51067/tests/kraken/driver.html?testName=audio-oscillator) 22:34:35 INFO - PROCESS | 14731 | RSS: Main: 164794368 22:34:35 INFO - PROCESS | 14731 | 22:34:38 INFO - PROCESS | 14731 | Cycle 1(1): loaded http://localhost:51067/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51067/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:34:38 INFO - PROCESS | 14731 | RSS: Main: 164827136 22:34:38 INFO - PROCESS | 14731 | 22:34:41 INFO - PROCESS | 14731 | Cycle 1(1): loaded http://localhost:51067/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51067/tests/kraken/driver.html?testName=imaging-darkroom) 22:34:42 INFO - PROCESS | 14731 | RSS: Main: 165064704 22:34:42 INFO - PROCESS | 14731 | 22:34:45 INFO - PROCESS | 14731 | Cycle 1(1): loaded http://localhost:51067/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51067/tests/kraken/driver.html?testName=imaging-desaturate) 22:34:46 INFO - PROCESS | 14731 | RSS: Main: 163528704 22:34:46 INFO - PROCESS | 14731 | 22:34:49 INFO - PROCESS | 14731 | Cycle 1(1): loaded http://localhost:51067/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51067/tests/kraken/driver.html?testName=json-parse-financial) 22:34:50 INFO - PROCESS | 14731 | RSS: Main: 164134912 22:34:50 INFO - PROCESS | 14731 | 22:34:51 INFO - PROCESS | 14731 | Cycle 1(1): loaded http://localhost:51067/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51067/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:34:52 INFO - PROCESS | 14731 | RSS: Main: 164270080 22:34:52 INFO - PROCESS | 14731 | 22:34:54 INFO - PROCESS | 14731 | Cycle 1(1): loaded http://localhost:51067/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51067/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:34:54 INFO - PROCESS | 14731 | RSS: Main: 164360192 22:34:54 INFO - PROCESS | 14731 | 22:34:57 INFO - PROCESS | 14731 | Cycle 1(1): loaded http://localhost:51067/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51067/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:34:57 INFO - PROCESS | 14731 | RSS: Main: 164880384 22:34:57 INFO - PROCESS | 14731 | 22:35:00 INFO - PROCESS | 14731 | Cycle 1(1): loaded http://localhost:51067/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51067/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:35:01 INFO - PROCESS | 14731 | RSS: Main: 165158912 22:35:01 INFO - PROCESS | 14731 | 22:35:04 INFO - PROCESS | 14731 | Cycle 1(1): loaded http://localhost:51067/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51067/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:35:04 INFO - PROCESS | 14731 | RSS: Main: 164950016 22:35:04 INFO - PROCESS | 14731 | 22:35:06 INFO - PROCESS | 14731 | Cycle 1(1): loaded http://localhost:51067/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51067/tests/kraken/driver.html?testName=ai-astar) 22:35:06 INFO - PROCESS | 14731 | RSS: Main: 166817792 22:35:06 INFO - PROCESS | 14731 | 22:35:06 INFO - PROCESS | 14731 | __start_tp_report 22:35:06 INFO - PROCESS | 14731 | _x_x_mozilla_page_load 22:35:06 INFO - PROCESS | 14731 | _x_x_mozilla_page_load_details 22:35:06 INFO - PROCESS | 14731 | |i|pagename|runs| 22:35:06 INFO - PROCESS | 14731 | |0;ai-astar;114;118;107;116;119;114;111;116;117;116 22:35:06 INFO - PROCESS | 14731 | |1;audio-beat-detection;163;131;156;190;137;168;164;136;192;149 22:35:06 INFO - PROCESS | 14731 | |2;audio-dft;165;165;166;171;163;164;166;164;166;165 22:35:06 INFO - PROCESS | 14731 | |3;audio-fft;77;76;77;163;77;77;76;77;173;78 22:35:06 INFO - PROCESS | 14731 | |4;audio-oscillator;99;94;147;96;95;94;142;98;93;154 22:35:06 INFO - PROCESS | 14731 | |5;imaging-gaussian-blur;118;119;117;118;118;119;118;119;119;119 22:35:06 INFO - PROCESS | 14731 | |6;imaging-darkroom;148;151;147;147;148;148;147;147;149;147 22:35:06 INFO - PROCESS | 14731 | |7;imaging-desaturate;96;96;95;96;95;95;96;96;95;96 22:35:06 INFO - PROCESS | 14731 | |8;json-parse-financial;65;68;66;68;67;67;67;87;66;64 22:35:06 INFO - PROCESS | 14731 | |9;json-stringify-tinderbox;65;65;64;65;64;64;65;64;67;65 22:35:06 INFO - PROCESS | 14731 | |10;stanford-crypto-aes;83;87;83;94;83;84;88;84;84;84 22:35:06 INFO - PROCESS | 14731 | |11;stanford-crypto-ccm;134;141;153;151;136;146;158;136;214;134 22:35:06 INFO - PROCESS | 14731 | |12;stanford-crypto-pbkdf2;182;180;184;181;182;175;184;179;176;181 22:35:06 INFO - PROCESS | 14731 | |13;stanford-crypto-sha256-iterative;71;69;69;71;70;72;73;68;69;72 22:35:06 INFO - PROCESS | 14731 | __end_tp_report 22:35:06 INFO - PROCESS | 14731 | __start_cc_report 22:35:06 INFO - PROCESS | 14731 | _x_x_mozilla_cycle_collect,910 22:35:06 INFO - PROCESS | 14731 | __end_cc_report 22:35:06 INFO - PROCESS | 14731 | __startTimestamp1462512906938__endTimestamp 22:35:06 INFO - PROCESS | 14731 | 22:35:06 INFO - PROCESS | 14731 | ------- Summary: start ------- 22:35:06 INFO - PROCESS | 14731 | Number of tests: 14 22:35:06 INFO - PROCESS | 14731 | 22:35:06 INFO - PROCESS | 14731 | [#0] ai-astar Cycles:10 Average:114.80 Median:116.00 stddev:3.55 (3.1%) stddev-sans-first:3.76 22:35:06 INFO - PROCESS | 14731 | Values: 114.0 118.0 107.0 116.0 119.0 114.0 111.0 116.0 117.0 116.0 22:35:06 INFO - PROCESS | 14731 | 22:35:06 INFO - PROCESS | 14731 | [#1] audio-beat-detection Cycles:10 Average:158.60 Median:163.50 stddev:21.28 (13.0%) stddev-sans-first:22.51 22:35:06 INFO - PROCESS | 14731 | Values: 163.0 131.0 156.0 190.0 137.0 168.0 164.0 136.0 192.0 149.0 22:35:06 INFO - PROCESS | 14731 | 22:35:06 INFO - PROCESS | 14731 | [#2] audio-dft Cycles:10 Average:165.50 Median:165.50 stddev:2.17 (1.3%) stddev-sans-first:2.30 22:35:06 INFO - PROCESS | 14731 | Values: 165.0 165.0 166.0 171.0 163.0 164.0 166.0 164.0 166.0 165.0 22:35:06 INFO - PROCESS | 14731 | 22:35:06 INFO - PROCESS | 14731 | [#3] audio-fft Cycles:10 Average:95.10 Median:77.00 stddev:38.50 (50.0%) stddev-sans-first:40.27 22:35:06 INFO - PROCESS | 14731 | Values: 77.0 76.0 77.0 163.0 77.0 77.0 76.0 77.0 173.0 78.0 22:35:06 INFO - PROCESS | 14731 | 22:35:06 INFO - PROCESS | 14731 | [#4] audio-oscillator Cycles:10 Average:111.20 Median:94.50 stddev:25.39 (26.9%) stddev-sans-first:26.54 22:35:06 INFO - PROCESS | 14731 | Values: 99.0 94.0 147.0 96.0 95.0 94.0 142.0 98.0 93.0 154.0 22:35:06 INFO - PROCESS | 14731 | 22:35:06 INFO - PROCESS | 14731 | [#5] imaging-gaussian-blur Cycles:10 Average:118.40 Median:119.00 stddev:0.70 (0.6%) stddev-sans-first:0.73 22:35:06 INFO - PROCESS | 14731 | Values: 118.0 119.0 117.0 118.0 118.0 119.0 118.0 119.0 119.0 119.0 22:35:06 INFO - PROCESS | 14731 | 22:35:06 INFO - PROCESS | 14731 | [#6] imaging-darkroom Cycles:10 Average:147.90 Median:148.00 stddev:1.29 (0.9%) stddev-sans-first:1.36 22:35:06 INFO - PROCESS | 14731 | Values: 148.0 151.0 147.0 147.0 148.0 148.0 147.0 147.0 149.0 147.0 22:35:06 INFO - PROCESS | 14731 | 22:35:06 INFO - PROCESS | 14731 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 22:35:06 INFO - PROCESS | 14731 | Values: 96.0 96.0 95.0 96.0 95.0 95.0 96.0 96.0 95.0 96.0 22:35:06 INFO - PROCESS | 14731 | 22:35:06 INFO - PROCESS | 14731 | [#8] json-parse-financial Cycles:10 Average:68.50 Median:67.00 stddev:6.62 (9.9%) stddev-sans-first:6.90 22:35:06 INFO - PROCESS | 14731 | Values: 65.0 68.0 66.0 68.0 67.0 67.0 67.0 87.0 66.0 64.0 22:35:06 INFO - PROCESS | 14731 | 22:35:06 INFO - PROCESS | 14731 | [#9] json-stringify-tinderbox Cycles:10 Average:64.80 Median:65.00 stddev:0.92 (1.4%) stddev-sans-first:0.97 22:35:06 INFO - PROCESS | 14731 | Values: 65.0 65.0 64.0 65.0 64.0 64.0 65.0 64.0 67.0 65.0 22:35:06 INFO - PROCESS | 14731 | 22:35:06 INFO - PROCESS | 14731 | [#10] stanford-crypto-aes Cycles:10 Average:85.40 Median:84.00 stddev:3.47 (4.1%) stddev-sans-first:3.57 22:35:06 INFO - PROCESS | 14731 | Values: 83.0 87.0 83.0 94.0 83.0 84.0 88.0 84.0 84.0 84.0 22:35:06 INFO - PROCESS | 14731 | 22:35:06 INFO - PROCESS | 14731 | [#11] stanford-crypto-ccm Cycles:10 Average:150.30 Median:148.50 stddev:23.97 (16.1%) stddev-sans-first:24.69 22:35:06 INFO - PROCESS | 14731 | Values: 134.0 141.0 153.0 151.0 136.0 146.0 158.0 136.0 214.0 134.0 22:35:06 INFO - PROCESS | 14731 | 22:35:06 INFO - PROCESS | 14731 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.40 Median:181.50 stddev:3.03 (1.7%) stddev-sans-first:3.15 22:35:06 INFO - PROCESS | 14731 | Values: 182.0 180.0 184.0 181.0 182.0 175.0 184.0 179.0 176.0 181.0 22:35:06 INFO - PROCESS | 14731 | 22:35:06 INFO - PROCESS | 14731 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.40 Median:71.00 stddev:1.65 (2.3%) stddev-sans-first:1.73 22:35:06 INFO - PROCESS | 14731 | Values: 71.0 69.0 69.0 71.0 70.0 72.0 73.0 68.0 69.0 72.0 22:35:06 INFO - PROCESS | 14731 | -------- Summary: end -------- 22:35:06 INFO - PROCESS | 14731 | 22:35:08 INFO - TEST-INFO | 14731: exit 0 22:35:08 INFO - TEST-OK | kraken | took 63906ms 22:35:08 INFO - SUITE-END | took 1179s 22:35:08 INFO - Completed test suite (00:19:39) 22:35:08 INFO - javascript benchmark 22:35:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2682.436688295458, 2728.399752054547, 2732.330579008143, 2778.2359851040974, 2792.958105628416, 4731.195696731551, 4839.661223714342, 4882.51174882512, 4902.803887844482, 4911.0, 4775.832845850396, 4858.708477491344, 4881.36542249508, 4902.901941961159, 4939.678920870141, 4454.443194600675, 4535.183666939949, 4578.262735976206, 4596.21864283071, 4640.698354606957, 4508.346289787979, 4615.699979501322, 4629.768511574424, 4655.068986202756, 4662.3705799716945, 4392.231359512072, 4465.977670111629, 4478.619317358029, 4519.367288579601, 4564.338170965191, 4451.087527056946, 4452.465704115494, 4455.064436468313, 4461.732296062214, 4469.9106017879785, 4488.147252022105, 4509.413776209105, 4510.526394728539, 4547.18150732868, 4552.0, 4671.579557839811, 4733.100710864925, 4740.478547359788, 4766.571008609207, 4782.258749893737, 5169.095408303532, 5210.296609957645, 5211.452797456251, 5214.582833373321, 5266.894662106774, 5156.303898973665, 5239.449857764956, 5252.133397989327, 5255.947440525584, 5260.421353651133, 4813.109574728686, 4824.5899098576665, 4856.198727210041, 4865.464798872121, 4869.0, 5311.176767601028, 5315.813946511931, 5346.331708536433, 5357.624966252325, 5360.088784906575, 5051.722155281494, 5095.8726031848755, 5109.412417572027, 5133.768980395891, 5145.897082058338, 5242.842714718565, 5268.157094864803, 5273.525382715574, 5284.07528682479, 5338.3060202173465, 5053.166227572409, 5059.114654935372, 5074.264231686385, 5125.513076257749, 5139.691618502902, 5021.548060674557, 5125.359330083739, 5191.922121168185, 5200.193969934666, 5202.687838729688, 4447.977760111179, 4484.618807401343, 4505.594496495331, 4532.9546704533195, 4541.205289074464, 3856.845726170922, 3865.40086286626, 3883.611638836094, 3890.280298144852, 3944.3886197639413, 4395.252807022814, 4462.642988560908, 4476.149531588988, 4556.703814252063, 4574.039451715111, 5335.466453354711, 5355.678659280456, 5396.568274538106, 5410.242566040757, 5412.621116521885, 4551.613112885442, 4560.224761790503, 4590.219662657356, 4610.884727881763, 4635.397398338195, 4655.998960223568, 4675.532446755297, 4695.835645752382, 4827.25177597473, 4862.0, 4902.264660300983, 4929.507049295042, 4930.33440485537, 4953.529414705597, 4962.330085438492, 5236.0, 5243.868903277296, 5248.0, 5250.763715632882, 5290.047791397586, 4845.200541910686, 4929.753512324298, 4935.555799978019, 4984.102861484967, 4993.500649934977, 5253.212018197301, 5264.0261551613075, 5267.4469180737005, 5268.473152684701, 5292.391374991926, 5338.919916201183, 5347.385050719217, 5347.7593508293, 5348.331458567679, 5367.490088441748, 4931.72875491837, 4977.776000079933, 5096.898062038665, 5111.948880511296, 5118.846434606968, 5110.591152707849, 5137.614678899023, 5149.87125321855, 5161.148410512224, 5179.19722443022, 5032.119379108714, 5060.569851562658, 5085.440601533903, 5116.616253780907, 5120.02719483297, 4934.777934993006, 5077.238414237894, 5146.742662866767, 5168.0, 5194.220866869849, 5037.017781532566, 5054.241863720471, 5083.669561478492, 5092.923606145985, 5098.79604815818], "value": 4813.399373431006, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [563.1243416487363, 597.4145337569182, 603.1646170054474, 605.4490413723511, 633.4552285034872, 36593.0, 40980.795096024514, 41122.177556448856, 41143.58856411443, 41188.382174267375, 41059.17881642366, 41299.38050929231, 41605.58394416055, 41681.0, 41714.37428438576, 7734.7679569613, 7929.563873986928, 7935.523868567904, 7943.72196973106, 7945.761627151166, 7734.7679569613, 7756.844863102735, 7819.882701759479, 7824.139344672081, 7836.412269079813, 7801.102873169573, 7863.0, 7873.842523149534, 7887.329576985963, 7892.60536973149, 7802.804929876742, 7818.4136189785995, 7825.882611760828, 7846.960765196166, 7860.174681658401, 7789.2989630932925, 7855.803604909923, 7862.606869656494, 7874.251946065115, 7895.763127106138, 31459.0, 37903.24193516114, 38088.42867356992, 38102.61897381046, 38280.61719382798, 3194.7923384979904, 3231.7737758356925, 3296.4231259529724, 3303.1411832923372, 3357.0, 28718.0, 29193.854030729923, 29198.562021569694, 30597.235069123228, 32196.517052244235, 3444.9311013779834, 3454.4300190468543, 3489.7208223342072, 3561.216532362876, 3579.910502237439, 253484.0, 257409.0, 257604.0, 257604.0, 259484.0, 34547.82726086354, 35989.28021439609, 61198.08202876872, 61199.38800612026, 61923.0, 36948.630513694516, 36970.81514592464, 37056.0, 37076.629233707856, 37264.83248923872, 14626.926865365605, 14759.409623614934, 14830.851691483163, 14836.406543738129, 14947.252637368088, 12059.517619295306, 12198.207116537396, 12231.082668799698, 12289.877101229053, 12327.075469339656, 8401.621927013299, 8424.536650484282, 8426.957865210634, 8539.615717292736, 8547.700830470903, 3357.3956687795944, 3366.5286859839644, 3406.7104296135108, 3412.675795799395, 3447.3450044491465, 910.3763921713647, 937.7702462896634, 949.924006079512, 963.5663951221978, 1015.7968406318765, 27524.0, 28922.421551568852, 29170.854145729136, 29367.412651746847, 29401.11796646104, 979.2606582030521, 1024.8872624011353, 1037.9117774989058, 1080.983785243222, 1086.9891301087046, 15123.773143402857, 15315.0, 15504.30230639624, 15553.844461555465, 15880.52358429249, 342721.0, 345831.0, 347149.0, 347474.0, 348010.0, 51044.489555104716, 52101.218481722804, 52227.21659175115, 52242.47757522452, 52325.47674523206, 1260.590308149855, 1277.3740866975115, 1287.3756228229302, 1287.993560032194, 1298.7921932490756, 27164.32089197786, 27987.0, 28173.295667608472, 28359.43281134407, 28765.0, 43403.565964339956, 43533.12933741371, 43545.78227108844, 43576.12847743091, 43658.781706091264, 283301.0, 289721.0, 290461.0, 290682.0, 291575.0, 26293.868530657226, 26627.33431664224, 26721.465570688866, 26758.331041724112, 26866.59700104461, 42432.0, 43543.564564353954, 43579.128417432104, 44110.11779764322, 44743.10513789771, 37613.2477350446, 37628.24743505169, 37633.435498467, 37967.62032379751, 38336.616633833306, 36818.0, 37382.0, 37550.0, 37574.43638345482, 37928.620713793614, 35945.0, 36746.26507469889, 36997.63002369942, 37404.43893341657, 37486.25027499489, 32221.78580129372, 33768.662313377536, 33968.81109161266, 34082.0, 34175.65824341824, 25686.357841054123, 25857.0, 26128.73871261263, 26214.791264712127, 26404.20787376382], "value": 16971.0515387942, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [371.9646633569811, 371.97582157159786, 373.74398537002173, 378.9431585262212, 390.1728335927833, 16044.919775401122, 16331.183440827956, 16782.244798984044, 17463.825361746378, 17591.296348146076, 15202.923985380057, 15242.314095865684, 15324.310406031727, 15463.613409664764, 15578.766318505232, 5097.668651537648, 5311.309529761125, 5334.893302133955, 5376.247325374451, 5386.138217885139, 5269.683818970855, 5281.683099014072, 5293.15309550472, 5336.30628018359, 5346.91979620306, 5138.486151384869, 5175.663581867167, 5217.634765566412, 5268.5521730652945, 5295.0468915595175, 5184.377874655028, 5200.92198617021, 5219.086659834533, 5272.367315922113, 5279.41926388097, 4597.632189424838, 4661.044485880387, 4674.298855171717, 4686.250199967989, 4711.0342379812055, 20255.392338229878, 20480.795192048037, 21007.684884726743, 21112.0, 21188.0, 1954.9022548872642, 1976.328048463515, 2068.2037415594955, 2135.9572808543744, 2174.5626967366516, 13329.266890321029, 13442.462301507929, 13490.797638035438, 13633.931830340884, 13875.306234688225, 1737.2182517866884, 1748.1084646830082, 1765.0821572782081, 1776.3427531813184, 1967.9901600492049, 61939.69030154865, 61940.69029654868, 66753.99999999952, 68201.0, 69755.30244697539, 9820.508974551387, 9894.55474503649, 10064.245181611408, 10092.646757363604, 10230.744231394274, 13906.0, 13909.79135312971, 13983.650408739863, 14035.736783689314, 14071.226082565558, 7515.549067055994, 7531.736389226351, 7572.583507907118, 7624.504407213513, 7736.961315193501, 7370.77887663371, 7408.925910740823, 7431.3683336916965, 7570.16728159902, 7580.0145981022115, 4229.0, 4309.1381723655395, 4378.671599630041, 4437.556244375602, 4467.7319360838455, 1838.2187570282576, 1849.2787812753038, 1881.2569035231281, 1887.6413481438483, 1897.5578560294, 874.4534665833854, 888.5646033443566, 936.5270538378076, 947.7535840681335, 997.1374760831973, 16680.74978875318, 17104.57238569046, 17295.827041729422, 17576.38482653101, 17702.468925932244, 876.6931573949195, 906.4380084347747, 931.8928323242778, 948.7296120605595, 971.8930917599058, 9685.32202745815, 9812.95093524542, 9840.606375745034, 9937.602495900082, 9967.451790151466, 373726.0, 380283.0, 386718.0, 388230.0, 388439.0, 81398.0, 84574.57712711397, 85002.0, 86326.0, 87035.56482217548, 948.3551185193996, 953.6328513522205, 965.1844191658038, 967.3180407812475, 973.1436336024253, 14946.476873309382, 15392.538223853302, 15628.687426251185, 15751.842481575037, 15869.444569440015, 29979.0, 35508.467372989944, 36391.45412818757, 36619.63380366162, 36926.6307336934, 48643.75678121587, 50518.98962020812, 51566.0, 51825.04342964422, 52079.0, 7658.463907526642, 7818.843623127392, 7842.490238134503, 7842.686292548234, 7972.601369931364, 6023.939760602338, 7114.893276600752, 10169.542370593193, 10500.317479363817, 10911.0, 9395.530223488935, 9447.385919915183, 9526.285528585246, 9530.904690953279, 10081.395116293046, 9588.56851441673, 9806.0, 9809.411435313905, 9833.655822046194, 10087.596496140366, 9686.951565242129, 10189.28674992773, 10210.744731381776, 10333.48332583383, 10714.357138571711, 7462.850742985219, 7625.199354067743, 7803.8829417557645, 7863.252990965849, 7922.683092676459, 9891.752706182404, 9960.452175130438, 10003.0, 10104.242181836245, 10205.336653117523], "value": 8264.424394580677, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1359.4562175129947, 1480.740870347689, 1635.4929971708764, 1802.3061121468231, 1817.7818661760598, 6426.164598602175, 7277.818054548639, 7381.446391520644, 7617.619119044047, 7698.615069246536, 7532.397408207344, 7683.423743219253, 7715.189905059972, 7734.03324584427, 7752.341051010657, 2207.348832094528, 2230.631945728953, 2248.685184074231, 2249.089118906837, 2255.2444930948154, 2158.956820863582, 2161.6109100361928, 2190.802827745503, 2192.9342119736434, 2193.5283913958497, 2151.107290474451, 2161.870287782738, 2170.1536400803698, 2179.6512557990723, 2189.321310393775, 2113.3131732187026, 2136.4979229880964, 2136.7329083864515, 2141.2933731868447, 2148.3125399872047, 2091.4144039668918, 2128.063651993118, 2129.2760461443027, 2134.551744133734, 2136.145541783299, 7698.076230852277, 7729.304362607392, 7760.767176984699, 7767.844643107106, 7788.376929845599, 4277.2087163874785, 4391.341298805205, 4489.0, 4550.931736023929, 4557.407537020199, 2717.184844546628, 2862.842543660098, 2872.195785180153, 2883.3224192314788, 2886.682464928856, 920.9125133112343, 928.0672923711627, 935.6678379175431, 936.8220038192721, 968.3560432312504, 9966.40201587907, 10052.597896084148, 10054.095131438205, 10095.949520252425, 10121.645742398981, 4051.9392209116886, 4089.672826173899, 4100.897477563025, 4109.486314210723, 4120.887360412672, 8741.825163496695, 8745.475271483605, 8769.166929141722, 8799.0, 8807.955960220286, 4340.827976446341, 4357.564243575617, 4410.977945110254, 4468.396766436555, 4498.595126438636, 3495.9300813984087, 4015.31739604268, 4046.838126474908, 4119.711620186618, 4268.210381079511, 3592.8742494012586, 3613.2050948791225, 3701.759385639925, 3744.344739670547, 3871.9419208711893, 1143.1369316166242, 1203.554684766642, 1204.7650708111835, 1213.805791073424, 1219.5000049979644, 869.1482347299556, 881.3918396306528, 884.274894586433, 895.0646574329841, 927.5779520318239, 5172.043172013115, 5174.301469301596, 5237.135872581058, 5274.657147285414, 5474.808381706701, 911.3119594706087, 919.2370332623906, 920.4753290624279, 943.4622265308845, 956.1442508954585, 3587.0673624857723, 3798.4682144499793, 3798.924021519554, 3810.733248672622, 3823.101571130782, 9014.323925705598, 9100.408473449204, 9463.952680236693, 9490.667826626035, 9510.191633711074, 9328.300377471716, 9345.906540934504, 9409.811803764023, 9444.338896277195, 9491.050894910592, 7107.431405487549, 7144.714211431485, 7219.927800722031, 7225.349718525253, 7287.41700663935, 5192.870178245574, 5226.817061402832, 5264.052470555183, 5356.866078348073, 5366.651167674088, 8309.501429914224, 8379.329653627574, 8532.44539104981, 8609.741707748777, 8719.91280087191, 8549.957250213709, 8711.21599056088, 8728.78178045554, 8910.910890891008, 8929.330300227379, 5911.261092363455, 6504.60972341661, 6729.966350168218, 6748.460123190232, 6886.552374095668, 7190.101237345332, 7220.422366210585, 7231.746888858865, 7243.45674074457, 7303.452241081834, 6585.242697089896, 6626.403623673892, 6645.933540664531, 6749.898751518633, 6867.896981545381, 6535.869282614226, 6591.571547849375, 6618.338166183343, 6630.071789949315, 6665.900011499734, 6267.843303917256, 6311.558190926775, 6322.399372059647, 6368.108464814837, 6377.553571250153, 4493.573110554492, 4602.21762300403, 4686.929696054493, 4703.129920964632, 4805.7597120143155, 4398.428204333416, 4474.9328760069275, 4550.385697930737, 4558.133954548758, 4584.4498660161], "value": 4113.454916073587, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [296.361341309478, 300.1311204064234, 302.9348690031643, 307.2870939420545, 309.3658001097749, 4826.686265392747, 4866.562009419152, 4936.753162341886, 5004.124278251305, 5105.208692652635, 4818.27725841124, 4910.0, 4910.386201724785, 4936.284238785374, 4952.959878425535, 3898.9805050974846, 3929.3516569766025, 3941.7043721720843, 3951.0122469382654, 3954.545227298854, 3650.4524321351746, 3932.1742434088874, 3947.9537922450572, 3958.366661334187, 3960.782156981365, 3811.7331786774935, 3817.522809648794, 3825.8087095645246, 3826.426036094594, 3835.5013848199833, 3846.6345697159004, 3846.807659617036, 3850.5186851643543, 3865.3042452358563, 3883.970747751834, 3387.6951074403178, 3390.338883917637, 3393.881214157517, 3411.9317613647836, 3412.4028295048265, 4716.29255611661, 4718.386609740712, 4739.905201895943, 4749.762511874427, 4826.903461930777, 4342.565743425664, 4363.170997510495, 4371.213181627306, 4377.584129507692, 4392.143532011227, 5178.766955487012, 5195.636305458619, 5220.347456567929, 5221.138512145491, 5224.582033437316, 3527.976886702853, 3646.47126166707, 3677.889663310105, 3684.852605895761, 3687.0, 5458.0721277382545, 5495.697736624484, 5504.2018907258625, 5543.390227075019, 5562.805301814457, 3722.571904230994, 3758.191988722383, 3767.434884767307, 3768.2651882882574, 3776.546814382237, 3812.0, 3816.8358650611276, 3822.4648549203134, 3826.8277927492773, 3832.3676593362343, 4217.915641687149, 4310.676699247506, 4330.848420305274, 4356.607905288476, 4361.280388735823, 5237.73811309433, 5241.50205730455, 5255.369355677343, 5271.341082364705, 5295.523402893758, 1220.725336799231, 1240.1752834365227, 1273.8471383434048, 1277.9105462617713, 1280.6030130659526, 852.7910661887877, 872.8609165039684, 881.1452890696015, 882.1619461511461, 887.2857349833317, 4420.977895110504, 4440.422745043188, 4448.199324121689, 4457.910841783146, 4519.480259770103, 5124.769385377667, 5144.382674079135, 5174.008006917364, 5228.816991405282, 5241.68549887008, 4417.53615870329, 4418.668599855024, 4422.248217802981, 4471.776411179428, 4495.2582823834355, 2635.262126604554, 2806.877249100376, 2810.2693299741804, 2821.3651928315967, 2822.5907243449997, 4912.091263116335, 4990.128701736849, 5002.874353270558, 5038.193888977746, 5053.494650534917, 5277.683338999673, 5404.081306177959, 5439.564834813205, 5445.128779395278, 5486.286782718221, 4995.350604421402, 4999.100521697479, 5006.949930500721, 5007.799688012512, 5011.924821127686, 5173.689578625144, 5283.762230699705, 5294.814681486129, 5340.198970154508, 5341.946580534145, 4978.576820970114, 5208.192730126836, 5227.366979948899, 5241.868953276198, 5265.340588291101, 4911.484294149206, 4913.606911447004, 4942.308076869169, 4946.7031978079995, 4950.727709975986, 3620.420732682758, 3677.1542545214215, 3682.8342724576924, 3693.076730817296, 3701.7979447778016, 5120.155174396332, 5278.4193738687945, 5289.2330612061805, 5314.681119132864, 5427.348718153847, 5220.791168353223, 5241.580673546031, 5242.633015688865, 5252.842414727565, 5290.761915713725, 5201.557867581298, 5259.579233661374, 5281.815136470205, 5288.418273989935, 5291.391489978701, 4851.781669824937, 5182.481751824938, 5202.453742356998, 5207.3751149862255, 5220.321358223407, 5252.290940722954, 5256.6320357574605, 5293.338332708411, 5316.308879845596, 5396.46035396473, 5194.246834208943, 5200.869978250423, 5207.479252074762, 5225.372955245395, 5246.291750613618], "value": 3891.869571335587, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [779.1157036763271, 782.6676504018022, 784.4430454377392, 800.879868019797, 804.231958479652, 10782.946085269583, 11045.28205666633, 11054.502547385368, 11069.391183484915, 11114.0, 11747.823782643267, 11846.703832404173, 11861.940690296537, 11900.880991190108, 11959.342236177006, 680.6936878404713, 858.5921687198578, 859.6260626627405, 868.7958329792493, 873.8732883731855, 853.9615717292737, 857.2199298638241, 857.6440777077537, 863.6890719341033, 865.4547634989948, 902.3773596218621, 905.4657751926362, 914.7301546043933, 917.0600134861787, 920.5075284722675, 905.6875377994581, 907.5054095517893, 908.5411867007152, 911.4349103555771, 916.1983264643437, 672.2504407585507, 672.4418732452053, 676.577139287945, 677.0791723256367, 677.9999500736424, 11692.298462092302, 11730.648080557512, 11749.001334886545, 11765.882341176564, 11783.823242651368, 12636.620901372973, 12786.262396601522, 12894.032947528973, 12926.28905410202, 13025.934870325682, 9629.181519570844, 9652.179564737005, 9688.321817472779, 9971.102600765893, 9976.501174941224, 3268.5587445694764, 3277.901662950115, 3284.310294838087, 3348.3470723208984, 3409.8636054558037, 44300.77849610763, 44788.55211447876, 44810.77594612039, 44814.32778508325, 45183.548164518266, 9850.556724947395, 9911.7026489204, 10091.0, 10095.899041009643, 10170.542325595366, 18266.086695665163, 18277.360292389967, 18477.0, 18480.0, 18820.81179188218, 6960.512764106464, 6967.79096627102, 7039.507234493639, 7120.0, 7212.423006159494, 3841.539015318124, 3897.142628621699, 3924.2151569685607, 3936.1340505088833, 3948.072203032285, 2575.9227223183334, 2681.5575430053823, 2682.2757855378936, 2683.9194824155306, 2685.3420911876715, 507.9009593129304, 509.03537795876605, 516.6770768269831, 520.9973950130225, 521.5228066319276, 598.3956204233668, 626.6490765171518, 629.9433051025429, 634.8190765631773, 637.1366797988659, 7068.126946359219, 7232.927670723226, 7247.347738703542, 7415.3326200642205, 7671.769846904602, 610.008735804318, 612.2530512774408, 614.3487902823022, 617.4443001298778, 617.9134921111048, 3721.1813401051727, 3743.9812800936365, 3773.113318370181, 3777.282316359938, 3870.9419358709642, 49241.26138107931, 49901.25148122781, 50123.24815127776, 50652.240216396785, 50679.23981140286, 44807.32789008167, 45363.0, 45818.770906145925, 46747.532524674316, 47279.5272047282, 42839.78580107142, 42955.570444295154, 42964.42213467202, 43524.0, 43816.78091609585, 7249.0, 7249.855002899807, 7282.96358518204, 7362.3741981932135, 7414.184439711519, 28424.431511369243, 29110.854445727637, 29454.410911781215, 29764.255893602833, 29773.702262977095, 34940.0, 36745.44881826828, 37141.814290929455, 37370.626293737805, 37798.055048624, 9392.95303523478, 9453.527323633929, 9511.904880951379, 9649.951750241486, 10009.299349045497, 10027.799444010932, 10046.447445390282, 10084.443405004879, 10175.806379501297, 10268.229882758673, 8965.7758556034, 9204.539773011456, 9353.158215760343, 9434.386764860263, 9631.229501639993, 9297.116773906468, 9352.719418417459, 9355.25157987373, 9356.485393303434, 9699.0, 8975.416597921114, 9104.408213466104, 9475.194608458358, 9491.952540237255, 9523.619055237712, 8202.958985205036, 8262.504249745034, 8398.748037558884, 8486.83026339482, 8519.701810436605, 8149.633266502903, 8368.330533557179, 8506.914930850613, 8603.569821508774, 8692.0], "value": 5797.981892250917, "unit": "score"}], "name": "dromaeo_css", "value": 6302.46367586264, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 118.0, 107.0, 116.0, 119.0, 114.0, 111.0, 116.0, 117.0, 116.0], "value": 114.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 131.0, 156.0, 190.0, 137.0, 168.0, 164.0, 136.0, 192.0, 149.0], "value": 158.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 165.0, 166.0, 171.0, 163.0, 164.0, 166.0, 164.0, 166.0, 165.0], "value": 165.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 77.0, 163.0, 77.0, 77.0, 76.0, 77.0, 173.0, 78.0], "value": 95.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 94.0, 147.0, 96.0, 95.0, 94.0, 142.0, 98.0, 93.0, 154.0], "value": 111.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 119.0, 117.0, 118.0, 118.0, 119.0, 118.0, 119.0, 119.0, 119.0], "value": 118.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 151.0, 147.0, 147.0, 148.0, 148.0, 147.0, 147.0, 149.0, 147.0], "value": 147.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 95.0, 96.0, 95.0, 95.0, 96.0, 96.0, 95.0, 96.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 68.0, 66.0, 68.0, 67.0, 67.0, 67.0, 87.0, 66.0, 64.0], "value": 68.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 64.0, 65.0, 64.0, 64.0, 65.0, 64.0, 67.0, 65.0], "value": 64.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 87.0, 83.0, 94.0, 83.0, 84.0, 88.0, 84.0, 84.0, 84.0], "value": 85.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 141.0, 153.0, 151.0, 136.0, 146.0, 158.0, 136.0, 214.0, 134.0], "value": 150.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 180.0, 184.0, 181.0, 182.0, 175.0, 184.0, 179.0, 176.0, 181.0], "value": 180.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 69.0, 69.0, 71.0, 70.0, 72.0, 73.0, 68.0, 69.0, 72.0], "value": 70.4, "unit": "score"}], "name": "kraken", "value": 1626.9, "alertThreshold": 2.0}]} 22:35:08 INFO - Return code: 0 22:35:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 22:35:08 ERROR - # TBPL SUCCESS # 22:35:08 INFO - Running post-action listener: _resource_record_post_action 22:35:08 INFO - Running post-run listener: _resource_record_post_run 22:35:09 INFO - Total resource usage - Wall time: 1196s; CPU: 14.0%; Read bytes: 4096; Write bytes: 525697024; Read time: 16; Write time: 433284 22:35:09 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 241963008; Read time: 0; Write time: 272216 22:35:09 INFO - run-tests - Wall time: 1181s; CPU: 14.0%; Read bytes: 4096; Write bytes: 283734016; Read time: 16; Write time: 161068 22:35:09 INFO - Running post-run listener: _upload_blobber_files 22:35:09 INFO - Blob upload gear active. 22:35:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:35:09 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 22:35:09 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'] 22:35:09 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 22:35:09 INFO - (blobuploader) - INFO - Open directory for files ... 22:35:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 22:35:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:35:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:35:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 22:35:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:35:11 INFO - (blobuploader) - INFO - Done attempting. 22:35:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 22:35:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:35:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:35:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 22:35:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:35:11 INFO - (blobuploader) - INFO - Done attempting. 22:35:11 INFO - (blobuploader) - INFO - Iteration through files over. 22:35:11 INFO - Return code: 0 22:35:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:35:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:35:11 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6c9f0a6fc076e441ef68b2a8aa8b89aa10545e3b50a653d71c1e55cb1a770bc2af0706a61a6a787fc6c438677a06a0423cd072fe721cd4997b089c7b576be036", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/149e3ad8517ce95f86f65d08bdf7241cc86e3a8e7d66c2c3c05a1ad76b2be03a24bf81fd22894914f759d0769a4df26cb1d48540eae4eb9ba7ab82a4843b6ff5"} 22:35:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:35:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:35:11 INFO - Contents: 22:35:11 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6c9f0a6fc076e441ef68b2a8aa8b89aa10545e3b50a653d71c1e55cb1a770bc2af0706a61a6a787fc6c438677a06a0423cd072fe721cd4997b089c7b576be036", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/149e3ad8517ce95f86f65d08bdf7241cc86e3a8e7d66c2c3c05a1ad76b2be03a24bf81fd22894914f759d0769a4df26cb1d48540eae4eb9ba7ab82a4843b6ff5"} 22:35:11 INFO - Running post-run listener: copy_logs_to_upload_dir 22:35:11 INFO - Copying logs to upload dir... 22:35:11 INFO - mkdir: /builds/slave/test/build/upload/logs 22:35:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.652617 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-05-05 22:35:11.572072) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-05 22:35:11.575836) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1462510044.673532-1926271636 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/6c9f0a6fc076e441ef68b2a8aa8b89aa10545e3b50a653d71c1e55cb1a770bc2af0706a61a6a787fc6c438677a06a0423cd072fe721cd4997b089c7b576be036", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/149e3ad8517ce95f86f65d08bdf7241cc86e3a8e7d66c2c3c05a1ad76b2be03a24bf81fd22894914f759d0769a4df26cb1d48540eae4eb9ba7ab82a4843b6ff5"} build_url:https://queue.taskcluster.net/v1/task/Xea2NRyzQOeIuXv9TlRWKQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011454 build_url: 'https://queue.taskcluster.net/v1/task/Xea2NRyzQOeIuXv9TlRWKQ/artifacts/public/build/firefox-49.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/6c9f0a6fc076e441ef68b2a8aa8b89aa10545e3b50a653d71c1e55cb1a770bc2af0706a61a6a787fc6c438677a06a0423cd072fe721cd4997b089c7b576be036", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/149e3ad8517ce95f86f65d08bdf7241cc86e3a8e7d66c2c3c05a1ad76b2be03a24bf81fd22894914f759d0769a4df26cb1d48540eae4eb9ba7ab82a4843b6ff5"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-05 22:35:11.600043) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 22:35:11.600336) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1462510044.673532-1926271636 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004450 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 22:35:11.685418) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-05 22:35:11.685840) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-05 22:35:11.686276) ========= ========= Total master_lag: 0.17 =========