builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-016 starttime: 1462823432.81 results: success (0) buildid: 20160509121157 builduid: aa80eae7e33f48fd9be8129e1c41b954 revision: 4dd60a8b9e2b229e8551c08ad4302433081ecced ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-09 12:50:32.811177) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-09 12:50:32.811677) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-09 12:50:32.811949) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-09 12:50:32.857980) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 12:50:32.858249) ========= 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=00204705a9daa57ed339a427000001b9-1462823336.495322-2045218319 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-09 12:50: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.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.7M=0s 2016-05-09 12:50:33 (42.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.229681 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 12:50:33.114998) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 12:50:33.115322) ========= 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=00204705a9daa57ed339a427000001b9-1462823336.495322-2045218319 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015242 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 12:50:33.165078) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 12:50:33.165401) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 4dd60a8b9e2b229e8551c08ad4302433081ecced --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 4dd60a8b9e2b229e8551c08ad4302433081ecced --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=00204705a9daa57ed339a427000001b9-1462823336.495322-2045218319 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-09 12:50:33,359 truncating revision to first 12 chars 2016-05-09 12:50:33,359 Setting DEBUG logging. 2016-05-09 12:50:33,359 attempt 1/10 2016-05-09 12:50:33,359 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/4dd60a8b9e2b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-09 12:50:33,608 unpacking tar archive at: fx-team-4dd60a8b9e2b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.539270 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 12:50:33.717080) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-09 12:50:33.717391) ========= script_repo_revision: 4dd60a8b9e2b229e8551c08ad4302433081ecced ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-09 12:50:33.717781) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-09 12:50:33.718049) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-09 12:50:33.725141) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-05-09 12:50:33.725420) ========= /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=00204705a9daa57ed339a427000001b9-1462823336.495322-2045218319 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:50:33 INFO - MultiFileLogger online at 20160509 12:50:33 in /builds/slave/test 12:50:33 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 12:50:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:50:34 INFO - {'append_to_log': False, 12:50:34 INFO - 'base_work_dir': '/builds/slave/test', 12:50:34 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 12:50:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:50:34 INFO - 'branch': 'Fx-Team-Non-PGO', 12:50:34 INFO - 'buildbot_json_path': 'buildprops.json', 12:50:34 INFO - 'config_files': ('talos/linux_config.py',), 12:50:34 INFO - 'default_actions': ('clobber', 12:50:34 INFO - 'read-buildbot-config', 12:50:34 INFO - 'download-and-extract', 12:50:34 INFO - 'populate-webroot', 12:50:34 INFO - 'create-virtualenv', 12:50:34 INFO - 'install', 12:50:34 INFO - 'run-tests'), 12:50:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:50:34 INFO - 'download_minidump_stackwalk': True, 12:50:34 INFO - 'download_symbols': 'ondemand', 12:50:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:50:34 INFO - 'tooltool.py': '/tools/tooltool.py', 12:50:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:50:34 INFO - '/tools/misc-python/virtualenv.py')}, 12:50:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:50:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:50:34 INFO - 'installer_path': 'installer.exe', 12:50:34 INFO - 'log_level': 'info', 12:50:34 INFO - 'log_name': 'talos', 12:50:34 INFO - 'log_to_console': True, 12:50:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:50:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:50:34 INFO - 'opt_config_files': (), 12:50:34 INFO - 'pip_index': False, 12:50:34 INFO - 'sps_profile': False, 12:50:34 INFO - 'sps_profile_interval': 0, 12:50:34 INFO - 'suite': 'dromaeojs-e10s', 12:50:34 INFO - 'system_bits': '32', 12:50:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:50:34 INFO - 'title': 'talos-linux64-ix-016', 12:50:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:50:34 INFO - 'use_talos_json': True, 12:50:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:50:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:50:34 INFO - 'work_dir': 'build'} 12:50:34 INFO - ##### 12:50:34 INFO - ##### Running clobber step. 12:50:34 INFO - ##### 12:50:34 INFO - Running pre-action listener: _resource_record_pre_action 12:50:34 INFO - Running main action method: clobber 12:50:34 INFO - rmtree: /builds/slave/test/build 12:50:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:50:34 INFO - Running post-action listener: _resource_record_post_action 12:50:34 INFO - ##### 12:50:34 INFO - ##### Finished clobber step (success) 12:50:34 INFO - ##### 12:50:34 INFO - ##### 12:50:34 INFO - ##### Running read-buildbot-config step. 12:50:34 INFO - ##### 12:50:34 INFO - Running pre-action listener: _resource_record_pre_action 12:50:34 INFO - Running main action method: read_buildbot_config 12:50:34 INFO - Using buildbot properties: 12:50:34 INFO - { 12:50:34 INFO - "project": "", 12:50:34 INFO - "product": "firefox", 12:50:34 INFO - "script_repo_revision": "production", 12:50:34 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 12:50:34 INFO - "repository": "", 12:50:34 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 12:50:34 INFO - "buildid": "20160509121157", 12:50:34 INFO - "pgo_build": "False", 12:50:34 INFO - "basedir": "/builds/slave/test", 12:50:34 INFO - "buildnumber": 1267, 12:50:34 INFO - "slavename": "talos-linux64-ix-016", 12:50:34 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 12:50:34 INFO - "platform": "ubuntu64_hw", 12:50:34 INFO - "scheduler": "tests-fx-team-linux64-talos", 12:50:34 INFO - "branch": "fx-team", 12:50:34 INFO - "repo_path": "integration/fx-team", 12:50:34 INFO - "revision": "4dd60a8b9e2b229e8551c08ad4302433081ecced", 12:50:34 INFO - "stage_platform": "linux64", 12:50:34 INFO - "builduid": "aa80eae7e33f48fd9be8129e1c41b954", 12:50:34 INFO - "slavebuilddir": "test" 12:50:34 INFO - } 12:50:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/efMoi9YaTICmX3WldmYg7Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 12:50:34 INFO - Running post-action listener: _resource_record_post_action 12:50:34 INFO - ##### 12:50:34 INFO - ##### Finished read-buildbot-config step (success) 12:50:34 INFO - ##### 12:50:34 INFO - ##### 12:50:34 INFO - ##### Running download-and-extract step. 12:50:34 INFO - ##### 12:50:34 INFO - Running pre-action listener: _resource_record_pre_action 12:50:34 INFO - Running main action method: download_and_extract 12:50:34 INFO - mkdir: /builds/slave/test/build/tests 12:50: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')]} 12:50:34 INFO - https://queue.taskcluster.net/v1/task/efMoi9YaTICmX3WldmYg7Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 12:50:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/efMoi9YaTICmX3WldmYg7Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 12:50:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/efMoi9YaTICmX3WldmYg7Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 12:50:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/efMoi9YaTICmX3WldmYg7Q/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 12:50:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/efMoi9YaTICmX3WldmYg7Q/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 12:50:42 INFO - Downloaded 1361 bytes. 12:50:42 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 12:50:42 INFO - Using the following test package requirements: 12:50:42 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 12:50:42 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 12:50:42 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:50:42 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 12:50:42 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 12:50:42 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 12:50:42 INFO - u'jsshell-linux-x86_64.zip'], 12:50:42 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 12:50:42 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:50:42 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 12:50:42 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 12:50:42 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:50:42 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 12:50:42 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:50:42 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 12:50:42 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:50:42 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 12:50:42 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:50:42 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:50:42 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')]} 12:50:42 INFO - https://queue.taskcluster.net/v1/task/efMoi9YaTICmX3WldmYg7Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:50:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/efMoi9YaTICmX3WldmYg7Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 12:50:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/efMoi9YaTICmX3WldmYg7Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 12:50:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/efMoi9YaTICmX3WldmYg7Q/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 12:50:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/efMoi9YaTICmX3WldmYg7Q/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 12:50:46 INFO - Downloaded 22322863 bytes. 12:50:46 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'] 12:50:46 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 12:50:47 INFO - Return code: 0 12:50:47 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 12:50:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:50:47 INFO - https://queue.taskcluster.net/v1/task/efMoi9YaTICmX3WldmYg7Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:50:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/efMoi9YaTICmX3WldmYg7Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 12:50:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/efMoi9YaTICmX3WldmYg7Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 12:50:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/efMoi9YaTICmX3WldmYg7Q/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 12:50:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/efMoi9YaTICmX3WldmYg7Q/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 12:50:49 INFO - Downloaded 22322863 bytes. 12:50:49 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'] 12:50:49 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 12:50:50 INFO - Return code: 0 12:50: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')]} 12:50:50 INFO - https://queue.taskcluster.net/v1/task/efMoi9YaTICmX3WldmYg7Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 12:50:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/efMoi9YaTICmX3WldmYg7Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 12:50:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/efMoi9YaTICmX3WldmYg7Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 12:50:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/efMoi9YaTICmX3WldmYg7Q/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 12:50:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/efMoi9YaTICmX3WldmYg7Q/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 12:50:51 INFO - Downloaded 10840152 bytes. 12:50:51 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'] 12:50:51 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 12:50:51 INFO - Return code: 0 12:50:51 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')]} 12:50:51 INFO - https://queue.taskcluster.net/v1/task/efMoi9YaTICmX3WldmYg7Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:50:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/efMoi9YaTICmX3WldmYg7Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 12:50:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/efMoi9YaTICmX3WldmYg7Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 12:50:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/efMoi9YaTICmX3WldmYg7Q/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 12:50:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/efMoi9YaTICmX3WldmYg7Q/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 12:50:53 INFO - Downloaded 54859787 bytes. 12:50:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/efMoi9YaTICmX3WldmYg7Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 12:50:53 INFO - mkdir: /builds/slave/test/properties 12:50:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:50:53 INFO - Writing to file /builds/slave/test/properties/build_url 12:50:53 INFO - Contents: 12:50:53 INFO - build_url:https://queue.taskcluster.net/v1/task/efMoi9YaTICmX3WldmYg7Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 12:50:54 INFO - Running post-action listener: _resource_record_post_action 12:50:54 INFO - Running post-action listener: set_extra_try_arguments 12:50:54 INFO - ##### 12:50:54 INFO - ##### Finished download-and-extract step (success) 12:50:54 INFO - ##### 12:50:54 INFO - ##### 12:50:54 INFO - ##### Running populate-webroot step. 12:50:54 INFO - ##### 12:50:54 INFO - Running pre-action listener: _resource_record_pre_action 12:50:54 INFO - Running main action method: populate_webroot 12:50:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:50:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:50:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:50:54 INFO - '--tppagecycles', 12:50:54 INFO - '7'], 12:50:54 INFO - 'tests': ['tsvgm']}}, 12:50:54 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:50:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:50:54 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:50:54 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:50:54 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:50:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:50:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:50:54 INFO - 'talos_options': ['--disable-e10s'], 12:50:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:50:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:50:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:50:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:50:54 INFO - 'talos_options': ['--disable-e10s'], 12:50:54 INFO - 'tests': ['damp', 'tps']}, 12:50:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:50:54 INFO - 'tests': ['damp', 'tps']}, 12:50:54 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:50:54 INFO - 'tests': ['dromaeo_dom']}, 12:50:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:50:54 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:50:54 INFO - 'tests': ['a11yr', 12:50:54 INFO - 'ts_paint', 12:50:54 INFO - 'tpaint', 12:50:54 INFO - 'sessionrestore', 12:50:54 INFO - 'sessionrestore_no_auto_restore', 12:50:54 INFO - 'tabpaint']}, 12:50:54 INFO - 'other-e10s': {'tests': ['a11yr', 12:50:54 INFO - 'ts_paint', 12:50:54 INFO - 'tpaint', 12:50:54 INFO - 'sessionrestore', 12:50:54 INFO - 'sessionrestore_no_auto_restore', 12:50:54 INFO - 'tabpaint']}, 12:50:54 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:50:54 INFO - 'ts_paint', 12:50:54 INFO - 'tpaint', 12:50:54 INFO - 'sessionrestore', 12:50:54 INFO - 'sessionrestore_no_auto_restore', 12:50:54 INFO - 'tabpaint']}, 12:50:54 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:50:54 INFO - 'ts_paint', 12:50:54 INFO - 'tpaint', 12:50:54 INFO - 'sessionrestore', 12:50:54 INFO - 'sessionrestore_no_auto_restore', 12:50:54 INFO - 'tabpaint']}, 12:50:54 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:50:54 INFO - 'tests': ['a11yr', 12:50:54 INFO - 'ts_paint', 12:50:54 INFO - 'tpaint', 12:50:54 INFO - 'sessionrestore', 12:50:54 INFO - 'sessionrestore_no_auto_restore', 12:50:54 INFO - 'tabpaint']}, 12:50:54 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:50:54 INFO - 'tests': ['a11yr', 12:50:54 INFO - 'ts_paint', 12:50:54 INFO - 'tpaint', 12:50:54 INFO - 'sessionrestore', 12:50:54 INFO - 'sessionrestore_no_auto_restore', 12:50:54 INFO - 'tabpaint']}, 12:50:54 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:50:54 INFO - 'tests': ['tsvgx', 12:50:54 INFO - 'tsvgr_opacity', 12:50:54 INFO - 'tart', 12:50:54 INFO - 'tscrollx', 12:50:54 INFO - 'cart']}, 12:50:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:50:54 INFO - 'tsvgr_opacity', 12:50:54 INFO - 'tart', 12:50:54 INFO - 'tscrollx', 12:50:54 INFO - 'cart']}, 12:50:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:50:54 INFO - 'talos_options': ['--disable-e10s'], 12:50:54 INFO - 'tests': ['tp5o']}, 12:50:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:50:54 INFO - 'tests': ['tp5o']}, 12:50:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:50:54 INFO - 'talos_options': ['--disable-e10s', 12:50:54 INFO - '--xperf_path', 12:50:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:50:54 INFO - 'tests': ['tp5n']}, 12:50:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:50:54 INFO - 'talos_options': ['--xperf_path', 12:50:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:50:54 INFO - 'tests': ['tp5n']}}, 12:50:54 INFO - 'talos.zip': {'path': '', 12:50:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:50:54 INFO - Running post-action listener: _resource_record_post_action 12:50:54 INFO - ##### 12:50:54 INFO - ##### Finished populate-webroot step (success) 12:50:54 INFO - ##### 12:50:54 INFO - ##### 12:50:54 INFO - ##### Running create-virtualenv step. 12:50:54 INFO - ##### 12:50:54 INFO - Running pre-action listener: _resource_record_pre_action 12:50:54 INFO - Running main action method: create_virtualenv 12:50:54 INFO - Creating virtualenv /builds/slave/test/build/venv 12:50:54 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 12:50:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:50:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:50:54 INFO - Using real prefix '/usr' 12:50:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:50:54 INFO - Installing distribute.............................................................................................................................................................................................done. 12:50:56 INFO - Installing pip.................done. 12:50:56 INFO - Return code: 0 12:50:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:50:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:50:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:50:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:50:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:50:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:50:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:50:56 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 0x7f4c655fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11d7770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12669c0>, '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 0x12678c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1267d50>, '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': '00204705a9daa57ed339a427000001b9-1462823336.495322-2045218319', '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 12:50:56 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 12:50:56 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 12:50:56 INFO - Using env: {'DISPLAY': ':0', 12:50:56 INFO - 'HOME': '/home/cltbld', 12:50:56 INFO - 'LANG': 'en_US.UTF-8', 12:50:56 INFO - 'LANGUAGE': 'en_US:en', 12:50:56 INFO - 'LOGNAME': 'cltbld', 12:50:56 INFO - 'MAIL': '/var/mail/cltbld', 12:50:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:50:56 INFO - 'MOZ_NO_REMOTE': '1', 12:50:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:50:56 INFO - 'NO_EM_RESTART': '1', 12:50:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:50:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:50:56 INFO - 'PWD': '/builds/slave/test', 12:50:56 INFO - 'SHELL': '/bin/bash', 12:50:56 INFO - 'SHLVL': '1', 12:50:56 INFO - 'TERM': 'linux', 12:50:56 INFO - 'TMOUT': '86400', 12:50:56 INFO - 'USER': 'cltbld', 12:50:56 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1462823336.495322-2045218319', 12:50:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:50:56 INFO - '_': '/tools/buildbot/bin/python'} 12:50:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:50:57 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 12:50:57 INFO - Cleaning up... 12:50:57 INFO - Return code: 0 12:50:57 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 12:50:57 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')]} 12:50:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:50:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:50:57 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')]} 12:50:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:50:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:50:57 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 0x7f4c655fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11d7770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12669c0>, '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 0x12678c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1267d50>, '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': '00204705a9daa57ed339a427000001b9-1462823336.495322-2045218319', '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 12:50:57 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 12:50:57 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 12:50:57 INFO - Using env: {'DISPLAY': ':0', 12:50:57 INFO - 'HOME': '/home/cltbld', 12:50:57 INFO - 'LANG': 'en_US.UTF-8', 12:50:57 INFO - 'LANGUAGE': 'en_US:en', 12:50:57 INFO - 'LOGNAME': 'cltbld', 12:50:57 INFO - 'MAIL': '/var/mail/cltbld', 12:50:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:50:57 INFO - 'MOZ_NO_REMOTE': '1', 12:50:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:50:57 INFO - 'NO_EM_RESTART': '1', 12:50:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:50:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:50:57 INFO - 'PWD': '/builds/slave/test', 12:50:57 INFO - 'SHELL': '/bin/bash', 12:50:57 INFO - 'SHLVL': '1', 12:50:57 INFO - 'TERM': 'linux', 12:50:57 INFO - 'TMOUT': '86400', 12:50:57 INFO - 'USER': 'cltbld', 12:50:57 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1462823336.495322-2045218319', 12:50:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:50:57 INFO - '_': '/tools/buildbot/bin/python'} 12:50:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:50:57 INFO - Downloading/unpacking psutil>=0.7.1 12:50: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 12:50: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 12:50: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 12:50: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 12:50: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 12:50: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 12:50:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:50:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:50:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:50:59 INFO - Installing collected packages: psutil 12:50:59 INFO - Running setup.py install for psutil 12:50:59 INFO - building 'psutil._psutil_linux' extension 12:50:59 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 12:50:59 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 12:50:59 INFO - building 'psutil._psutil_posix' extension 12:50:59 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 12:50:59 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 12:50:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:50:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:50:59 INFO - Successfully installed psutil 12:50:59 INFO - Cleaning up... 12:50:59 INFO - Return code: 0 12:50:59 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 12:50:59 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')]} 12:50:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:50:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:50:59 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')]} 12:50:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:50:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:50:59 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 0x7f4c655fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11d7770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12669c0>, '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 0x12678c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1267d50>, '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': '00204705a9daa57ed339a427000001b9-1462823336.495322-2045218319', '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 12:50:59 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 12:50:59 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 12:50:59 INFO - Using env: {'DISPLAY': ':0', 12:50:59 INFO - 'HOME': '/home/cltbld', 12:50:59 INFO - 'LANG': 'en_US.UTF-8', 12:50:59 INFO - 'LANGUAGE': 'en_US:en', 12:50:59 INFO - 'LOGNAME': 'cltbld', 12:50:59 INFO - 'MAIL': '/var/mail/cltbld', 12:50:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:50:59 INFO - 'MOZ_NO_REMOTE': '1', 12:50:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:50:59 INFO - 'NO_EM_RESTART': '1', 12:50:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:50:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:50:59 INFO - 'PWD': '/builds/slave/test', 12:50:59 INFO - 'SHELL': '/bin/bash', 12:50:59 INFO - 'SHLVL': '1', 12:50:59 INFO - 'TERM': 'linux', 12:50:59 INFO - 'TMOUT': '86400', 12:50:59 INFO - 'USER': 'cltbld', 12:50:59 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1462823336.495322-2045218319', 12:50:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:50:59 INFO - '_': '/tools/buildbot/bin/python'} 12:50:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:51:00 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 12:51:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:51:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:51:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:51:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:51:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:51:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:51:01 INFO - Downloading mozsystemmonitor-0.0.tar.gz 12:51:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:51:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 12:51:02 INFO - Installing collected packages: mozsystemmonitor 12:51:02 INFO - Running setup.py install for mozsystemmonitor 12:51:02 INFO - Successfully installed mozsystemmonitor 12:51:02 INFO - Cleaning up... 12:51:02 INFO - Return code: 0 12:51:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:51:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:51:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:51:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:51:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:51:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:51:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:51:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f4c655fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11d7770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12669c0>, '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 0x12678c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1267d50>, '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': '00204705a9daa57ed339a427000001b9-1462823336.495322-2045218319', '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 12:51:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 12:51:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 12:51:02 INFO - Using env: {'DISPLAY': ':0', 12:51:02 INFO - 'HOME': '/home/cltbld', 12:51:02 INFO - 'LANG': 'en_US.UTF-8', 12:51:02 INFO - 'LANGUAGE': 'en_US:en', 12:51:02 INFO - 'LOGNAME': 'cltbld', 12:51:02 INFO - 'MAIL': '/var/mail/cltbld', 12:51:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:51:02 INFO - 'MOZ_NO_REMOTE': '1', 12:51:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:51:02 INFO - 'NO_EM_RESTART': '1', 12:51:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:51:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:51:02 INFO - 'PWD': '/builds/slave/test', 12:51:02 INFO - 'SHELL': '/bin/bash', 12:51:02 INFO - 'SHLVL': '1', 12:51:02 INFO - 'TERM': 'linux', 12:51:02 INFO - 'TMOUT': '86400', 12:51:02 INFO - 'USER': 'cltbld', 12:51:02 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1462823336.495322-2045218319', 12:51:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:51:02 INFO - '_': '/tools/buildbot/bin/python'} 12:51:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:51:02 INFO - Downloading/unpacking blobuploader==1.2.4 12:51:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:51:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:51:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:51:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:51:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:51:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:51:04 INFO - Downloading blobuploader-1.2.4.tar.gz 12:51:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:51:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:51:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:51:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:51:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:51:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:51:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:51:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:51:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:51:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:51:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:51:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:51:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:51:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:51:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:51:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:51:04 INFO - Downloading docopt-0.6.1.tar.gz 12:51:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:51:05 INFO - Installing collected packages: blobuploader, requests, docopt 12:51:05 INFO - Running setup.py install for blobuploader 12:51:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:51:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:51:05 INFO - Running setup.py install for requests 12:51:05 INFO - Running setup.py install for docopt 12:51:05 INFO - Successfully installed blobuploader requests docopt 12:51:05 INFO - Cleaning up... 12:51:05 INFO - Return code: 0 12:51:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:51: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')]} 12:51:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:51:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:51: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')]} 12:51:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:51:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:51:05 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 0x7f4c655fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11d7770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12669c0>, '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 0x12678c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1267d50>, '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': '00204705a9daa57ed339a427000001b9-1462823336.495322-2045218319', '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 12:51:05 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 12:51:05 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 12:51:05 INFO - Using env: {'DISPLAY': ':0', 12:51:05 INFO - 'HOME': '/home/cltbld', 12:51:05 INFO - 'LANG': 'en_US.UTF-8', 12:51:05 INFO - 'LANGUAGE': 'en_US:en', 12:51:05 INFO - 'LOGNAME': 'cltbld', 12:51:05 INFO - 'MAIL': '/var/mail/cltbld', 12:51:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:51:05 INFO - 'MOZ_NO_REMOTE': '1', 12:51:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:51:05 INFO - 'NO_EM_RESTART': '1', 12:51:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:51:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:51:05 INFO - 'PWD': '/builds/slave/test', 12:51:05 INFO - 'SHELL': '/bin/bash', 12:51:05 INFO - 'SHLVL': '1', 12:51:05 INFO - 'TERM': 'linux', 12:51:05 INFO - 'TMOUT': '86400', 12:51:05 INFO - 'USER': 'cltbld', 12:51:05 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1462823336.495322-2045218319', 12:51:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:51:05 INFO - '_': '/tools/buildbot/bin/python'} 12:51:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:51:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:51:05 INFO - Running setup.py (path:/tmp/pip-sRtlql-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:51:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:51:05 INFO - Running setup.py (path:/tmp/pip-74CXmt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:51:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:51:05 INFO - Running setup.py (path:/tmp/pip-kia_0c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:51:06 INFO - Running setup.py (path:/tmp/pip-9pPykA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:51:06 INFO - Running setup.py (path:/tmp/pip-22iyID-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:51:06 INFO - Running setup.py (path:/tmp/pip-Bqkt_4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:51:06 INFO - Running setup.py (path:/tmp/pip-Bb2qJJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:51:06 INFO - Running setup.py (path:/tmp/pip-iJkvNW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:51:06 INFO - Running setup.py (path:/tmp/pip-fPnXUn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:51:06 INFO - Running setup.py (path:/tmp/pip-Ho28j0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:51:06 INFO - Running setup.py (path:/tmp/pip-XqBojs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:51:06 INFO - Running setup.py (path:/tmp/pip-NkKqoc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:51:06 INFO - Running setup.py (path:/tmp/pip-T9xaR5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:51:06 INFO - Running setup.py (path:/tmp/pip-gSIstb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:51:06 INFO - Running setup.py (path:/tmp/pip-lwOWGn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:51:06 INFO - Running setup.py (path:/tmp/pip-WUEd3w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:51:06 INFO - Running setup.py (path:/tmp/pip-1Og4zi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:51:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:51:07 INFO - Running setup.py install for manifestparser 12:51:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:51:07 INFO - Running setup.py install for mozcrash 12:51:07 INFO - Running setup.py install for mozdebug 12:51:07 INFO - Running setup.py install for mozdevice 12:51:07 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:51:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:51:07 INFO - Running setup.py install for mozfile 12:51:07 INFO - Running setup.py install for mozhttpd 12:51:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:51:07 INFO - Running setup.py install for mozinfo 12:51:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:51:07 INFO - Running setup.py install for mozInstall 12:51:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:51:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:51:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:51:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:51:07 INFO - Running setup.py install for mozleak 12:51:07 INFO - Running setup.py install for mozlog 12:51:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:51:08 INFO - Running setup.py install for moznetwork 12:51:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:51:08 INFO - Running setup.py install for mozprocess 12:51:08 INFO - Running setup.py install for mozprofile 12:51:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:51:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:51:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:51:08 INFO - Running setup.py install for mozrunner 12:51:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:51:08 INFO - Running setup.py install for mozscreenshot 12:51:08 INFO - Running setup.py install for moztest 12:51:08 INFO - Running setup.py install for mozversion 12:51:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:51:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:51:08 INFO - Cleaning up... 12:51:08 INFO - Return code: 0 12:51:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:51: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')]} 12:51:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:51:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:51: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')]} 12:51:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:51:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:51:08 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 0x7f4c655fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11d7770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12669c0>, '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 0x12678c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1267d50>, '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': '00204705a9daa57ed339a427000001b9-1462823336.495322-2045218319', '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 12:51:08 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 12:51:08 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 12:51:08 INFO - Using env: {'DISPLAY': ':0', 12:51:08 INFO - 'HOME': '/home/cltbld', 12:51:08 INFO - 'LANG': 'en_US.UTF-8', 12:51:08 INFO - 'LANGUAGE': 'en_US:en', 12:51:08 INFO - 'LOGNAME': 'cltbld', 12:51:08 INFO - 'MAIL': '/var/mail/cltbld', 12:51:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:51:08 INFO - 'MOZ_NO_REMOTE': '1', 12:51:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:51:08 INFO - 'NO_EM_RESTART': '1', 12:51:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:51:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:51:08 INFO - 'PWD': '/builds/slave/test', 12:51:08 INFO - 'SHELL': '/bin/bash', 12:51:08 INFO - 'SHLVL': '1', 12:51:08 INFO - 'TERM': 'linux', 12:51:08 INFO - 'TMOUT': '86400', 12:51:08 INFO - 'USER': 'cltbld', 12:51:08 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1462823336.495322-2045218319', 12:51:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:51:08 INFO - '_': '/tools/buildbot/bin/python'} 12:51:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:51:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:51:09 INFO - Running setup.py (path:/tmp/pip-IqodGk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:51:09 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)) 12:51:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:51:09 INFO - Running setup.py (path:/tmp/pip-zE5eOa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:51:09 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)) 12:51:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:51:09 INFO - Running setup.py (path:/tmp/pip-5CvxDI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:51:09 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)) 12:51:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:51:09 INFO - Running setup.py (path:/tmp/pip-JV4ick-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:51:09 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)) 12:51:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:51:09 INFO - Running setup.py (path:/tmp/pip-OolY_N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:51:09 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)) 12:51:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:51:09 INFO - Running setup.py (path:/tmp/pip-NPsGUR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:51:09 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)) 12:51:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:51:09 INFO - Running setup.py (path:/tmp/pip-QHwRSw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:51:09 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)) 12:51:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:51:09 INFO - Running setup.py (path:/tmp/pip-78bPbM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:51:09 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)) 12:51:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:51:09 INFO - Running setup.py (path:/tmp/pip-n0NLNs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:51:09 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)) 12:51:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:51:09 INFO - Running setup.py (path:/tmp/pip-19I_uf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:51:09 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)) 12:51:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:51:09 INFO - Running setup.py (path:/tmp/pip-Q3wa6p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:51:09 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)) 12:51:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:51:09 INFO - Running setup.py (path:/tmp/pip-C2rWGc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:51:09 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)) 12:51:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:51:09 INFO - Running setup.py (path:/tmp/pip-LrDL2q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:51:10 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)) 12:51:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:51:10 INFO - Running setup.py (path:/tmp/pip-6mPgkv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:51:10 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)) 12:51:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:51:10 INFO - Running setup.py (path:/tmp/pip-_shnfr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:51:10 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)) 12:51:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:51:10 INFO - Running setup.py (path:/tmp/pip-tI6qj5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:51:10 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)) 12:51:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:51:10 INFO - Running setup.py (path:/tmp/pip-DQTME4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:51:10 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)) 12:51:10 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)) 12:51:10 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)) 12:51:10 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)) 12:51:10 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)) 12:51:10 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)) 12:51:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:51: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 12:51: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 12:51: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 12:51: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 12:51: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 12:51: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 12:51:12 INFO - Downloading blessings-1.6.tar.gz 12:51:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:51:12 INFO - Installing collected packages: blessings 12:51:12 INFO - Running setup.py install for blessings 12:51:12 INFO - Successfully installed blessings 12:51:12 INFO - Cleaning up... 12:51:12 INFO - Return code: 0 12:51:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:51:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:51:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:51:12 INFO - Reading from file tmpfile_stdout 12:51:12 INFO - Current package versions: 12:51:12 INFO - argparse == 1.2.1 12:51:12 INFO - blessings == 1.6 12:51:12 INFO - blobuploader == 1.2.4 12:51:12 INFO - docopt == 0.6.1 12:51:12 INFO - manifestparser == 1.1 12:51:12 INFO - mozInstall == 1.12 12:51:12 INFO - mozcrash == 0.17 12:51:12 INFO - mozdebug == 0.1 12:51:12 INFO - mozdevice == 0.48 12:51:12 INFO - mozfile == 1.2 12:51:12 INFO - mozhttpd == 0.7 12:51:12 INFO - mozinfo == 0.9 12:51:12 INFO - mozleak == 0.1 12:51:12 INFO - mozlog == 3.1 12:51:12 INFO - moznetwork == 0.27 12:51:12 INFO - mozprocess == 0.22 12:51:12 INFO - mozprofile == 0.28 12:51:12 INFO - mozrunner == 6.11 12:51:12 INFO - mozscreenshot == 0.1 12:51:12 INFO - mozsystemmonitor == 0.0 12:51:12 INFO - moztest == 0.7 12:51:12 INFO - mozversion == 1.4 12:51:12 INFO - psutil == 3.1.1 12:51:12 INFO - requests == 1.2.3 12:51:12 INFO - wsgiref == 0.1.2 12:51:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:51:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:51:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:51:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:51:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:51:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:51:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:51:12 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 0x7f4c655fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11d7770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12669c0>, '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 0x12678c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1267d50>, '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': '00204705a9daa57ed339a427000001b9-1462823336.495322-2045218319', '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 12:51:12 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 12:51:12 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 12:51:12 INFO - Using env: {'DISPLAY': ':0', 12:51:12 INFO - 'HOME': '/home/cltbld', 12:51:12 INFO - 'LANG': 'en_US.UTF-8', 12:51:12 INFO - 'LANGUAGE': 'en_US:en', 12:51:12 INFO - 'LOGNAME': 'cltbld', 12:51:12 INFO - 'MAIL': '/var/mail/cltbld', 12:51:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:51:12 INFO - 'MOZ_NO_REMOTE': '1', 12:51:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:51:12 INFO - 'NO_EM_RESTART': '1', 12:51:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:51:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:51:12 INFO - 'PWD': '/builds/slave/test', 12:51:12 INFO - 'SHELL': '/bin/bash', 12:51:12 INFO - 'SHLVL': '1', 12:51:12 INFO - 'TERM': 'linux', 12:51:12 INFO - 'TMOUT': '86400', 12:51:12 INFO - 'USER': 'cltbld', 12:51:12 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1462823336.495322-2045218319', 12:51:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:51:12 INFO - '_': '/tools/buildbot/bin/python'} 12:51:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:51:12 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)) 12:51:12 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)) 12:51:12 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)) 12:51:12 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)) 12:51:12 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)) 12:51:12 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)) 12:51:12 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)) 12:51:12 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)) 12:51:12 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)) 12:51:12 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)) 12:51:12 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)) 12:51:12 INFO - Cleaning up... 12:51:12 INFO - Return code: 0 12:51:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:51:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:51:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:51:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:51:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:51:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:51:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:51:12 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 0x7f4c655fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11d7770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12669c0>, '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 0x12678c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1267d50>, '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': '00204705a9daa57ed339a427000001b9-1462823336.495322-2045218319', '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 12:51:12 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 12:51:12 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 12:51:12 INFO - Using env: {'DISPLAY': ':0', 12:51:12 INFO - 'HOME': '/home/cltbld', 12:51:12 INFO - 'LANG': 'en_US.UTF-8', 12:51:12 INFO - 'LANGUAGE': 'en_US:en', 12:51:12 INFO - 'LOGNAME': 'cltbld', 12:51:12 INFO - 'MAIL': '/var/mail/cltbld', 12:51:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:51:12 INFO - 'MOZ_NO_REMOTE': '1', 12:51:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:51:12 INFO - 'NO_EM_RESTART': '1', 12:51:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:51:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:51:12 INFO - 'PWD': '/builds/slave/test', 12:51:12 INFO - 'SHELL': '/bin/bash', 12:51:12 INFO - 'SHLVL': '1', 12:51:12 INFO - 'TERM': 'linux', 12:51:12 INFO - 'TMOUT': '86400', 12:51:12 INFO - 'USER': 'cltbld', 12:51:12 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1462823336.495322-2045218319', 12:51:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:51:12 INFO - '_': '/tools/buildbot/bin/python'} 12:51:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:51:13 INFO - Downloading/unpacking jsonschema 12:51:13 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 12:51:13 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 12:51:13 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 12:51:13 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 12:51:13 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 12:51:13 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 12:51:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:51:14 INFO - Downloading/unpacking functools32 (from jsonschema) 12:51:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:51:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:51:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:51:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:51:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:51:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:51:15 INFO - Downloading functools32-3.2.3-2.tar.gz 12:51:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:51:15 INFO - warning: no files found matching '*.txt' 12:51:15 INFO - no previously-included directories found matching 'build' 12:51:15 INFO - no previously-included directories found matching 'dist' 12:51:15 INFO - no previously-included directories found matching '.git*' 12:51:15 INFO - Installing collected packages: jsonschema, functools32 12:51:15 INFO - Running setup.py install for functools32 12:51:15 INFO - warning: no files found matching '*.txt' 12:51:15 INFO - no previously-included directories found matching 'build' 12:51:15 INFO - no previously-included directories found matching 'dist' 12:51:15 INFO - no previously-included directories found matching '.git*' 12:51:15 INFO - Successfully installed jsonschema functools32 12:51:15 INFO - Cleaning up... 12:51:15 INFO - Return code: 0 12:51:15 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 12:51:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:51:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:51:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:51:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:51:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:51:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:51:15 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 0x7f4c655fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11d7770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12669c0>, '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 0x12678c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1267d50>, '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': '00204705a9daa57ed339a427000001b9-1462823336.495322-2045218319', '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 12:51:15 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 12:51:15 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 12:51:15 INFO - Using env: {'DISPLAY': ':0', 12:51:15 INFO - 'HOME': '/home/cltbld', 12:51:15 INFO - 'LANG': 'en_US.UTF-8', 12:51:15 INFO - 'LANGUAGE': 'en_US:en', 12:51:15 INFO - 'LOGNAME': 'cltbld', 12:51:15 INFO - 'MAIL': '/var/mail/cltbld', 12:51:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:51:15 INFO - 'MOZ_NO_REMOTE': '1', 12:51:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:51:15 INFO - 'NO_EM_RESTART': '1', 12:51:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:51:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:51:15 INFO - 'PWD': '/builds/slave/test', 12:51:15 INFO - 'SHELL': '/bin/bash', 12:51:15 INFO - 'SHLVL': '1', 12:51:15 INFO - 'TERM': 'linux', 12:51:15 INFO - 'TMOUT': '86400', 12:51:15 INFO - 'USER': 'cltbld', 12:51:15 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1462823336.495322-2045218319', 12:51:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:51:15 INFO - '_': '/tools/buildbot/bin/python'} 12:51:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:51:15 INFO - Downloading/unpacking flake8 12:51:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:51:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:51:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:51:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:51:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:51:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:51:17 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 12:51:17 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 12:51:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:51:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:51:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:51:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:51:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:51:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:51:17 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 12:51:17 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 12:51:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:51:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:51:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:51:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:51:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:51:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:51:17 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 12:51:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:51:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:51:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:51:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:51:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:51:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:51:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 12:51:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:51:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:51:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:51:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:51:18 INFO - no previously-included directories found matching 'docs/_build' 12:51:18 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 12:51:18 INFO - Running setup.py install for pep8 12:51:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:51:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:51:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:51:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:51:18 INFO - no previously-included directories found matching 'docs/_build' 12:51:18 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 12:51:18 INFO - Successfully installed flake8 mccabe pyflakes pep8 12:51:18 INFO - Cleaning up... 12:51:18 INFO - Return code: 0 12:51:18 INFO - Running post-action listener: _resource_record_post_action 12:51:18 INFO - Running post-action listener: _start_resource_monitoring 12:51:18 INFO - Starting resource monitoring. 12:51:18 INFO - ##### 12:51:18 INFO - ##### Finished create-virtualenv step (success) 12:51:18 INFO - ##### 12:51:18 INFO - ##### 12:51:18 INFO - ##### Running install step. 12:51:18 INFO - ##### 12:51:18 INFO - Running pre-action listener: _resource_record_pre_action 12:51:18 INFO - Running main action method: install 12:51:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:51:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:51:18 INFO - Reading from file tmpfile_stdout 12:51:18 INFO - Detecting whether we're running mozinstall >=1.0... 12:51:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:51:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:51:18 INFO - Reading from file tmpfile_stdout 12:51:18 INFO - Output received: 12:51:18 INFO - Usage: mozinstall [options] installer 12:51:18 INFO - Options: 12:51:18 INFO - -h, --help show this help message and exit 12:51:18 INFO - -d DEST, --destination=DEST 12:51:18 INFO - Directory to install application into. [default: 12:51:18 INFO - "/builds/slave/test"] 12:51:18 INFO - --app=APP Application being installed. [default: firefox] 12:51:18 INFO - mkdir: /builds/slave/test/build/application 12:51:18 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'] 12:51:18 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 12:51:34 INFO - Reading from file tmpfile_stdout 12:51:34 INFO - Output received: 12:51:34 INFO - /builds/slave/test/build/application/firefox/firefox 12:51:34 INFO - Running post-action listener: _resource_record_post_action 12:51:34 INFO - ##### 12:51:34 INFO - ##### Finished install step (success) 12:51:34 INFO - ##### 12:51:34 INFO - ##### 12:51:34 INFO - ##### Running run-tests step. 12:51:34 INFO - ##### 12:51:34 INFO - Running pre-action listener: _resource_record_pre_action 12:51:34 INFO - Running main action method: run_tests 12:51:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:51:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:51:34 INFO - Python 2.7.3 12:51:34 INFO - Return code: 0 12:51:34 INFO - grabbing minidump binary from tooltool 12:51: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')]} 12:51:34 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 0x12669c0>, '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 0x12678c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1267d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:51:34 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 12:51:34 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 12:51:34 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:51:34 INFO - Return code: 0 12:51:34 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:51:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:51:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:51:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:51:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:51:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 12:51:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 12:51:35 INFO - Return code: 0 12:51:35 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/efMoi9YaTICmX3WldmYg7Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--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 12:51:35 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/efMoi9YaTICmX3WldmYg7Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-016 --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 12:51:35 INFO - Using env: {'DISPLAY': ':0', 12:51:35 INFO - 'HOME': '/home/cltbld', 12:51:35 INFO - 'LANG': 'en_US.UTF-8', 12:51:35 INFO - 'LANGUAGE': 'en_US:en', 12:51:35 INFO - 'LOGNAME': 'cltbld', 12:51:35 INFO - 'MAIL': '/var/mail/cltbld', 12:51:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:51:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:51:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:51:35 INFO - 'MOZ_NO_REMOTE': '1', 12:51:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:51:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:51:35 INFO - 'NO_EM_RESTART': '1', 12:51:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:51:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:51:35 INFO - 'PWD': '/builds/slave/test', 12:51:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:51:35 INFO - 'SHELL': '/bin/bash', 12:51:35 INFO - 'SHLVL': '1', 12:51:35 INFO - 'TERM': 'linux', 12:51:35 INFO - 'TMOUT': '86400', 12:51:35 INFO - 'USER': 'cltbld', 12:51:35 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1462823336.495322-2045218319', 12:51:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:51:35 INFO - '_': '/tools/buildbot/bin/python'} 12:51:35 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/efMoi9YaTICmX3WldmYg7Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--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 12:51:35 INFO - mozversion application_buildid: 20160509121157 12:51:35 INFO - mozversion application_changeset: 4dd60a8b9e2b229e8551c08ad4302433081ecced 12:51:35 INFO - mozversion application_display_name: Nightly 12:51:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:51:35 INFO - mozversion application_name: Firefox 12:51:35 INFO - mozversion application_remotingname: firefox 12:51:35 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 12:51:35 INFO - mozversion application_vendor: Mozilla 12:51:35 INFO - mozversion application_version: 49.0a1 12:51:35 INFO - mozversion platform_buildid: 20160509121157 12:51:35 INFO - mozversion platform_changeset: 4dd60a8b9e2b229e8551c08ad4302433081ecced 12:51:35 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 12:51:35 INFO - mozversion platform_version: 49.0a1 12:51:35 INFO - using testdate: 1462823495 12:51:35 INFO - actual date: 1462823495 12:51:35 INFO - starting webserver on 'localhost:36641' 12:51:35 INFO - SUITE-START | Running 2 tests 12:51:35 INFO - TEST-START | dromaeo_css 12:51:35 INFO - operating with platform_type : linux_ 12:51:35 INFO - Initialising browser for dromaeo_css test... 12:51:35 INFO - TEST-INFO | started process 2892 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnyg7FP/profile http://localhost:36641/getInfo.html) 12:51:39 INFO - PROCESS | 2892 | 12:51:39 INFO - PROCESS | 2892 | (process:2960): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 12:51:40 INFO - PROCESS | 2892 | __metrics Screen width/height:1600/1200 12:51:40 INFO - PROCESS | 2892 | colorDepth:24 12:51:40 INFO - PROCESS | 2892 | Browser inner width/height: 1024/697 12:51:40 INFO - PROCESS | 2892 | __metrics 12:51:41 ERROR - PROCESS | 2892 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2937: TypeError: this.tabs is undefined 12:51:42 INFO - TEST-INFO | 2892: exit 0 12:51:42 INFO - Browser initialized. 12:51:42 INFO - Running cycle 1/1 for dromaeo_css test... 12:51:42 INFO - TEST-INFO | started process 3012 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnyg7FP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:51:44 INFO - PROCESS | 3012 | 12:51:44 INFO - PROCESS | 3012 | (process:3072): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 12:51:54 INFO - PROCESS | 3012 | RSS: Main: 163823616 12:51:54 INFO - PROCESS | 3012 | 12:52:43 INFO - PROCESS | 3012 | 1462823563795 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] 12:54:55 INFO - PROCESS | 3012 | Cycle 1(1): loaded http://localhost:36641/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36641/tests/dromaeo/cssquery-ext.html) 12:54:56 INFO - PROCESS | 3012 | RSS: Main: 166301696 12:54:56 INFO - PROCESS | 3012 | 12:57:58 INFO - PROCESS | 3012 | Cycle 1(1): loaded http://localhost:36641/tests/dromaeo/cssquery-ext.html (next: http://localhost:36641/tests/dromaeo/cssquery-jquery.html) 12:57:59 INFO - PROCESS | 3012 | RSS: Main: 166256640 12:57:59 INFO - PROCESS | 3012 | 13:01:01 INFO - PROCESS | 3012 | Cycle 1(1): loaded http://localhost:36641/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36641/tests/dromaeo/cssquery-mootools.html) 13:01:01 INFO - PROCESS | 3012 | RSS: Main: 167411712 13:01:01 INFO - PROCESS | 3012 | 13:04:03 INFO - PROCESS | 3012 | Cycle 1(1): loaded http://localhost:36641/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36641/tests/dromaeo/cssquery-prototype.html) 13:04:04 INFO - PROCESS | 3012 | RSS: Main: 165113856 13:04:04 INFO - PROCESS | 3012 | 13:07:07 INFO - PROCESS | 3012 | Cycle 1(1): loaded http://localhost:36641/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36641/tests/dromaeo/cssquery-yui.html) 13:07:07 INFO - PROCESS | 3012 | RSS: Main: 166813696 13:07:07 INFO - PROCESS | 3012 | 13:10:10 INFO - PROCESS | 3012 | Cycle 1(1): loaded http://localhost:36641/tests/dromaeo/cssquery-yui.html (next: http://localhost:36641/tests/dromaeo/cssquery-dojo.html) 13:10:10 INFO - PROCESS | 3012 | RSS: Main: 168517632 13:10:10 INFO - PROCESS | 3012 | 13:10:10 INFO - PROCESS | 3012 | __start_tp_report 13:10:10 INFO - PROCESS | 3012 | _x_x_mozilla_page_load 13:10:10 INFO - PROCESS | 3012 | _x_x_mozilla_page_load_details 13:10:10 INFO - PROCESS | 3012 | |i|pagename|runs| 13:10:10 INFO - PROCESS | 3012 | |0;dojo.html;2654.4956458272927;2679.8258113222646;2685.43605842773;2691.798115141365;2713.077553631766;4647;4669.976650116753;4701.811927522899;4757.1437141314545;4757.357756702844;4667.579917807397;4784.40194975628;4798.136335459616;4822.807087716487;4838.854834354966;4362.520122786491;4446;4493.438320209973;4505.549445055501;4507.57178068083;579.7281601671903;4263.914721705564;4297.0331675372945;4439.511653718088;4443.066955939256;4284.657227421799;4354.412154359153;4355.695101342892;4357.128574285124;4359.542248063939;4389.407429996942;4413.889652758675;4430.379746835446;4447.510773814878;4450.554944505556;4318.481782186158;4322.848700295474;4387.605115539617;4414.05097903949;4419.160359531678;4610.170169369512;4653.092646933849;4683.484816670163;4697.177993851063;4701.7414042227665;5100.285959965608;5105.948940510584;5106.259592359124;5108.66793658411;5123.564497017758;4998.275250088753;5157.174852023658;5183.041137389595;5214.243934629495;5247.950409917993;4886.31999960103;4886.486918873538;4910.607151427948;4917.803287868517;4962.280469331927;5305.946940530623;5381.13901775714;5381.67709937405;5394;5399.676019438846;4933.703977761345;5077.18764997606;5106.514881086291;5125.948740512547;5151.97424012885;5209.0363282792805;5220.477952204825;5222.033923724123;5236.738163091906;5245.213218017251;5179.870503237449;5193.610479214074;5194.480551944851;5195.948040519622;5199.558037566773;4962.181240095344;5122.154844450624;5133.204353325241;5153.742312884341;5167.121589329823;4403.867883963486;4451.1765323415275;4467.955320446819;4475.239209334421;4509.143262780061;3776.773393596393;3899;3905.6875449963936;3916.882493525142;3946.1121247719607;4280.0369916769105;4365.694401391872;4394.692371533962;4404.075144219686;4420.204363214652;5107.54032137102;5125.923111153335;5189.455107213764;5190.195519694454;5239.790408383698;4303.849365272201;4412.757298348622;4413.6248418884115;4419.049904270597;4465.866024019285;4623.237165867661;4654.464736555339;4660.603848672833;4700.412448443944;4705.6470764692785;4817.735024573612;4844.2007068833955;4847.684900481458;4848;4887.682300650446;5182.378114626269;5182.818601348935;5184.585233181261;5184.740762961912;5240.4759524047295;4729.55069268419;4855.465898751205;4890.168671325812;4908.263760435963;4919;5160.767765450639;5161.974190129025;5164.8192313268855;5175.741212939413;5223.373195216598;5050.3182070420025;5227.712475813867;5237.947620523899;5254.369475662945;5264.289320941624;5012.298278240976;5019.874503137451;5061.342025536656;5064.696118232918;5096;5068.037072956126;5073.746312684277;5084;5089.694618322913;5144.30551875492;4767.475577686521;4903.509649035211;5002.349694539686;5009.474005229398;5012.423571289202;4987.251912213197;5069.391672999116;5094.2358646203365;5097.898042039213;5147.845564633067;4978.751062446936;4992;4995.075910956485;5000.699958002531;5043.2939388486375 13:10:10 INFO - PROCESS | 3012 | |1;ext.html;578.9131630255462;601.6931365003846;617.4504690825166;619.8915189841774;622.1662971618032;40565;42145.78927105364;42253;42278.788606056965;46482.302765458546;41958.79020604893;42502;42509.36235956463;42631.360529592006;42697.57302426975;7916.6437510312035;8045.517268963881;8049.919500805005;8060.193980601922;8070.757877263692;7901.762947111567;8001.039875214982;8008.159143289958;8020.598970051474;8036.6785328587075;8004.879926801103;8022.358211343078;8052.074011488666;8075.111737708848;8087.31257843084;7871.5831150392905;7929.365650747926;8017.3586113111105;8036.116027236999;8043.879341809878;7620.618969051525;7705.730299439493;7728.6522106505345;7744.845103097963;7768.145503994556;38243.8087809562;38616.80691596524;38626;38643;38756;3158.6683398243313;3222.2105584131805;3227.5320078588475;3360.22714775603;3525.5600628042994;28744;29384;29453.263668408246;29653.258668533243;29681.257968550744;3541.787492750443;3561.281862793807;3656.597774244831;3701.130234394915;3807.7905715185652;237737;239479;239695;239930;240575;54700.726496367264;55115.724421377636;55311.17033244504;55316;55329.44670553243;58147.70926145427;58329.70835145797;58485.70757146187;58512.4148758507;58648;13032.869671303166;13424.463021479227;13442.126261792951;13442.731145377038;13484.528041518499;10042.799144017225;10107.494625268708;10141.391516509033;10181.898181018243;10185.388876667424;16504;16794.664106718043;16836.579085522713;16839;16917.91541042287;5829.621074630136;6584.440322572635;6620.470362370998;6650.536881886074;6708.429783468362;862.3489265604554;962.605331813953;967.5645959318335;1030.124394264869;1039.8180318444242;28886.277843054093;28971.85514072416;29231.853840731084;29449.55825662617;29663.25841853971;951.2104952889085;976.5605477535138;1013.1742629756725;1014.3305418423805;1071.9303245289032;14299.78550321746;14687;14772.380766712009;14832.332545035499;14952.476663316731;347186;347857;348262;349124;349960;49426;49922.50077499251;50014.49985500171;50075.499245007086;50237.74881125571;1235.8887700107034;1283.1980012492193;1286.2668279080833;1289.9290539020255;1295.151675652449;28111.43777124405;29355.266118347212;29751.404971900873;30081.548776768803;30415.54376684307;42931.7853410731;43064.35403468888;43529.347059793494;43598.56401435945;43629.56370436255;269462;272868;274945;275325;276861;25494.235172944842;25781.484370312115;25931.74068259369;25974.87012564925;25980.8700956494;41948;42853.78573107115;42952;42980.785096074316;43865.34201987037;37098;37131.814340928126;37241.62758372381;37477.25045499129;37647.623523764414;36679.26641467209;36926.94535494564;37468.62531374651;37508.43737343887;37818.62181378151;35916.82041589775;36094.8195259022;36622.8168859154;36909.81545092257;37022;32526.83736581302;33004.79076017693;33432.49851252282;33887.491687625195;33967.66032339645;25689.486210275318;25756.227313180636;26224.21327360182;26322.86838565795;26581.468370632865 13:10:10 INFO - PROCESS | 3012 | |2;jquery.html;372.8266356144392;375.318796384562;375.9548854137504;379.7721367179691;395.8337498250734;16058.116803575798;16517.669646607075;17338.653226935454;17533.386331478418;17542.210600522976;11080.556777728882;11474.827877581843;11491.482883270251;11502.539898404053;11541.076713862893;4646.442426908776;4694.108119457309;4831.396075490564;4833.057553777015;4878.902421951559;4733.242681171013;4748.643851711118;4827.58965487934;4837.516248375169;4857.489963553829;4663.417072865892;4827.879303017417;4841.661083724141;4860.100881336946;4861.562459378655;4791.448983366922;4803.111424386465;4804.783784729696;4830.951690483085;4844.2733589961435;4564.931526027112;4660.39414876064;4705.741184234866;4719.150552900476;4740.265258884879;11944;12220.20568663043;12403.441845116991;12431.875681243162;12438.81341779874;1854.9629007419776;1937.5059359863285;2046.1610739596695;2047.6723724204205;2244.461329280961;9777.706668799947;9791.755206119833;10049.648262310784;11216.831747523795;14021.158730476203;1830.0300840554528;1831.569581148429;1872.7284543741082;1902.4007437657094;1984.4046785964154;59878.40121598772;63263;65361.67319163374;65684.6715766418;69167.65416172887;9898.950505247427;9983.251256155672;10150.543225554868;10422.947885260524;10693.625723099654;12845.743085138245;12878.484860605658;12882.162659427107;12923.870761292455;13017.414216360286;6720.764773232913;6731;6789.185297764201;6808.863822723617;6908.965455172692;6396.744130234832;6426.839329016719;6461.988886454571;6491.350864913566;6517.250516190698;4442.178197033559;4459.643228541709;4495.595396414338;4538.704984176084;4578.9542104579195;1823.4165067178642;1838.3290099113726;1903.6097599991967;1911.8491696841054;1919.0788421557452;827.557256867573;856.5802756649197;902.6028547439237;904.2539904578749;914.5564401265381;16740.414085507193;16744.330226791037;17344.91327543354;17750.46748597544;17823.554411139827;882.1134759566595;884.5488800711684;887.587271918561;899;954.5131982688879;8770.429922055046;9880.555375008142;9949.55227014786;10105.242106842017;10158.187345012382;361761;395967;400347;402740;402984;82626;83571;85264.57367713246;86795;88126.55936720276;952.8713623660717;957.2437774158476;975.7902051059057;982.6560703753772;992.399598243067;15569.844301557292;15647.530574082795;15664.138472384127;15717.292721827316;16073.115978621288;35656.82171589229;35986;36322;36629.63370366262;37007.814960925025;48536.51463485461;50268;50630.74684626553;50708.74645626748;50726.492735073654;7871.195018482406;7878.960605196938;7892.763217103496;8101.959490202511;8230.588470576567;12012.699682508008;12089.637310880687;12178;12217.633470995885;12249.938750306192;10417.84373234387;10554.366737995744;10661.520231589751;10714.571417143226;10839.783204336027;10345.948270258601;10696.41169735672;10698.197635177548;10733.516991735234;11035.668929932115;10568.588469184891;10571.524281407508;10652.467376630982;10720.785584288427;10740.409277489813;6920.41176499983;8036.67853285862;8047.315978141924;8063.758087257392;8067.798305042186;9283.80645994058;9833.754156146153;10237.590496380062;10618.415987120783;10785.40680262593 13:10:10 INFO - PROCESS | 3012 | |3;mootools.html;1465.406510363303;1477.9113253204807;1615.3054186699721;1779.234928980538;1791.4088350844222;6659.866802663956;6860.416864566511;7253.673584688689;7391.704331826727;7400.185979542252;7291.817704557388;7516.924830751691;7533.547987120776;7548.660310286036;7564.583947882864;2187.387531491185;2214.9224777132804;2218.7892150245702;2218.800307972282;2219.1678120704737;2176.85850419723;2179.411558879102;2224.410531209231;2228.799408053275;2246.5619204255177;2174.0760176924823;2197.549502352014;2219.034719896842;2224.7997680208778;2226.487907781211;2133.4666333416644;2145.8068773810433;2146.64580344243;2146.774588668191;2159.5680863827297;2151.247063527768;2156.924507642225;2180.07346877578;2183.2467798609455;2202;7470.3650189733935;7474.103107627066;7525.510841795266;7529.811754706121;7556.206598307209;4371.868843934687;4537.296719008559;4537.750423726694;4540.614047805941;4575.267957126844;2964.2589352661835;2983.209449495885;3035.666076731558;3057.143999680093;3082.4143412751505;962.1052421248237;975.4586204656413;986.9703908882746;988.9258305627106;1003.989960100397;9849.261305402124;9863.260255480867;9924.652637157666;9926.255530835217;9928.45393503357;4096.73371230869;4121.1345617420675;4214.030772922245;4241.4698162729655;4286.39990401344;8553.144685531397;8569.928758905136;8574.356923230782;8597.78505537354;8612.095729948265;4472.1502914446155;4531.478879928784;4536.841210557614;4548.067646132535;4549.45406551216;3420.640832712579;3894.415837624322;4011.799410029487;4112.383142528644;4138.544760076389;3583.9104022399647;3606.13452771333;3729.7948612826012;3773.6981041516615;3853.479780229633;1218.9085818563642;1224.2287358963795;1225.3811825028304;1238.3746208164998;1238.9318587477594;810.8459392715365;824.5258976088653;902.9864552031725;903.1826197291462;911.5032307392487;4927.359443272351;5052.494750524918;5141.048905952411;5149.639525233272;5154.664946778447;876.3602570123718;888.1828717579842;890.679355432044;898.9865152022725;919.5080631862055;3422.7261819054916;3438.951119908452;3453.8445769939913;3506.947395789065;3553.3248682750714;8964.193222609996;9286.164245217962;9306.06939306064;9319.207867331354;9338.57976391064;8631.395802293779;9141.63433462654;9170.770730731785;9213.76965575866;9275.443473391619;6704.698288577026;6975.651217439006;7032.859342813115;7035.683394247271;7098.716051357887;5099.821506247264;5318.414974352895;5328.147496400712;5400.702961337164;5426.972865135649;8253.95873020631;8326.50040997542;8335.249827515552;8403.747887563382;8458.407911446386;8357.122502137432;8381.16188381157;8596.484210947363;8633.136686331316;8642.09258027898;5882.117682347682;6342.2389313280855;6595.274519802914;6611.933880661324;6687.431568316553;7345.926540734738;7406;7413.888791668237;7421.332080112816;7470.589117598584;6565.277819439762;6586.967065164644;6702.698378573074;6711.664416779044;6791.72833086671;6623.2383275923885;6635.6350400728425;6715.832104197434;6739.5619284746335;6764;6096.725647345791;6140.416660417253;6142.2629284484365;6232.407921247474;6243.594166379171;4118.649914757159;4312.676549258756;4340.9131817364105;4363.083752411902;4373.409589705349;4431.313146462304;4470.552944705503;4549.203889319289;4556.270996640522;4779.354787103696 13:10:10 INFO - PROCESS | 3012 | |4;prototype.html;307.0496812365728;312.3144697389231;319.6627557926388;323.83646258639385;324.64775718345595;5037.093323201822;5047.26814611881;5053.917110562558;5094.414142373624;5116.590672746181;4952.579030782379;4965.553100220988;4969.850904472863;4973.303737476747;4984.850454486362;3784.167483153709;3853.8265778039913;3974.8608798692053;3991.341428664267;3994.5206575211014;3964.345882929313;3969.0871099647097;3984;4006.9381613872347;4007.939880901789;3930.8820735377985;3952.9327081687925;3971.5035620547433;3974.225026119908;3983.5219773627205;3800.638939300762;3939.5666476687543;3944.8619298324707;3969.9603003970024;3975.1453437510786;3497.5517138003497;3501.929961400783;3541.592716837545;3547.290541891632;3557.0929412999776;4856.9314750754775;4861.149298872683;4874.975625121851;4894.730789806559;4901.338319326881;4484.417025786627;4572.702774319659;4573;4576.398260608794;4602.228142165257;5247.763850626731;5259.921101183485;5264.2893209416625;5269;5307.2569840222395;3847.826847791856;3874.7093967952515;3879.2823327684187;3886.630770076838;3900.7659540427667;5318.016167009116;5475.863103422446;5516.255305533782;5545.77816887324;5547.223388725582;3947.921041579152;3950.822213000422;3959.425883246913;3969.960300396959;3976.9602303977167;4017.6183262590007;4020.0502756163237;4027.81874815634;4046.615571520701;4047.6964227683043;4526.343680166357;4559.316102584573;4570.702904311209;4574.908501829945;4579.198640238012;5128.846009647799;5258.6581872178185;5264.42091369949;5283.471652834686;5311.389190243094;1329.322045756671;1345.2668295778824;1347.5148946379295;1350.4260689207047;1358.8369395672582;871.4335681806876;881.9426737262057;925.6528801699362;943.9292053096045;945.3052006775015;4405.955940440619;4504.819807207675;4525.366448697185;4558.202314594932;4604.171249175113;5432.701201433959;5447.918281225785;5453.318335208099;5463.672179669233;5490.505854473036;4393.253146964959;4521.59305662492;4548.340490628841;4582.221022426195;4584.633229341644;2787.7315821301663;2802.6407192511615;2827.7596404305864;2831.7026712195334;2833.914982550527;4914.410270767459;4921.040397122527;4980.427250866197;4988.35151430319;5004.649674522821;5293.655912365761;5379.946200538023;5460.863478413072;5493.066178749622;5659.547236221092;5183.818566350235;5185.248139019821;5197.142471492161;5198.610104242121;5208.6874787512115;5496.5053145217125;5499.175123731312;5502.889942201214;5503.532199763065;5526.613137080527;5243.606729495227;5427.158790387496;5427.511523962862;5469.945300546943;5489.505944465017;5175.948240517697;5181.404138524118;5195.272661827272;5199.168133098686;5204.947950520598;3813.8474461021246;3830.5211848518934;3851.614838516126;3860.6450065459485;3860.749051311656;5346.476254267515;5499.202615620793;5515.365732940763;5532;5564.860878478071;5293.947060529345;5309.415964243853;5322.403279016357;5334.653247538898;5340.839774806762;5271.393789714232;5299.629025968299;5302.734863256899;5319;5324.47087633371;4947.480514546065;5208.921866171935;5217.113090774502;5218.947810521846;5225.346831646044;5041.899162016666;5216.426193118678;5292.761825717775;5346.647475110939;5353.411124776194;5225.372955245395;5227.3465816772905;5246.632735708464;5257.211418287135;5285.762140703754 13:10:10 INFO - PROCESS | 3012 | |5;yui.html;716.5342527357217;746.66400119946;770.7764748223015;789.2896393246078;805.7542449552891;11385.943070284648;11972.700682482942;12008.519659213633;12065.276083435;12095.879041209597;11803.173777835555;11876.465559049842;11882.643520694393;11896.643100706993;11897.643070707893;665.5806841689729;865.6148014133713;866.0862789756804;876.1370050500252;876.7282142535835;885.5926273914007;887.0951629338072;887.1350433327518;887.4675194883083;889.1819526036062;929.0755698080386;932.4684929590136;932.8787257656529;934.9392289501161;935.8315503209419;922.239152699026;922.2898368256439;922.7739203895021;928.7956649537091;928.9163975242227;675.9594424334556;676.5805200775501;678.0744284052282;680.0750978669006;680.6562685843667;11497;11523.308601483854;11523.711907202387;11542.538298468051;11551.826722599168;12889.291088990101;13030.54393096237;13182.60452186436;13429.261390623511;13550.390232439564;10498.527566259536;10535.789284214272;10638.840417393745;10710.839337409945;10776.946115269373;3106;3109.3781243751114;3151.43274210642;3161;3185.267388500658;47826.52173478255;48179;48688.99999999964;48858;48888;10377.9481102594;10651.094656954245;10657.413842238751;10813.83779243312;11007.119430445706;18938.337158199396;18985.145668444955;19004.04979751007;19037.524061898286;19100.426987190407;6694.230163531159;6784.626845523544;6890.8621827563165;6913;6968;3609.097725568608;3643.5263415756312;3687.520622319081;3701.4937247648268;3712.870049548253;2914.1548950804454;2939.5737618045264;2978.255436140965;2979.702029797003;3000.9496676163603;505.07571144804916;508.99491005090215;512.4721536817084;517.252570036294;519.1408219396905;569.732225853848;590.4243362721312;644.2269276867777;651.4332530698323;664.465105589995;7591.696332146652;7662.118856331594;7732.845343093107;7849;8018.278354947966;598.7245866901275;623.856513002003;629.789020678078;630.7161777200279;638.4923985431593;3545.751797374159;3860.942085868714;3883.2427676603356;3961.960380396159;3996.5803590623145;43061;43885.341719874225;44859.77570112129;49902;49981;45691;46260.7686961563;47034.529654703016;47480.52519474761;48008.27987580189;42617.78691106525;43072.78463607662;43333.349999750026;43340;43875.341869871976;7684.884726728992;7746.218369774871;7786.844263114593;8027.478213916077;8046.597670116588;29243.85378073096;29361.11916642504;29594;29792.10623681293;29858.992290118716;35713.821430892676;37210.06974825651;38294.61705383022;38485.07574621202;38528.42207366948;10856;10918.672439826818;10951.397673128055;10958.28771129874;10996.28524145928;11734.70663233426;11928.4035798208;12695.42870570808;12700;12748.171368860994;10929.289596176222;11242.718932026764;11383.317000979967;11454.94272528632;11494.94252528732;10745.785084298113;10865.18511111654;11022.559097636326;11113.388763617755;11128.499217535069;10700.946495267473;10910.23628346008;10956.28784129029;11066.889331106586;11535.76928461443;9279.164875161268;9460.262601946977;9562.856557151508;9616.807663846825;9729.756756081155;9392.389494682824;9428.905710942803;9551.761205969906;9674.177694896012;9850.408975461496 13:10:10 INFO - PROCESS | 3012 | __end_tp_report 13:10:10 INFO - PROCESS | 3012 | __start_cc_report 13:10:10 INFO - PROCESS | 3012 | _x_x_mozilla_cycle_collect,394 13:10:10 INFO - PROCESS | 3012 | __end_cc_report 13:10:10 INFO - PROCESS | 3012 | __startTimestamp1462824610588__endTimestamp 13:10:10 INFO - PROCESS | 3012 | 13:10:10 INFO - PROCESS | 3012 | ------- Summary: start ------- 13:10:10 INFO - PROCESS | 3012 | Number of tests: 6 13:10:10 INFO - PROCESS | 3012 | 13:10:10 INFO - PROCESS | 3012 | [#0] dojo.html Cycles:165 Average:4746.36 Median:4910.61 stddev:607.78 (12.4%) stddev-sans-first:587.07 13:10:10 INFO - PROCESS | 3012 | Values: 2654.5 2679.8 2685.4 2691.8 2713.1 4647.0 4670.0 4701.8 4757.1 4757.4 4667.6 4784.4 4798.1 4822.8 4838.9 4362.5 4446.0 4493.4 4505.5 4507.6 579.7 4263.9 4297.0 4439.5 4443.1 4284.7 4354.4 4355.7 4357.1 4359.5 4389.4 4413.9 4430.4 4447.5 4450.6 4318.5 4322.8 4387.6 4414.1 4419.2 4610.2 4653.1 4683.5 4697.2 4701.7 5100.3 5105.9 5106.3 5108.7 5123.6 4998.3 5157.2 5183.0 5214.2 5248.0 4886.3 4886.5 4910.6 4917.8 4962.3 5305.9 5381.1 5381.7 5394.0 5399.7 4933.7 5077.2 5106.5 5125.9 5152.0 5209.0 5220.5 5222.0 5236.7 5245.2 5179.9 5193.6 5194.5 5195.9 5199.6 4962.2 5122.2 5133.2 5153.7 5167.1 4403.9 4451.2 4468.0 4475.2 4509.1 3776.8 3899.0 3905.7 3916.9 3946.1 4280.0 4365.7 4394.7 4404.1 4420.2 5107.5 5125.9 5189.5 5190.2 5239.8 4303.8 4412.8 4413.6 4419.0 4465.9 4623.2 4654.5 4660.6 4700.4 4705.6 4817.7 4844.2 4847.7 4848.0 4887.7 5182.4 5182.8 5184.6 5184.7 5240.5 4729.6 4855.5 4890.2 4908.3 4919.0 5160.8 5162.0 5164.8 5175.7 5223.4 5050.3 5227.7 5237.9 5254.4 5264.3 5012.3 5019.9 5061.3 5064.7 5096.0 5068.0 5073.7 5084.0 5089.7 5144.3 4767.5 4903.5 5002.3 5009.5 5012.4 4987.3 5069.4 5094.2 5097.9 5147.8 4978.8 4992.0 4995.1 5000.7 5043.3 13:10:10 INFO - PROCESS | 3012 | 13:10:10 INFO - PROCESS | 3012 | [#1] ext.html Cycles:180 Average:45334.86 Median:37060.00 stddev:76215.56 (205.7%) stddev-sans-first:76355.29 13:10:10 INFO - PROCESS | 3012 | Values: 578.9 601.7 617.5 619.9 622.2 40565.0 42145.8 42253.0 42278.8 46482.3 41958.8 42502.0 42509.4 42631.4 42697.6 7916.6 8045.5 8049.9 8060.2 8070.8 7901.8 8001.0 8008.2 8020.6 8036.7 8004.9 8022.4 8052.1 8075.1 8087.3 7871.6 7929.4 8017.4 8036.1 8043.9 7620.6 7705.7 7728.7 7744.8 7768.1 38243.8 38616.8 38626.0 38643.0 38756.0 3158.7 3222.2 3227.5 3360.2 3525.6 28744.0 29384.0 29453.3 29653.3 29681.3 3541.8 3561.3 3656.6 3701.1 3807.8 237737.0 239479.0 239695.0 239930.0 240575.0 54700.7 55115.7 55311.2 55316.0 55329.4 58147.7 58329.7 58485.7 58512.4 58648.0 13032.9 13424.5 13442.1 13442.7 13484.5 10042.8 10107.5 10141.4 10181.9 10185.4 16504.0 16794.7 16836.6 16839.0 16917.9 5829.6 6584.4 6620.5 6650.5 6708.4 862.3 962.6 967.6 1030.1 1039.8 28886.3 28971.9 29231.9 29449.6 29663.3 951.2 976.6 1013.2 1014.3 1071.9 14299.8 14687.0 14772.4 14832.3 14952.5 347186.0 347857.0 348262.0 349124.0 349960.0 49426.0 49922.5 50014.5 50075.5 50237.7 1235.9 1283.2 1286.3 1289.9 1295.2 28111.4 29355.3 29751.4 30081.5 30415.5 42931.8 43064.4 43529.3 43598.6 43629.6 269462.0 272868.0 274945.0 275325.0 276861.0 25494.2 25781.5 25931.7 25974.9 25980.9 41948.0 42853.8 42952.0 42980.8 43865.3 37098.0 37131.8 37241.6 37477.3 37647.6 36679.3 36926.9 37468.6 37508.4 37818.6 35916.8 36094.8 36622.8 36909.8 37022.0 32526.8 33004.8 33432.5 33887.5 33967.7 25689.5 25756.2 26224.2 26322.9 26581.5 13:10:10 INFO - PROCESS | 3012 | 13:10:10 INFO - PROCESS | 3012 | [#2] jquery.html Cycles:180 Average:24096.62 Median:203713.09 stddev:65046.17 (31.9%) stddev-sans-first:65204.25 13:10:10 INFO - PROCESS | 3012 | Values: 372.8 375.3 376.0 379.8 395.8 16058.1 16517.7 17338.7 17533.4 17542.2 11080.6 11474.8 11491.5 11502.5 11541.1 4646.4 4694.1 4831.4 4833.1 4878.9 4733.2 4748.6 4827.6 4837.5 4857.5 4663.4 4827.9 4841.7 4860.1 4861.6 4791.4 4803.1 4804.8 4831.0 4844.3 4564.9 4660.4 4705.7 4719.2 4740.3 11944.0 12220.2 12403.4 12431.9 12438.8 1855.0 1937.5 2046.2 2047.7 2244.5 9777.7 9791.8 10049.6 11216.8 14021.2 1830.0 1831.6 1872.7 1902.4 1984.4 59878.4 63263.0 65361.7 65684.7 69167.7 9899.0 9983.3 10150.5 10422.9 10693.6 12845.7 12878.5 12882.2 12923.9 13017.4 6720.8 6731.0 6789.2 6808.9 6909.0 6396.7 6426.8 6462.0 6491.4 6517.3 4442.2 4459.6 4495.6 4538.7 4579.0 1823.4 1838.3 1903.6 1911.8 1919.1 827.6 856.6 902.6 904.3 914.6 16740.4 16744.3 17344.9 17750.5 17823.6 882.1 884.5 887.6 899.0 954.5 8770.4 9880.6 9949.6 10105.2 10158.2 361761.0 395967.0 400347.0 402740.0 402984.0 82626.0 83571.0 85264.6 86795.0 88126.6 952.9 957.2 975.8 982.7 992.4 15569.8 15647.5 15664.1 15717.3 16073.1 35656.8 35986.0 36322.0 36629.6 37007.8 48536.5 50268.0 50630.7 50708.7 50726.5 7871.2 7879.0 7892.8 8102.0 8230.6 12012.7 12089.6 12178.0 12217.6 12249.9 10417.8 10554.4 10661.5 10714.6 10839.8 10345.9 10696.4 10698.2 10733.5 11035.7 10568.6 10571.5 10652.5 10720.8 10740.4 6920.4 8036.7 8047.3 8063.8 8067.8 9283.8 9833.8 10237.6 10618.4 10785.4 13:10:10 INFO - PROCESS | 3012 | 13:10:10 INFO - PROCESS | 3012 | [#3] mootools.html Cycles:180 Average:4981.05 Median:5654.55 stddev:2681.82 (47.4%) stddev-sans-first:2676.33 13:10:10 INFO - PROCESS | 3012 | Values: 1465.4 1477.9 1615.3 1779.2 1791.4 6659.9 6860.4 7253.7 7391.7 7400.2 7291.8 7516.9 7533.5 7548.7 7564.6 2187.4 2214.9 2218.8 2218.8 2219.2 2176.9 2179.4 2224.4 2228.8 2246.6 2174.1 2197.5 2219.0 2224.8 2226.5 2133.5 2145.8 2146.6 2146.8 2159.6 2151.2 2156.9 2180.1 2183.2 2202.0 7470.4 7474.1 7525.5 7529.8 7556.2 4371.9 4537.3 4537.8 4540.6 4575.3 2964.3 2983.2 3035.7 3057.1 3082.4 962.1 975.5 987.0 988.9 1004.0 9849.3 9863.3 9924.7 9926.3 9928.5 4096.7 4121.1 4214.0 4241.5 4286.4 8553.1 8569.9 8574.4 8597.8 8612.1 4472.2 4531.5 4536.8 4548.1 4549.5 3420.6 3894.4 4011.8 4112.4 4138.5 3583.9 3606.1 3729.8 3773.7 3853.5 1218.9 1224.2 1225.4 1238.4 1238.9 810.8 824.5 903.0 903.2 911.5 4927.4 5052.5 5141.0 5149.6 5154.7 876.4 888.2 890.7 899.0 919.5 3422.7 3439.0 3453.8 3506.9 3553.3 8964.2 9286.2 9306.1 9319.2 9338.6 8631.4 9141.6 9170.8 9213.8 9275.4 6704.7 6975.7 7032.9 7035.7 7098.7 5099.8 5318.4 5328.1 5400.7 5427.0 8254.0 8326.5 8335.2 8403.7 8458.4 8357.1 8381.2 8596.5 8633.1 8642.1 5882.1 6342.2 6595.3 6611.9 6687.4 7345.9 7406.0 7413.9 7421.3 7470.6 6565.3 6587.0 6702.7 6711.7 6791.7 6623.2 6635.6 6715.8 6739.6 6764.0 6096.7 6140.4 6142.3 6232.4 6243.6 4118.6 4312.7 4340.9 4363.1 4373.4 4431.3 4470.6 4549.2 4556.3 4779.4 13:10:10 INFO - PROCESS | 3012 | 13:10:10 INFO - PROCESS | 3012 | [#4] prototype.html Cycles:180 Average:4402.12 Median:4971.58 stddev:1271.75 (25.6%) stddev-sans-first:1237.62 13:10:10 INFO - PROCESS | 3012 | Values: 307.0 312.3 319.7 323.8 324.6 5037.1 5047.3 5053.9 5094.4 5116.6 4952.6 4965.6 4969.9 4973.3 4984.9 3784.2 3853.8 3974.9 3991.3 3994.5 3964.3 3969.1 3984.0 4006.9 4007.9 3930.9 3952.9 3971.5 3974.2 3983.5 3800.6 3939.6 3944.9 3970.0 3975.1 3497.6 3501.9 3541.6 3547.3 3557.1 4856.9 4861.1 4875.0 4894.7 4901.3 4484.4 4572.7 4573.0 4576.4 4602.2 5247.8 5259.9 5264.3 5269.0 5307.3 3847.8 3874.7 3879.3 3886.6 3900.8 5318.0 5475.9 5516.3 5545.8 5547.2 3947.9 3950.8 3959.4 3970.0 3977.0 4017.6 4020.1 4027.8 4046.6 4047.7 4526.3 4559.3 4570.7 4574.9 4579.2 5128.8 5258.7 5264.4 5283.5 5311.4 1329.3 1345.3 1347.5 1350.4 1358.8 871.4 881.9 925.7 943.9 945.3 4406.0 4504.8 4525.4 4558.2 4604.2 5432.7 5447.9 5453.3 5463.7 5490.5 4393.3 4521.6 4548.3 4582.2 4584.6 2787.7 2802.6 2827.8 2831.7 2833.9 4914.4 4921.0 4980.4 4988.4 5004.6 5293.7 5379.9 5460.9 5493.1 5659.5 5183.8 5185.2 5197.1 5198.6 5208.7 5496.5 5499.2 5502.9 5503.5 5526.6 5243.6 5427.2 5427.5 5469.9 5489.5 5175.9 5181.4 5195.3 5199.2 5204.9 3813.8 3830.5 3851.6 3860.6 3860.7 5346.5 5499.2 5515.4 5532.0 5564.9 5293.9 5309.4 5322.4 5334.7 5340.8 5271.4 5299.6 5302.7 5319.0 5324.5 4947.5 5208.9 5217.1 5218.9 5225.3 5041.9 5216.4 5292.8 5346.6 5353.4 5225.4 5227.3 5246.6 5257.2 5285.8 13:10:10 INFO - PROCESS | 3012 | 13:10:10 INFO - PROCESS | 3012 | [#5] yui.html Cycles:180 Average:12768.21 Median:42839.39 stddev:14209.01 (33.2%) stddev-sans-first:14220.05 13:10:10 INFO - PROCESS | 3012 | Values: 716.5 746.7 770.8 789.3 805.8 11385.9 11972.7 12008.5 12065.3 12095.9 11803.2 11876.5 11882.6 11896.6 11897.6 665.6 865.6 866.1 876.1 876.7 885.6 887.1 887.1 887.5 889.2 929.1 932.5 932.9 934.9 935.8 922.2 922.3 922.8 928.8 928.9 676.0 676.6 678.1 680.1 680.7 11497.0 11523.3 11523.7 11542.5 11551.8 12889.3 13030.5 13182.6 13429.3 13550.4 10498.5 10535.8 10638.8 10710.8 10776.9 3106.0 3109.4 3151.4 3161.0 3185.3 47826.5 48179.0 48689.0 48858.0 48888.0 10377.9 10651.1 10657.4 10813.8 11007.1 18938.3 18985.1 19004.0 19037.5 19100.4 6694.2 6784.6 6890.9 6913.0 6968.0 3609.1 3643.5 3687.5 3701.5 3712.9 2914.2 2939.6 2978.3 2979.7 3000.9 505.1 509.0 512.5 517.3 519.1 569.7 590.4 644.2 651.4 664.5 7591.7 7662.1 7732.8 7849.0 8018.3 598.7 623.9 629.8 630.7 638.5 3545.8 3860.9 3883.2 3962.0 3996.6 43061.0 43885.3 44859.8 49902.0 49981.0 45691.0 46260.8 47034.5 47480.5 48008.3 42617.8 43072.8 43333.3 43340.0 43875.3 7684.9 7746.2 7786.8 8027.5 8046.6 29243.9 29361.1 29594.0 29792.1 29859.0 35713.8 37210.1 38294.6 38485.1 38528.4 10856.0 10918.7 10951.4 10958.3 10996.3 11734.7 11928.4 12695.4 12700.0 12748.2 10929.3 11242.7 11383.3 11454.9 11494.9 10745.8 10865.2 11022.6 11113.4 11128.5 10700.9 10910.2 10956.3 11066.9 11535.8 9279.2 9460.3 9562.9 9616.8 9729.8 9392.4 9428.9 9551.8 9674.2 9850.4 13:10:10 INFO - PROCESS | 3012 | -------- Summary: end -------- 13:10:10 INFO - PROCESS | 3012 | 13:10:11 INFO - TEST-INFO | 3012: exit 0 13:10:11 INFO - TEST-OK | dromaeo_css | took 1115641ms 13:10:11 INFO - TEST-START | kraken 13:10:11 INFO - operating with platform_type : linux_ 13:10:11 INFO - Initialising browser for kraken test... 13:10:11 INFO - TEST-INFO | started process 3245 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXEPB_K/profile http://localhost:36641/getInfo.html) 13:10:15 INFO - PROCESS | 3245 | 13:10:15 INFO - PROCESS | 3245 | (process:3312): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 13:10:16 INFO - PROCESS | 3245 | __metrics Screen width/height:1600/1200 13:10:16 INFO - PROCESS | 3245 | colorDepth:24 13:10:16 INFO - PROCESS | 3245 | Browser inner width/height: 1024/697 13:10:16 INFO - PROCESS | 3245 | __metrics 13:10:16 ERROR - PROCESS | 3245 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2937: TypeError: this.tabs is undefined 13:10:17 INFO - TEST-INFO | 3245: exit 0 13:10:17 INFO - Browser initialized. 13:10:17 INFO - Running cycle 1/1 for kraken test... 13:10:17 INFO - TEST-INFO | started process 3363 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXEPB_K/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:10:19 INFO - PROCESS | 3363 | 13:10:19 INFO - PROCESS | 3363 | (process:3423): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 13:10:29 INFO - PROCESS | 3363 | RSS: Main: 164155392 13:10:29 INFO - PROCESS | 3363 | 13:10:32 INFO - PROCESS | 3363 | Cycle 1(1): loaded http://localhost:36641/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36641/tests/kraken/driver.html?testName=audio-beat-detection) 13:10:33 INFO - PROCESS | 3363 | RSS: Main: 167329792 13:10:33 INFO - PROCESS | 3363 | 13:10:36 INFO - PROCESS | 3363 | Cycle 1(1): loaded http://localhost:36641/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36641/tests/kraken/driver.html?testName=audio-dft) 13:10:36 INFO - PROCESS | 3363 | RSS: Main: 168222720 13:10:36 INFO - PROCESS | 3363 | 13:10:39 INFO - PROCESS | 3363 | Cycle 1(1): loaded http://localhost:36641/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36641/tests/kraken/driver.html?testName=audio-fft) 13:10:40 INFO - PROCESS | 3363 | RSS: Main: 164020224 13:10:40 INFO - PROCESS | 3363 | 13:10:42 INFO - PROCESS | 3363 | Cycle 1(1): loaded http://localhost:36641/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36641/tests/kraken/driver.html?testName=audio-oscillator) 13:10:43 INFO - PROCESS | 3363 | RSS: Main: 163741696 13:10:43 INFO - PROCESS | 3363 | 13:10:45 INFO - PROCESS | 3363 | Cycle 1(1): loaded http://localhost:36641/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36641/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:10:46 INFO - PROCESS | 3363 | RSS: Main: 164315136 13:10:46 INFO - PROCESS | 3363 | 13:10:49 INFO - PROCESS | 3363 | Cycle 1(1): loaded http://localhost:36641/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36641/tests/kraken/driver.html?testName=imaging-darkroom) 13:10:50 INFO - PROCESS | 3363 | RSS: Main: 164753408 13:10:50 INFO - PROCESS | 3363 | 13:10:53 INFO - PROCESS | 3363 | Cycle 1(1): loaded http://localhost:36641/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36641/tests/kraken/driver.html?testName=imaging-desaturate) 13:10:54 INFO - PROCESS | 3363 | RSS: Main: 163545088 13:10:54 INFO - PROCESS | 3363 | 13:10:57 INFO - PROCESS | 3363 | Cycle 1(1): loaded http://localhost:36641/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36641/tests/kraken/driver.html?testName=json-parse-financial) 13:10:58 INFO - PROCESS | 3363 | RSS: Main: 163315712 13:10:58 INFO - PROCESS | 3363 | 13:10:59 INFO - PROCESS | 3363 | Cycle 1(1): loaded http://localhost:36641/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36641/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:11:00 INFO - PROCESS | 3363 | RSS: Main: 163782656 13:11:00 INFO - PROCESS | 3363 | 13:11:02 INFO - PROCESS | 3363 | Cycle 1(1): loaded http://localhost:36641/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36641/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:11:03 INFO - PROCESS | 3363 | RSS: Main: 164229120 13:11:03 INFO - PROCESS | 3363 | 13:11:05 INFO - PROCESS | 3363 | Cycle 1(1): loaded http://localhost:36641/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36641/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:11:06 INFO - PROCESS | 3363 | RSS: Main: 165003264 13:11:06 INFO - PROCESS | 3363 | 13:11:08 INFO - PROCESS | 3363 | Cycle 1(1): loaded http://localhost:36641/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36641/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:11:09 INFO - PROCESS | 3363 | RSS: Main: 164196352 13:11:09 INFO - PROCESS | 3363 | 13:11:12 INFO - PROCESS | 3363 | Cycle 1(1): loaded http://localhost:36641/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36641/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:11:13 INFO - PROCESS | 3363 | RSS: Main: 164630528 13:11:13 INFO - PROCESS | 3363 | 13:11:14 INFO - PROCESS | 3363 | Cycle 1(1): loaded http://localhost:36641/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36641/tests/kraken/driver.html?testName=ai-astar) 13:11:15 INFO - PROCESS | 3363 | RSS: Main: 166973440 13:11:15 INFO - PROCESS | 3363 | 13:11:15 INFO - PROCESS | 3363 | __start_tp_report 13:11:15 INFO - PROCESS | 3363 | _x_x_mozilla_page_load 13:11:15 INFO - PROCESS | 3363 | _x_x_mozilla_page_load_details 13:11:15 INFO - PROCESS | 3363 | |i|pagename|runs| 13:11:15 INFO - PROCESS | 3363 | |0;ai-astar;110;118;108;115;114;117;108;115;120;117 13:11:15 INFO - PROCESS | 3363 | |1;audio-beat-detection;163;132;167;215;132;158;174;132;195;131 13:11:15 INFO - PROCESS | 3363 | |2;audio-dft;163;166;180;163;164;163;163;164;165;163 13:11:15 INFO - PROCESS | 3363 | |3;audio-fft;76;76;77;169;76;77;77;76;154;78 13:11:15 INFO - PROCESS | 3363 | |4;audio-oscillator;93;94;172;94;94;93;145;93;93;146 13:11:15 INFO - PROCESS | 3363 | |5;imaging-gaussian-blur;117;120;118;118;118;118;119;119;118;118 13:11:15 INFO - PROCESS | 3363 | |6;imaging-darkroom;148;148;147;147;148;147;147;146;147;148 13:11:15 INFO - PROCESS | 3363 | |7;imaging-desaturate;95;95;96;95;95;95;96;94;95;95 13:11:15 INFO - PROCESS | 3363 | |8;json-parse-financial;65;67;67;65;66;66;66;66;65;66 13:11:15 INFO - PROCESS | 3363 | |9;json-stringify-tinderbox;65;65;65;65;64;64;65;65;65;66 13:11:15 INFO - PROCESS | 3363 | |10;stanford-crypto-aes;83;82;82;82;84;87;83;83;151;87 13:11:15 INFO - PROCESS | 3363 | |11;stanford-crypto-ccm;141;141;141;128;130;132;132;137;164;136 13:11:15 INFO - PROCESS | 3363 | |12;stanford-crypto-pbkdf2;179;179;179;175;175;177;172;174;172;173 13:11:15 INFO - PROCESS | 3363 | |13;stanford-crypto-sha256-iterative;68;68;69;71;69;69;67;70;69;68 13:11:15 INFO - PROCESS | 3363 | __end_tp_report 13:11:15 INFO - PROCESS | 3363 | __start_cc_report 13:11:15 INFO - PROCESS | 3363 | _x_x_mozilla_cycle_collect,959 13:11:15 INFO - PROCESS | 3363 | __end_cc_report 13:11:15 INFO - PROCESS | 3363 | __startTimestamp1462824675252__endTimestamp 13:11:15 INFO - PROCESS | 3363 | 13:11:15 INFO - PROCESS | 3363 | ------- Summary: start ------- 13:11:15 INFO - PROCESS | 3363 | Number of tests: 14 13:11:15 INFO - PROCESS | 3363 | 13:11:15 INFO - PROCESS | 3363 | [#0] ai-astar Cycles:10 Average:114.20 Median:116.00 stddev:4.21 (3.6%) stddev-sans-first:4.18 13:11:15 INFO - PROCESS | 3363 | Values: 110.0 118.0 108.0 115.0 114.0 117.0 108.0 115.0 120.0 117.0 13:11:15 INFO - PROCESS | 3363 | 13:11:15 INFO - PROCESS | 3363 | [#1] audio-beat-detection Cycles:10 Average:159.90 Median:165.00 stddev:29.25 (17.7%) stddev-sans-first:31.00 13:11:15 INFO - PROCESS | 3363 | Values: 163.0 132.0 167.0 215.0 132.0 158.0 174.0 132.0 195.0 131.0 13:11:15 INFO - PROCESS | 3363 | 13:11:15 INFO - PROCESS | 3363 | [#2] audio-dft Cycles:10 Average:165.40 Median:164.00 stddev:5.23 (3.2%) stddev-sans-first:5.48 13:11:15 INFO - PROCESS | 3363 | Values: 163.0 166.0 180.0 163.0 164.0 163.0 163.0 164.0 165.0 163.0 13:11:15 INFO - PROCESS | 3363 | 13:11:15 INFO - PROCESS | 3363 | [#3] audio-fft Cycles:10 Average:93.60 Median:76.50 stddev:35.97 (47.0%) stddev-sans-first:37.58 13:11:15 INFO - PROCESS | 3363 | Values: 76.0 76.0 77.0 169.0 76.0 77.0 77.0 76.0 154.0 78.0 13:11:15 INFO - PROCESS | 3363 | 13:11:15 INFO - PROCESS | 3363 | [#4] audio-oscillator Cycles:10 Average:111.70 Median:93.00 stddev:30.30 (32.6%) stddev-sans-first:31.37 13:11:15 INFO - PROCESS | 3363 | Values: 93.0 94.0 172.0 94.0 94.0 93.0 145.0 93.0 93.0 146.0 13:11:15 INFO - PROCESS | 3363 | 13:11:15 INFO - PROCESS | 3363 | [#5] imaging-gaussian-blur Cycles:10 Average:118.30 Median:118.00 stddev:0.82 (0.7%) stddev-sans-first:0.73 13:11:15 INFO - PROCESS | 3363 | Values: 117.0 120.0 118.0 118.0 118.0 118.0 119.0 119.0 118.0 118.0 13:11:15 INFO - PROCESS | 3363 | 13:11:15 INFO - PROCESS | 3363 | [#6] imaging-darkroom Cycles:10 Average:147.30 Median:147.50 stddev:0.67 (0.5%) stddev-sans-first:0.67 13:11:15 INFO - PROCESS | 3363 | Values: 148.0 148.0 147.0 147.0 148.0 147.0 147.0 146.0 147.0 148.0 13:11:15 INFO - PROCESS | 3363 | 13:11:15 INFO - PROCESS | 3363 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 13:11:15 INFO - PROCESS | 3363 | Values: 95.0 95.0 96.0 95.0 95.0 95.0 96.0 94.0 95.0 95.0 13:11:15 INFO - PROCESS | 3363 | 13:11:15 INFO - PROCESS | 3363 | [#8] json-parse-financial Cycles:10 Average:65.90 Median:66.00 stddev:0.74 (1.1%) stddev-sans-first:0.71 13:11:15 INFO - PROCESS | 3363 | Values: 65.0 67.0 67.0 65.0 66.0 66.0 66.0 66.0 65.0 66.0 13:11:15 INFO - PROCESS | 3363 | 13:11:15 INFO - PROCESS | 3363 | [#9] json-stringify-tinderbox Cycles:10 Average:64.90 Median:65.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 13:11:15 INFO - PROCESS | 3363 | Values: 65.0 65.0 65.0 65.0 64.0 64.0 65.0 65.0 65.0 66.0 13:11:15 INFO - PROCESS | 3363 | 13:11:15 INFO - PROCESS | 3363 | [#10] stanford-crypto-aes Cycles:10 Average:90.40 Median:83.00 stddev:21.38 (25.8%) stddev-sans-first:22.50 13:11:15 INFO - PROCESS | 3363 | Values: 83.0 82.0 82.0 82.0 84.0 87.0 83.0 83.0 151.0 87.0 13:11:15 INFO - PROCESS | 3363 | 13:11:15 INFO - PROCESS | 3363 | [#11] stanford-crypto-ccm Cycles:10 Average:138.20 Median:139.00 stddev:10.24 (7.4%) stddev-sans-first:10.81 13:11:15 INFO - PROCESS | 3363 | Values: 141.0 141.0 141.0 128.0 130.0 132.0 132.0 137.0 164.0 136.0 13:11:15 INFO - PROCESS | 3363 | 13:11:15 INFO - PROCESS | 3363 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.50 Median:176.00 stddev:2.84 (1.6%) stddev-sans-first:2.71 13:11:15 INFO - PROCESS | 3363 | Values: 179.0 179.0 179.0 175.0 175.0 177.0 172.0 174.0 172.0 173.0 13:11:15 INFO - PROCESS | 3363 | 13:11:15 INFO - PROCESS | 3363 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.80 Median:69.00 stddev:1.14 (1.6%) stddev-sans-first:1.17 13:11:15 INFO - PROCESS | 3363 | Values: 68.0 68.0 69.0 71.0 69.0 69.0 67.0 70.0 69.0 68.0 13:11:15 INFO - PROCESS | 3363 | -------- Summary: end -------- 13:11:15 INFO - PROCESS | 3363 | 13:11:16 INFO - TEST-INFO | 3363: exit 0 13:11:16 INFO - TEST-OK | kraken | took 64910ms 13:11:16 INFO - SUITE-END | took 1180s 13:11:16 INFO - Completed test suite (00:19:40) 13:11:16 INFO - javascript benchmark 13:11:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2654.4956458272927, 2679.8258113222646, 2685.43605842773, 2691.798115141365, 2713.077553631766, 4647.0, 4669.976650116753, 4701.811927522899, 4757.1437141314545, 4757.357756702844, 4667.579917807397, 4784.40194975628, 4798.136335459616, 4822.807087716487, 4838.854834354966, 4362.520122786491, 4446.0, 4493.438320209973, 4505.549445055501, 4507.57178068083, 579.7281601671903, 4263.914721705564, 4297.0331675372945, 4439.511653718088, 4443.066955939256, 4284.657227421799, 4354.412154359153, 4355.695101342892, 4357.128574285124, 4359.542248063939, 4389.407429996942, 4413.889652758675, 4430.379746835446, 4447.510773814878, 4450.554944505556, 4318.481782186158, 4322.848700295474, 4387.605115539617, 4414.05097903949, 4419.160359531678, 4610.170169369512, 4653.092646933849, 4683.484816670163, 4697.177993851063, 4701.7414042227665, 5100.285959965608, 5105.948940510584, 5106.259592359124, 5108.66793658411, 5123.564497017758, 4998.275250088753, 5157.174852023658, 5183.041137389595, 5214.243934629495, 5247.950409917993, 4886.31999960103, 4886.486918873538, 4910.607151427948, 4917.803287868517, 4962.280469331927, 5305.946940530623, 5381.13901775714, 5381.67709937405, 5394.0, 5399.676019438846, 4933.703977761345, 5077.18764997606, 5106.514881086291, 5125.948740512547, 5151.97424012885, 5209.0363282792805, 5220.477952204825, 5222.033923724123, 5236.738163091906, 5245.213218017251, 5179.870503237449, 5193.610479214074, 5194.480551944851, 5195.948040519622, 5199.558037566773, 4962.181240095344, 5122.154844450624, 5133.204353325241, 5153.742312884341, 5167.121589329823, 4403.867883963486, 4451.1765323415275, 4467.955320446819, 4475.239209334421, 4509.143262780061, 3776.773393596393, 3899.0, 3905.6875449963936, 3916.882493525142, 3946.1121247719607, 4280.0369916769105, 4365.694401391872, 4394.692371533962, 4404.075144219686, 4420.204363214652, 5107.54032137102, 5125.923111153335, 5189.455107213764, 5190.195519694454, 5239.790408383698, 4303.849365272201, 4412.757298348622, 4413.6248418884115, 4419.049904270597, 4465.866024019285, 4623.237165867661, 4654.464736555339, 4660.603848672833, 4700.412448443944, 4705.6470764692785, 4817.735024573612, 4844.2007068833955, 4847.684900481458, 4848.0, 4887.682300650446, 5182.378114626269, 5182.818601348935, 5184.585233181261, 5184.740762961912, 5240.4759524047295, 4729.55069268419, 4855.465898751205, 4890.168671325812, 4908.263760435963, 4919.0, 5160.767765450639, 5161.974190129025, 5164.8192313268855, 5175.741212939413, 5223.373195216598, 5050.3182070420025, 5227.712475813867, 5237.947620523899, 5254.369475662945, 5264.289320941624, 5012.298278240976, 5019.874503137451, 5061.342025536656, 5064.696118232918, 5096.0, 5068.037072956126, 5073.746312684277, 5084.0, 5089.694618322913, 5144.30551875492, 4767.475577686521, 4903.509649035211, 5002.349694539686, 5009.474005229398, 5012.423571289202, 4987.251912213197, 5069.391672999116, 5094.2358646203365, 5097.898042039213, 5147.845564633067, 4978.751062446936, 4992.0, 4995.075910956485, 5000.699958002531, 5043.2939388486375], "value": 4708.681811181316, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [578.9131630255462, 601.6931365003846, 617.4504690825166, 619.8915189841774, 622.1662971618032, 40565.0, 42145.78927105364, 42253.0, 42278.788606056965, 46482.302765458546, 41958.79020604893, 42502.0, 42509.36235956463, 42631.360529592006, 42697.57302426975, 7916.6437510312035, 8045.517268963881, 8049.919500805005, 8060.193980601922, 8070.757877263692, 7901.762947111567, 8001.039875214982, 8008.159143289958, 8020.598970051474, 8036.6785328587075, 8004.879926801103, 8022.358211343078, 8052.074011488666, 8075.111737708848, 8087.31257843084, 7871.5831150392905, 7929.365650747926, 8017.3586113111105, 8036.116027236999, 8043.879341809878, 7620.618969051525, 7705.730299439493, 7728.6522106505345, 7744.845103097963, 7768.145503994556, 38243.8087809562, 38616.80691596524, 38626.0, 38643.0, 38756.0, 3158.6683398243313, 3222.2105584131805, 3227.5320078588475, 3360.22714775603, 3525.5600628042994, 28744.0, 29384.0, 29453.263668408246, 29653.258668533243, 29681.257968550744, 3541.787492750443, 3561.281862793807, 3656.597774244831, 3701.130234394915, 3807.7905715185652, 237737.0, 239479.0, 239695.0, 239930.0, 240575.0, 54700.726496367264, 55115.724421377636, 55311.17033244504, 55316.0, 55329.44670553243, 58147.70926145427, 58329.70835145797, 58485.70757146187, 58512.4148758507, 58648.0, 13032.869671303166, 13424.463021479227, 13442.126261792951, 13442.731145377038, 13484.528041518499, 10042.799144017225, 10107.494625268708, 10141.391516509033, 10181.898181018243, 10185.388876667424, 16504.0, 16794.664106718043, 16836.579085522713, 16839.0, 16917.91541042287, 5829.621074630136, 6584.440322572635, 6620.470362370998, 6650.536881886074, 6708.429783468362, 862.3489265604554, 962.605331813953, 967.5645959318335, 1030.124394264869, 1039.8180318444242, 28886.277843054093, 28971.85514072416, 29231.853840731084, 29449.55825662617, 29663.25841853971, 951.2104952889085, 976.5605477535138, 1013.1742629756725, 1014.3305418423805, 1071.9303245289032, 14299.78550321746, 14687.0, 14772.380766712009, 14832.332545035499, 14952.476663316731, 347186.0, 347857.0, 348262.0, 349124.0, 349960.0, 49426.0, 49922.50077499251, 50014.49985500171, 50075.499245007086, 50237.74881125571, 1235.8887700107034, 1283.1980012492193, 1286.2668279080833, 1289.9290539020255, 1295.151675652449, 28111.43777124405, 29355.266118347212, 29751.404971900873, 30081.548776768803, 30415.54376684307, 42931.7853410731, 43064.35403468888, 43529.347059793494, 43598.56401435945, 43629.56370436255, 269462.0, 272868.0, 274945.0, 275325.0, 276861.0, 25494.235172944842, 25781.484370312115, 25931.74068259369, 25974.87012564925, 25980.8700956494, 41948.0, 42853.78573107115, 42952.0, 42980.785096074316, 43865.34201987037, 37098.0, 37131.814340928126, 37241.62758372381, 37477.25045499129, 37647.623523764414, 36679.26641467209, 36926.94535494564, 37468.62531374651, 37508.43737343887, 37818.62181378151, 35916.82041589775, 36094.8195259022, 36622.8168859154, 36909.81545092257, 37022.0, 32526.83736581302, 33004.79076017693, 33432.49851252282, 33887.491687625195, 33967.66032339645, 25689.486210275318, 25756.227313180636, 26224.21327360182, 26322.86838565795, 26581.468370632865], "value": 17720.134658886913, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [372.8266356144392, 375.318796384562, 375.9548854137504, 379.7721367179691, 395.8337498250734, 16058.116803575798, 16517.669646607075, 17338.653226935454, 17533.386331478418, 17542.210600522976, 11080.556777728882, 11474.827877581843, 11491.482883270251, 11502.539898404053, 11541.076713862893, 4646.442426908776, 4694.108119457309, 4831.396075490564, 4833.057553777015, 4878.902421951559, 4733.242681171013, 4748.643851711118, 4827.58965487934, 4837.516248375169, 4857.489963553829, 4663.417072865892, 4827.879303017417, 4841.661083724141, 4860.100881336946, 4861.562459378655, 4791.448983366922, 4803.111424386465, 4804.783784729696, 4830.951690483085, 4844.2733589961435, 4564.931526027112, 4660.39414876064, 4705.741184234866, 4719.150552900476, 4740.265258884879, 11944.0, 12220.20568663043, 12403.441845116991, 12431.875681243162, 12438.81341779874, 1854.9629007419776, 1937.5059359863285, 2046.1610739596695, 2047.6723724204205, 2244.461329280961, 9777.706668799947, 9791.755206119833, 10049.648262310784, 11216.831747523795, 14021.158730476203, 1830.0300840554528, 1831.569581148429, 1872.7284543741082, 1902.4007437657094, 1984.4046785964154, 59878.40121598772, 63263.0, 65361.67319163374, 65684.6715766418, 69167.65416172887, 9898.950505247427, 9983.251256155672, 10150.543225554868, 10422.947885260524, 10693.625723099654, 12845.743085138245, 12878.484860605658, 12882.162659427107, 12923.870761292455, 13017.414216360286, 6720.764773232913, 6731.0, 6789.185297764201, 6808.863822723617, 6908.965455172692, 6396.744130234832, 6426.839329016719, 6461.988886454571, 6491.350864913566, 6517.250516190698, 4442.178197033559, 4459.643228541709, 4495.595396414338, 4538.704984176084, 4578.9542104579195, 1823.4165067178642, 1838.3290099113726, 1903.6097599991967, 1911.8491696841054, 1919.0788421557452, 827.557256867573, 856.5802756649197, 902.6028547439237, 904.2539904578749, 914.5564401265381, 16740.414085507193, 16744.330226791037, 17344.91327543354, 17750.46748597544, 17823.554411139827, 882.1134759566595, 884.5488800711684, 887.587271918561, 899.0, 954.5131982688879, 8770.429922055046, 9880.555375008142, 9949.55227014786, 10105.242106842017, 10158.187345012382, 361761.0, 395967.0, 400347.0, 402740.0, 402984.0, 82626.0, 83571.0, 85264.57367713246, 86795.0, 88126.55936720276, 952.8713623660717, 957.2437774158476, 975.7902051059057, 982.6560703753772, 992.399598243067, 15569.844301557292, 15647.530574082795, 15664.138472384127, 15717.292721827316, 16073.115978621288, 35656.82171589229, 35986.0, 36322.0, 36629.63370366262, 37007.814960925025, 48536.51463485461, 50268.0, 50630.74684626553, 50708.74645626748, 50726.492735073654, 7871.195018482406, 7878.960605196938, 7892.763217103496, 8101.959490202511, 8230.588470576567, 12012.699682508008, 12089.637310880687, 12178.0, 12217.633470995885, 12249.938750306192, 10417.84373234387, 10554.366737995744, 10661.520231589751, 10714.571417143226, 10839.783204336027, 10345.948270258601, 10696.41169735672, 10698.197635177548, 10733.516991735234, 11035.668929932115, 10568.588469184891, 10571.524281407508, 10652.467376630982, 10720.785584288427, 10740.409277489813, 6920.41176499983, 8036.67853285862, 8047.315978141924, 8063.758087257392, 8067.798305042186, 9283.80645994058, 9833.754156146153, 10237.590496380062, 10618.415987120783, 10785.40680262593], "value": 8018.496288180916, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1465.406510363303, 1477.9113253204807, 1615.3054186699721, 1779.234928980538, 1791.4088350844222, 6659.866802663956, 6860.416864566511, 7253.673584688689, 7391.704331826727, 7400.185979542252, 7291.817704557388, 7516.924830751691, 7533.547987120776, 7548.660310286036, 7564.583947882864, 2187.387531491185, 2214.9224777132804, 2218.7892150245702, 2218.800307972282, 2219.1678120704737, 2176.85850419723, 2179.411558879102, 2224.410531209231, 2228.799408053275, 2246.5619204255177, 2174.0760176924823, 2197.549502352014, 2219.034719896842, 2224.7997680208778, 2226.487907781211, 2133.4666333416644, 2145.8068773810433, 2146.64580344243, 2146.774588668191, 2159.5680863827297, 2151.247063527768, 2156.924507642225, 2180.07346877578, 2183.2467798609455, 2202.0, 7470.3650189733935, 7474.103107627066, 7525.510841795266, 7529.811754706121, 7556.206598307209, 4371.868843934687, 4537.296719008559, 4537.750423726694, 4540.614047805941, 4575.267957126844, 2964.2589352661835, 2983.209449495885, 3035.666076731558, 3057.143999680093, 3082.4143412751505, 962.1052421248237, 975.4586204656413, 986.9703908882746, 988.9258305627106, 1003.989960100397, 9849.261305402124, 9863.260255480867, 9924.652637157666, 9926.255530835217, 9928.45393503357, 4096.73371230869, 4121.1345617420675, 4214.030772922245, 4241.4698162729655, 4286.39990401344, 8553.144685531397, 8569.928758905136, 8574.356923230782, 8597.78505537354, 8612.095729948265, 4472.1502914446155, 4531.478879928784, 4536.841210557614, 4548.067646132535, 4549.45406551216, 3420.640832712579, 3894.415837624322, 4011.799410029487, 4112.383142528644, 4138.544760076389, 3583.9104022399647, 3606.13452771333, 3729.7948612826012, 3773.6981041516615, 3853.479780229633, 1218.9085818563642, 1224.2287358963795, 1225.3811825028304, 1238.3746208164998, 1238.9318587477594, 810.8459392715365, 824.5258976088653, 902.9864552031725, 903.1826197291462, 911.5032307392487, 4927.359443272351, 5052.494750524918, 5141.048905952411, 5149.639525233272, 5154.664946778447, 876.3602570123718, 888.1828717579842, 890.679355432044, 898.9865152022725, 919.5080631862055, 3422.7261819054916, 3438.951119908452, 3453.8445769939913, 3506.947395789065, 3553.3248682750714, 8964.193222609996, 9286.164245217962, 9306.06939306064, 9319.207867331354, 9338.57976391064, 8631.395802293779, 9141.63433462654, 9170.770730731785, 9213.76965575866, 9275.443473391619, 6704.698288577026, 6975.651217439006, 7032.859342813115, 7035.683394247271, 7098.716051357887, 5099.821506247264, 5318.414974352895, 5328.147496400712, 5400.702961337164, 5426.972865135649, 8253.95873020631, 8326.50040997542, 8335.249827515552, 8403.747887563382, 8458.407911446386, 8357.122502137432, 8381.16188381157, 8596.484210947363, 8633.136686331316, 8642.09258027898, 5882.117682347682, 6342.2389313280855, 6595.274519802914, 6611.933880661324, 6687.431568316553, 7345.926540734738, 7406.0, 7413.888791668237, 7421.332080112816, 7470.589117598584, 6565.277819439762, 6586.967065164644, 6702.698378573074, 6711.664416779044, 6791.72833086671, 6623.2383275923885, 6635.6350400728425, 6715.832104197434, 6739.5619284746335, 6764.0, 6096.725647345791, 6140.416660417253, 6142.2629284484365, 6232.407921247474, 6243.594166379171, 4118.649914757159, 4312.676549258756, 4340.9131817364105, 4363.083752411902, 4373.409589705349, 4431.313146462304, 4470.552944705503, 4549.203889319289, 4556.270996640522, 4779.354787103696], "value": 4083.929783943404, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [307.0496812365728, 312.3144697389231, 319.6627557926388, 323.83646258639385, 324.64775718345595, 5037.093323201822, 5047.26814611881, 5053.917110562558, 5094.414142373624, 5116.590672746181, 4952.579030782379, 4965.553100220988, 4969.850904472863, 4973.303737476747, 4984.850454486362, 3784.167483153709, 3853.8265778039913, 3974.8608798692053, 3991.341428664267, 3994.5206575211014, 3964.345882929313, 3969.0871099647097, 3984.0, 4006.9381613872347, 4007.939880901789, 3930.8820735377985, 3952.9327081687925, 3971.5035620547433, 3974.225026119908, 3983.5219773627205, 3800.638939300762, 3939.5666476687543, 3944.8619298324707, 3969.9603003970024, 3975.1453437510786, 3497.5517138003497, 3501.929961400783, 3541.592716837545, 3547.290541891632, 3557.0929412999776, 4856.9314750754775, 4861.149298872683, 4874.975625121851, 4894.730789806559, 4901.338319326881, 4484.417025786627, 4572.702774319659, 4573.0, 4576.398260608794, 4602.228142165257, 5247.763850626731, 5259.921101183485, 5264.2893209416625, 5269.0, 5307.2569840222395, 3847.826847791856, 3874.7093967952515, 3879.2823327684187, 3886.630770076838, 3900.7659540427667, 5318.016167009116, 5475.863103422446, 5516.255305533782, 5545.77816887324, 5547.223388725582, 3947.921041579152, 3950.822213000422, 3959.425883246913, 3969.960300396959, 3976.9602303977167, 4017.6183262590007, 4020.0502756163237, 4027.81874815634, 4046.615571520701, 4047.6964227683043, 4526.343680166357, 4559.316102584573, 4570.702904311209, 4574.908501829945, 4579.198640238012, 5128.846009647799, 5258.6581872178185, 5264.42091369949, 5283.471652834686, 5311.389190243094, 1329.322045756671, 1345.2668295778824, 1347.5148946379295, 1350.4260689207047, 1358.8369395672582, 871.4335681806876, 881.9426737262057, 925.6528801699362, 943.9292053096045, 945.3052006775015, 4405.955940440619, 4504.819807207675, 4525.366448697185, 4558.202314594932, 4604.171249175113, 5432.701201433959, 5447.918281225785, 5453.318335208099, 5463.672179669233, 5490.505854473036, 4393.253146964959, 4521.59305662492, 4548.340490628841, 4582.221022426195, 4584.633229341644, 2787.7315821301663, 2802.6407192511615, 2827.7596404305864, 2831.7026712195334, 2833.914982550527, 4914.410270767459, 4921.040397122527, 4980.427250866197, 4988.35151430319, 5004.649674522821, 5293.655912365761, 5379.946200538023, 5460.863478413072, 5493.066178749622, 5659.547236221092, 5183.818566350235, 5185.248139019821, 5197.142471492161, 5198.610104242121, 5208.6874787512115, 5496.5053145217125, 5499.175123731312, 5502.889942201214, 5503.532199763065, 5526.613137080527, 5243.606729495227, 5427.158790387496, 5427.511523962862, 5469.945300546943, 5489.505944465017, 5175.948240517697, 5181.404138524118, 5195.272661827272, 5199.168133098686, 5204.947950520598, 3813.8474461021246, 3830.5211848518934, 3851.614838516126, 3860.6450065459485, 3860.749051311656, 5346.476254267515, 5499.202615620793, 5515.365732940763, 5532.0, 5564.860878478071, 5293.947060529345, 5309.415964243853, 5322.403279016357, 5334.653247538898, 5340.839774806762, 5271.393789714232, 5299.629025968299, 5302.734863256899, 5319.0, 5324.47087633371, 4947.480514546065, 5208.921866171935, 5217.113090774502, 5218.947810521846, 5225.346831646044, 5041.899162016666, 5216.426193118678, 5292.761825717775, 5346.647475110939, 5353.411124776194, 5225.372955245395, 5227.3465816772905, 5246.632735708464, 5257.211418287135, 5285.762140703754], "value": 3998.9771590105984, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [716.5342527357217, 746.66400119946, 770.7764748223015, 789.2896393246078, 805.7542449552891, 11385.943070284648, 11972.700682482942, 12008.519659213633, 12065.276083435, 12095.879041209597, 11803.173777835555, 11876.465559049842, 11882.643520694393, 11896.643100706993, 11897.643070707893, 665.5806841689729, 865.6148014133713, 866.0862789756804, 876.1370050500252, 876.7282142535835, 885.5926273914007, 887.0951629338072, 887.1350433327518, 887.4675194883083, 889.1819526036062, 929.0755698080386, 932.4684929590136, 932.8787257656529, 934.9392289501161, 935.8315503209419, 922.239152699026, 922.2898368256439, 922.7739203895021, 928.7956649537091, 928.9163975242227, 675.9594424334556, 676.5805200775501, 678.0744284052282, 680.0750978669006, 680.6562685843667, 11497.0, 11523.308601483854, 11523.711907202387, 11542.538298468051, 11551.826722599168, 12889.291088990101, 13030.54393096237, 13182.60452186436, 13429.261390623511, 13550.390232439564, 10498.527566259536, 10535.789284214272, 10638.840417393745, 10710.839337409945, 10776.946115269373, 3106.0, 3109.3781243751114, 3151.43274210642, 3161.0, 3185.267388500658, 47826.52173478255, 48179.0, 48688.99999999964, 48858.0, 48888.0, 10377.9481102594, 10651.094656954245, 10657.413842238751, 10813.83779243312, 11007.119430445706, 18938.337158199396, 18985.145668444955, 19004.04979751007, 19037.524061898286, 19100.426987190407, 6694.230163531159, 6784.626845523544, 6890.8621827563165, 6913.0, 6968.0, 3609.097725568608, 3643.5263415756312, 3687.520622319081, 3701.4937247648268, 3712.870049548253, 2914.1548950804454, 2939.5737618045264, 2978.255436140965, 2979.702029797003, 3000.9496676163603, 505.07571144804916, 508.99491005090215, 512.4721536817084, 517.252570036294, 519.1408219396905, 569.732225853848, 590.4243362721312, 644.2269276867777, 651.4332530698323, 664.465105589995, 7591.696332146652, 7662.118856331594, 7732.845343093107, 7849.0, 8018.278354947966, 598.7245866901275, 623.856513002003, 629.789020678078, 630.7161777200279, 638.4923985431593, 3545.751797374159, 3860.942085868714, 3883.2427676603356, 3961.960380396159, 3996.5803590623145, 43061.0, 43885.341719874225, 44859.77570112129, 49902.0, 49981.0, 45691.0, 46260.7686961563, 47034.529654703016, 47480.52519474761, 48008.27987580189, 42617.78691106525, 43072.78463607662, 43333.349999750026, 43340.0, 43875.341869871976, 7684.884726728992, 7746.218369774871, 7786.844263114593, 8027.478213916077, 8046.597670116588, 29243.85378073096, 29361.11916642504, 29594.0, 29792.10623681293, 29858.992290118716, 35713.821430892676, 37210.06974825651, 38294.61705383022, 38485.07574621202, 38528.42207366948, 10856.0, 10918.672439826818, 10951.397673128055, 10958.28771129874, 10996.28524145928, 11734.70663233426, 11928.4035798208, 12695.42870570808, 12700.0, 12748.171368860994, 10929.289596176222, 11242.718932026764, 11383.317000979967, 11454.94272528632, 11494.94252528732, 10745.785084298113, 10865.18511111654, 11022.559097636326, 11113.388763617755, 11128.499217535069, 10700.946495267473, 10910.23628346008, 10956.28784129029, 11066.889331106586, 11535.76928461443, 9279.164875161268, 9460.262601946977, 9562.856557151508, 9616.807663846825, 9729.756756081155, 9392.389494682824, 9428.905710942803, 9551.761205969906, 9674.177694896012, 9850.408975461496], "value": 6058.42356174942, "unit": "score"}], "name": "dromaeo_css", "value": 6360.369178022521, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 118.0, 108.0, 115.0, 114.0, 117.0, 108.0, 115.0, 120.0, 117.0], "value": 114.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 132.0, 167.0, 215.0, 132.0, 158.0, 174.0, 132.0, 195.0, 131.0], "value": 159.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 166.0, 180.0, 163.0, 164.0, 163.0, 163.0, 164.0, 165.0, 163.0], "value": 165.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 77.0, 169.0, 76.0, 77.0, 77.0, 76.0, 154.0, 78.0], "value": 93.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 172.0, 94.0, 94.0, 93.0, 145.0, 93.0, 93.0, 146.0], "value": 111.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 120.0, 118.0, 118.0, 118.0, 118.0, 119.0, 119.0, 118.0, 118.0], "value": 118.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 147.0, 147.0, 148.0, 147.0, 147.0, 146.0, 147.0, 148.0], "value": 147.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 96.0, 94.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 67.0, 67.0, 65.0, 66.0, 66.0, 66.0, 66.0, 65.0, 66.0], "value": 65.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 65.0, 64.0, 64.0, 65.0, 65.0, 65.0, 66.0], "value": 64.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 82.0, 82.0, 84.0, 87.0, 83.0, 83.0, 151.0, 87.0], "value": 90.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 141.0, 141.0, 128.0, 130.0, 132.0, 132.0, 137.0, 164.0, 136.0], "value": 138.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 179.0, 179.0, 175.0, 175.0, 177.0, 172.0, 174.0, 172.0, 173.0], "value": 175.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 69.0, 71.0, 69.0, 69.0, 67.0, 70.0, 69.0, 68.0], "value": 68.8, "unit": "score"}], "name": "kraken", "value": 1609.2000000000003, "alertThreshold": 2.0}]} 13:11:16 INFO - Return code: 0 13:11:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 13:11:16 ERROR - # TBPL SUCCESS # 13:11:16 INFO - Running post-action listener: _resource_record_post_action 13:11:16 INFO - ##### 13:11:16 INFO - ##### Finished run-tests step (success) 13:11:16 INFO - ##### 13:11:16 INFO - Running post-run listener: _resource_record_post_run 13:11:17 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 0; Write bytes: 531021824; Read time: 0; Write time: 416144 13:11:17 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 234958848; Read time: 0; Write time: 242768 13:11:17 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 0; Write bytes: 296062976; Read time: 0; Write time: 173376 13:11:17 INFO - Running post-run listener: _upload_blobber_files 13:11:17 INFO - Blob upload gear active. 13:11:17 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:11:17 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 13:11:17 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'] 13:11:17 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 13:11:18 INFO - (blobuploader) - INFO - Open directory for files ... 13:11:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:11:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:11:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:11:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:11:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:11:18 INFO - (blobuploader) - INFO - Done attempting. 13:11:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:11:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:11:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:11:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:11:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:11:19 INFO - (blobuploader) - INFO - Done attempting. 13:11:19 INFO - (blobuploader) - INFO - Iteration through files over. 13:11:19 INFO - Return code: 0 13:11:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:11:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:11:19 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7ee2cd75e59e08313b7debab58835c8c65a3215db8a1ca4bd75bd9d1ac9a7a6a4489685725d5b66b90d05aa619632fb9ebf422da91e6221c994e64cf3f55cf26", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/93cb195a1067b35654a310b77963de757b39fb574acec6777423a910086d335958fe63d9323f888f068b0a3254f1466b32e6b22e0165144a633c2e8c3ef67f8a"} 13:11:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:11:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:11:19 INFO - Contents: 13:11:19 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7ee2cd75e59e08313b7debab58835c8c65a3215db8a1ca4bd75bd9d1ac9a7a6a4489685725d5b66b90d05aa619632fb9ebf422da91e6221c994e64cf3f55cf26", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/93cb195a1067b35654a310b77963de757b39fb574acec6777423a910086d335958fe63d9323f888f068b0a3254f1466b32e6b22e0165144a633c2e8c3ef67f8a"} 13:11:19 INFO - Running post-run listener: copy_logs_to_upload_dir 13:11:19 INFO - Copying logs to upload dir... 13:11:19 INFO - mkdir: /builds/slave/test/build/upload/logs 13:11:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.887644 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-05-09 13:11:19.635478) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-09 13:11:19.638832) ========= 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=00204705a9daa57ed339a427000001b9-1462823336.495322-2045218319 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/7ee2cd75e59e08313b7debab58835c8c65a3215db8a1ca4bd75bd9d1ac9a7a6a4489685725d5b66b90d05aa619632fb9ebf422da91e6221c994e64cf3f55cf26", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/93cb195a1067b35654a310b77963de757b39fb574acec6777423a910086d335958fe63d9323f888f068b0a3254f1466b32e6b22e0165144a633c2e8c3ef67f8a"} build_url:https://queue.taskcluster.net/v1/task/efMoi9YaTICmX3WldmYg7Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011292 build_url: 'https://queue.taskcluster.net/v1/task/efMoi9YaTICmX3WldmYg7Q/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/7ee2cd75e59e08313b7debab58835c8c65a3215db8a1ca4bd75bd9d1ac9a7a6a4489685725d5b66b90d05aa619632fb9ebf422da91e6221c994e64cf3f55cf26", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/93cb195a1067b35654a310b77963de757b39fb574acec6777423a910086d335958fe63d9323f888f068b0a3254f1466b32e6b22e0165144a633c2e8c3ef67f8a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-09 13:11:19.663086) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 13:11:19.663386) ========= 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=00204705a9daa57ed339a427000001b9-1462823336.495322-2045218319 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004475 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 13:11:19.747526) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-09 13:11:19.747844) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-09 13:11:19.748128) ========= ========= Total master_lag: 0.19 =========