builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-025 starttime: 1463001510.74 results: success (0) buildid: 20160511113038 builduid: 2fdd31845b8c47a4b3ce4fe60afdb39d revision: 45daaf6edeae80ec8c67da50fa1d31f4a1b1a454 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-11 14:18:30.735469) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-11 14:18:30.735915) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-11 14:18:30.736216) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-11 14:18:30.744772) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 14:18:30.745035) ========= 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=232498196343f89f466a4a9a000001c8-1463001510.561049-609160901 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-11 14:18:31-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 429M=0s 2016-05-11 14:18:31 (429 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.070804 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 14:18:30.823589) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 14:18:30.823897) ========= 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=232498196343f89f466a4a9a000001c8-1463001510.561049-609160901 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.009524 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 14:18:30.869932) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 14:18:30.870258) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 45daaf6edeae80ec8c67da50fa1d31f4a1b1a454 --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 45daaf6edeae80ec8c67da50fa1d31f4a1b1a454 --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=232498196343f89f466a4a9a000001c8-1463001510.561049-609160901 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-11 14:18:31,297 truncating revision to first 12 chars 2016-05-11 14:18:31,297 Setting DEBUG logging. 2016-05-11 14:18:31,297 attempt 1/10 2016-05-11 14:18:31,297 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/45daaf6edeae?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-11 14:18:31,558 unpacking tar archive at: fx-team-45daaf6edeae/testing/mozharness/ program finished with exit code 0 elapsedTime=0.514440 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 14:18:31.392608) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-11 14:18:31.392935) ========= script_repo_revision: 45daaf6edeae80ec8c67da50fa1d31f4a1b1a454 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-11 14:18:31.393321) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-11 14:18:31.393622) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-11 14:18:31.399345) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 26 secs) (at 2016-05-11 14:18:31.399632) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=232498196343f89f466a4a9a000001c8-1463001510.561049-609160901 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:18:31 INFO - MultiFileLogger online at 20160511 14:18:31 in /builds/slave/test 14:18:31 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 14:18:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:18:31 INFO - {'append_to_log': False, 14:18:31 INFO - 'base_work_dir': '/builds/slave/test', 14:18:31 INFO - 'blob_upload_branch': 'Fx-Team', 14:18:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:18:31 INFO - 'branch': 'Fx-Team', 14:18:31 INFO - 'buildbot_json_path': 'buildprops.json', 14:18:31 INFO - 'config_files': ('talos/linux_config.py',), 14:18:31 INFO - 'default_actions': ('clobber', 14:18:31 INFO - 'read-buildbot-config', 14:18:31 INFO - 'download-and-extract', 14:18:31 INFO - 'populate-webroot', 14:18:31 INFO - 'create-virtualenv', 14:18:31 INFO - 'install', 14:18:31 INFO - 'run-tests'), 14:18:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:18:31 INFO - 'download_minidump_stackwalk': True, 14:18:31 INFO - 'download_symbols': 'ondemand', 14:18:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:18:31 INFO - 'tooltool.py': '/tools/tooltool.py', 14:18:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:18:31 INFO - '/tools/misc-python/virtualenv.py')}, 14:18:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:18:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:18:31 INFO - 'installer_path': 'installer.exe', 14:18:31 INFO - 'log_level': 'info', 14:18:31 INFO - 'log_name': 'talos', 14:18:31 INFO - 'log_to_console': True, 14:18:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:18:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:18:31 INFO - 'opt_config_files': (), 14:18:31 INFO - 'pip_index': False, 14:18:31 INFO - 'sps_profile': False, 14:18:31 INFO - 'sps_profile_interval': 0, 14:18:31 INFO - 'suite': 'dromaeojs', 14:18:31 INFO - 'system_bits': '32', 14:18:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:18:31 INFO - 'title': 'talos-linux64-ix-025', 14:18:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:18:31 INFO - 'use_talos_json': True, 14:18:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:18:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:18:31 INFO - 'work_dir': 'build'} 14:18:31 INFO - ##### 14:18:31 INFO - ##### Running clobber step. 14:18:31 INFO - ##### 14:18:31 INFO - Running pre-action listener: _resource_record_pre_action 14:18:31 INFO - Running main action method: clobber 14:18:31 INFO - rmtree: /builds/slave/test/build 14:18:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:18:32 INFO - Running post-action listener: _resource_record_post_action 14:18:32 INFO - ##### 14:18:32 INFO - ##### Finished clobber step (success) 14:18:32 INFO - ##### 14:18:32 INFO - ##### 14:18:32 INFO - ##### Running read-buildbot-config step. 14:18:32 INFO - ##### 14:18:32 INFO - Running pre-action listener: _resource_record_pre_action 14:18:32 INFO - Running main action method: read_buildbot_config 14:18:32 INFO - Using buildbot properties: 14:18:32 INFO - { 14:18:32 INFO - "project": "", 14:18:32 INFO - "product": "firefox", 14:18:32 INFO - "script_repo_revision": "production", 14:18:32 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 14:18:32 INFO - "repository": "", 14:18:32 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 14:18:32 INFO - "buildid": "20160511113038", 14:18:32 INFO - "pgo_build": "True", 14:18:32 INFO - "basedir": "/builds/slave/test", 14:18:32 INFO - "buildnumber": 78, 14:18:32 INFO - "slavename": "talos-linux64-ix-025", 14:18:32 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 14:18:32 INFO - "platform": "ubuntu64_hw", 14:18:32 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 14:18:32 INFO - "branch": "fx-team", 14:18:32 INFO - "repo_path": "integration/fx-team", 14:18:32 INFO - "revision": "45daaf6edeae80ec8c67da50fa1d31f4a1b1a454", 14:18:32 INFO - "stage_platform": "linux64-pgo", 14:18:32 INFO - "builduid": "2fdd31845b8c47a4b3ce4fe60afdb39d", 14:18:32 INFO - "slavebuilddir": "test" 14:18:32 INFO - } 14:18:32 INFO - Found installer url https://queue.taskcluster.net/v1/task/NZG4cLBdT5Sfc2N9UbPUOA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 14:18:32 INFO - Running post-action listener: _resource_record_post_action 14:18:32 INFO - ##### 14:18:32 INFO - ##### Finished read-buildbot-config step (success) 14:18:32 INFO - ##### 14:18:32 INFO - ##### 14:18:32 INFO - ##### Running download-and-extract step. 14:18:32 INFO - ##### 14:18:32 INFO - Running pre-action listener: _resource_record_pre_action 14:18:32 INFO - Running main action method: download_and_extract 14:18:32 INFO - mkdir: /builds/slave/test/build/tests 14:18:32 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')]} 14:18:32 INFO - https://queue.taskcluster.net/v1/task/NZG4cLBdT5Sfc2N9UbPUOA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 14:18:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NZG4cLBdT5Sfc2N9UbPUOA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 14:18:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NZG4cLBdT5Sfc2N9UbPUOA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 14:18:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NZG4cLBdT5Sfc2N9UbPUOA/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 14:18:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NZG4cLBdT5Sfc2N9UbPUOA/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 14:18:33 INFO - Downloaded 1361 bytes. 14:18:33 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 14:18:33 INFO - Using the following test package requirements: 14:18:33 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 14:18:33 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:18:33 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:18:33 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:18:33 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:18:33 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:18:33 INFO - u'jsshell-linux-x86_64.zip'], 14:18:33 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:18:33 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:18:33 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 14:18:33 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:18:33 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:18:33 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:18:33 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:18:33 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:18:33 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:18:33 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:18:33 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:18:33 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:18:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:18:33 INFO - https://queue.taskcluster.net/v1/task/NZG4cLBdT5Sfc2N9UbPUOA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:18:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NZG4cLBdT5Sfc2N9UbPUOA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:18:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NZG4cLBdT5Sfc2N9UbPUOA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:18:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NZG4cLBdT5Sfc2N9UbPUOA/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 14:18:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NZG4cLBdT5Sfc2N9UbPUOA/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 14:18:34 INFO - Downloaded 23902892 bytes. 14:18:34 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'] 14:18:34 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 14:18:36 INFO - Return code: 0 14:18:36 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 14:18:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:18:36 INFO - https://queue.taskcluster.net/v1/task/NZG4cLBdT5Sfc2N9UbPUOA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:18:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NZG4cLBdT5Sfc2N9UbPUOA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:18:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NZG4cLBdT5Sfc2N9UbPUOA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:18:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NZG4cLBdT5Sfc2N9UbPUOA/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 14:18:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NZG4cLBdT5Sfc2N9UbPUOA/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 14:18:37 INFO - Downloaded 23902892 bytes. 14:18:37 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'] 14:18:37 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 14:18:38 INFO - Return code: 0 14:18:38 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')]} 14:18:38 INFO - https://queue.taskcluster.net/v1/task/NZG4cLBdT5Sfc2N9UbPUOA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:18:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NZG4cLBdT5Sfc2N9UbPUOA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 14:18:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NZG4cLBdT5Sfc2N9UbPUOA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 14:18:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NZG4cLBdT5Sfc2N9UbPUOA/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 14:18:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NZG4cLBdT5Sfc2N9UbPUOA/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 14:18:39 INFO - Downloaded 10840152 bytes. 14:18:39 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'] 14:18:39 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 14:18:39 INFO - Return code: 0 14:18:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:18:39 INFO - https://queue.taskcluster.net/v1/task/NZG4cLBdT5Sfc2N9UbPUOA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:18:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NZG4cLBdT5Sfc2N9UbPUOA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:18:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NZG4cLBdT5Sfc2N9UbPUOA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:18:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NZG4cLBdT5Sfc2N9UbPUOA/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 14:18:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NZG4cLBdT5Sfc2N9UbPUOA/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 14:18:41 INFO - Downloaded 58340981 bytes. 14:18:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NZG4cLBdT5Sfc2N9UbPUOA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:18:41 INFO - mkdir: /builds/slave/test/properties 14:18:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:18:41 INFO - Writing to file /builds/slave/test/properties/build_url 14:18:41 INFO - Contents: 14:18:41 INFO - build_url:https://queue.taskcluster.net/v1/task/NZG4cLBdT5Sfc2N9UbPUOA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:18:41 INFO - Running post-action listener: _resource_record_post_action 14:18:41 INFO - Running post-action listener: set_extra_try_arguments 14:18:41 INFO - ##### 14:18:41 INFO - ##### Finished download-and-extract step (success) 14:18:41 INFO - ##### 14:18:41 INFO - ##### 14:18:41 INFO - ##### Running populate-webroot step. 14:18:41 INFO - ##### 14:18:41 INFO - Running pre-action listener: _resource_record_pre_action 14:18:41 INFO - Running main action method: populate_webroot 14:18:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:18:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:18:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:18:41 INFO - '--tppagecycles', 14:18:41 INFO - '7'], 14:18:41 INFO - 'tests': ['tsvgm']}}, 14:18:41 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:18:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:18:41 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:18:41 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:18:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:18:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:18:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:18:41 INFO - 'talos_options': ['--disable-e10s'], 14:18:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:18:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:18:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:18:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:18:41 INFO - 'talos_options': ['--disable-e10s'], 14:18:41 INFO - 'tests': ['damp', 'tps']}, 14:18:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:18:41 INFO - 'tests': ['damp', 'tps']}, 14:18:41 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:18:41 INFO - 'tests': ['dromaeo_dom']}, 14:18:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:18:41 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:18:41 INFO - 'tests': ['a11yr', 14:18:41 INFO - 'ts_paint', 14:18:41 INFO - 'tpaint', 14:18:41 INFO - 'sessionrestore', 14:18:41 INFO - 'sessionrestore_no_auto_restore', 14:18:41 INFO - 'tabpaint']}, 14:18:41 INFO - 'other-e10s': {'tests': ['a11yr', 14:18:41 INFO - 'ts_paint', 14:18:41 INFO - 'tpaint', 14:18:41 INFO - 'sessionrestore', 14:18:41 INFO - 'sessionrestore_no_auto_restore', 14:18:41 INFO - 'tabpaint']}, 14:18:41 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:18:41 INFO - 'ts_paint', 14:18:41 INFO - 'tpaint', 14:18:41 INFO - 'sessionrestore', 14:18:41 INFO - 'sessionrestore_no_auto_restore', 14:18:41 INFO - 'tabpaint']}, 14:18:41 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:18:41 INFO - 'ts_paint', 14:18:41 INFO - 'tpaint', 14:18:41 INFO - 'sessionrestore', 14:18:41 INFO - 'sessionrestore_no_auto_restore', 14:18:41 INFO - 'tabpaint']}, 14:18:41 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:18:41 INFO - 'tests': ['a11yr', 14:18:41 INFO - 'ts_paint', 14:18:41 INFO - 'tpaint', 14:18:41 INFO - 'sessionrestore', 14:18:41 INFO - 'sessionrestore_no_auto_restore', 14:18:41 INFO - 'tabpaint']}, 14:18:41 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:18:41 INFO - 'tests': ['a11yr', 14:18:41 INFO - 'ts_paint', 14:18:41 INFO - 'tpaint', 14:18:41 INFO - 'sessionrestore', 14:18:41 INFO - 'sessionrestore_no_auto_restore', 14:18:41 INFO - 'tabpaint']}, 14:18:41 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:18:41 INFO - 'tests': ['tsvgx', 14:18:41 INFO - 'tsvgr_opacity', 14:18:41 INFO - 'tart', 14:18:41 INFO - 'tscrollx', 14:18:41 INFO - 'cart']}, 14:18:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:18:41 INFO - 'tsvgr_opacity', 14:18:41 INFO - 'tart', 14:18:41 INFO - 'tscrollx', 14:18:41 INFO - 'cart']}, 14:18:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:18:41 INFO - 'talos_options': ['--disable-e10s'], 14:18:41 INFO - 'tests': ['tp5o']}, 14:18:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:18:41 INFO - 'tests': ['tp5o']}, 14:18:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:18:41 INFO - 'talos_options': ['--disable-e10s', 14:18:41 INFO - '--xperf_path', 14:18:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:18:41 INFO - 'tests': ['tp5n']}, 14:18:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:18:41 INFO - 'talos_options': ['--xperf_path', 14:18:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:18:41 INFO - 'tests': ['tp5n']}}, 14:18:41 INFO - 'talos.zip': {'path': '', 14:18:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:18:41 INFO - Running post-action listener: _resource_record_post_action 14:18:41 INFO - ##### 14:18:41 INFO - ##### Finished populate-webroot step (success) 14:18:41 INFO - ##### 14:18:41 INFO - ##### 14:18:41 INFO - ##### Running create-virtualenv step. 14:18:41 INFO - ##### 14:18:41 INFO - Running pre-action listener: _resource_record_pre_action 14:18:41 INFO - Running main action method: create_virtualenv 14:18:41 INFO - Creating virtualenv /builds/slave/test/build/venv 14:18:41 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 14:18:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:18:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:18:41 INFO - Using real prefix '/usr' 14:18:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:18:42 INFO - Installing distribute.............................................................................................................................................................................................done. 14:18:44 INFO - Installing pip.................done. 14:18:44 INFO - Return code: 0 14:18:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:18:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:18:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:18:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:18:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:18:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd41e2a6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c4a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd99c0>, '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 0x1cda8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cdad50>, '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': '232498196343f89f466a4a9a000001c8-1463001510.561049-609160901', '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 14:18:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:18:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:18:44 INFO - Using env: {'DISPLAY': ':0', 14:18:44 INFO - 'HOME': '/home/cltbld', 14:18:44 INFO - 'LANG': 'en_US.UTF-8', 14:18:44 INFO - 'LANGUAGE': 'en_US:en', 14:18:44 INFO - 'LOGNAME': 'cltbld', 14:18:44 INFO - 'MAIL': '/var/mail/cltbld', 14:18:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:44 INFO - 'MOZ_NO_REMOTE': '1', 14:18:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:18:44 INFO - 'NO_EM_RESTART': '1', 14:18:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:18:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:18:44 INFO - 'PWD': '/builds/slave/test', 14:18:44 INFO - 'SHELL': '/bin/bash', 14:18:44 INFO - 'SHLVL': '1', 14:18:44 INFO - 'TERM': 'linux', 14:18:44 INFO - 'TMOUT': '86400', 14:18:44 INFO - 'USER': 'cltbld', 14:18:44 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1463001510.561049-609160901', 14:18:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:44 INFO - '_': '/tools/buildbot/bin/python'} 14:18:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:18:44 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 14:18:44 INFO - Cleaning up... 14:18:44 INFO - Return code: 0 14:18:44 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 14:18:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:18:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:18:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:18:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:18:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd41e2a6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c4a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd99c0>, '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 0x1cda8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cdad50>, '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': '232498196343f89f466a4a9a000001c8-1463001510.561049-609160901', '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 14:18:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 14:18:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 14:18:44 INFO - Using env: {'DISPLAY': ':0', 14:18:44 INFO - 'HOME': '/home/cltbld', 14:18:44 INFO - 'LANG': 'en_US.UTF-8', 14:18:44 INFO - 'LANGUAGE': 'en_US:en', 14:18:44 INFO - 'LOGNAME': 'cltbld', 14:18:44 INFO - 'MAIL': '/var/mail/cltbld', 14:18:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:44 INFO - 'MOZ_NO_REMOTE': '1', 14:18:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:18:44 INFO - 'NO_EM_RESTART': '1', 14:18:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:18:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:18:44 INFO - 'PWD': '/builds/slave/test', 14:18:44 INFO - 'SHELL': '/bin/bash', 14:18:44 INFO - 'SHLVL': '1', 14:18:44 INFO - 'TERM': 'linux', 14:18:44 INFO - 'TMOUT': '86400', 14:18:44 INFO - 'USER': 'cltbld', 14:18:44 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1463001510.561049-609160901', 14:18:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:44 INFO - '_': '/tools/buildbot/bin/python'} 14:18:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:18:44 INFO - Downloading/unpacking psutil>=0.7.1 14:18:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:18:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:18:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:18:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:18:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:18:46 INFO - Installing collected packages: psutil 14:18:46 INFO - Running setup.py install for psutil 14:18:46 INFO - building 'psutil._psutil_linux' extension 14:18:46 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 14:18:46 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 14:18:46 INFO - building 'psutil._psutil_posix' extension 14:18:46 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 14:18:47 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 14:18:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:18:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:18:47 INFO - Successfully installed psutil 14:18:47 INFO - Cleaning up... 14:18:47 INFO - Return code: 0 14:18:47 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 14:18: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')]} 14:18:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:18:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18: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')]} 14:18:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:18:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd41e2a6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c4a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd99c0>, '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 0x1cda8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cdad50>, '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': '232498196343f89f466a4a9a000001c8-1463001510.561049-609160901', '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 14:18:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 14:18:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 14:18:47 INFO - Using env: {'DISPLAY': ':0', 14:18:47 INFO - 'HOME': '/home/cltbld', 14:18:47 INFO - 'LANG': 'en_US.UTF-8', 14:18:47 INFO - 'LANGUAGE': 'en_US:en', 14:18:47 INFO - 'LOGNAME': 'cltbld', 14:18:47 INFO - 'MAIL': '/var/mail/cltbld', 14:18:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:47 INFO - 'MOZ_NO_REMOTE': '1', 14:18:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:18:47 INFO - 'NO_EM_RESTART': '1', 14:18:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:18:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:18:47 INFO - 'PWD': '/builds/slave/test', 14:18:47 INFO - 'SHELL': '/bin/bash', 14:18:47 INFO - 'SHLVL': '1', 14:18:47 INFO - 'TERM': 'linux', 14:18:47 INFO - 'TMOUT': '86400', 14:18:47 INFO - 'USER': 'cltbld', 14:18:47 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1463001510.561049-609160901', 14:18:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:47 INFO - '_': '/tools/buildbot/bin/python'} 14:18:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:18:47 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:18:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:18:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:18:49 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:18:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:18:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:18:49 INFO - Installing collected packages: mozsystemmonitor 14:18:49 INFO - Running setup.py install for mozsystemmonitor 14:18:49 INFO - Successfully installed mozsystemmonitor 14:18:49 INFO - Cleaning up... 14:18:49 INFO - Return code: 0 14:18:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:18:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:18:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:18:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:18:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:18:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd41e2a6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c4a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd99c0>, '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 0x1cda8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cdad50>, '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': '232498196343f89f466a4a9a000001c8-1463001510.561049-609160901', '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 14:18:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:18:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:18:49 INFO - Using env: {'DISPLAY': ':0', 14:18:49 INFO - 'HOME': '/home/cltbld', 14:18:49 INFO - 'LANG': 'en_US.UTF-8', 14:18:49 INFO - 'LANGUAGE': 'en_US:en', 14:18:49 INFO - 'LOGNAME': 'cltbld', 14:18:49 INFO - 'MAIL': '/var/mail/cltbld', 14:18:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:49 INFO - 'MOZ_NO_REMOTE': '1', 14:18:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:18:49 INFO - 'NO_EM_RESTART': '1', 14:18:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:18:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:18:49 INFO - 'PWD': '/builds/slave/test', 14:18:49 INFO - 'SHELL': '/bin/bash', 14:18:49 INFO - 'SHLVL': '1', 14:18:49 INFO - 'TERM': 'linux', 14:18:49 INFO - 'TMOUT': '86400', 14:18:49 INFO - 'USER': 'cltbld', 14:18:49 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1463001510.561049-609160901', 14:18:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:49 INFO - '_': '/tools/buildbot/bin/python'} 14:18:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:18:49 INFO - Downloading/unpacking blobuploader==1.2.4 14:18:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:18:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:18:51 INFO - Downloading blobuploader-1.2.4.tar.gz 14:18:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:18:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:18:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:18:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:18:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:18:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:18:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:18:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:18:52 INFO - Downloading docopt-0.6.1.tar.gz 14:18:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:18:52 INFO - Installing collected packages: blobuploader, requests, docopt 14:18:52 INFO - Running setup.py install for blobuploader 14:18:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:18:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:18:52 INFO - Running setup.py install for requests 14:18:52 INFO - Running setup.py install for docopt 14:18:52 INFO - Successfully installed blobuploader requests docopt 14:18:52 INFO - Cleaning up... 14:18:52 INFO - Return code: 0 14:18:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:18:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:18:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:18:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:18:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:18:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:52 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 0x7fd41e2a6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c4a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd99c0>, '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 0x1cda8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cdad50>, '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': '232498196343f89f466a4a9a000001c8-1463001510.561049-609160901', '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 14:18:52 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 14:18:52 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 14:18:52 INFO - Using env: {'DISPLAY': ':0', 14:18:52 INFO - 'HOME': '/home/cltbld', 14:18:52 INFO - 'LANG': 'en_US.UTF-8', 14:18:52 INFO - 'LANGUAGE': 'en_US:en', 14:18:52 INFO - 'LOGNAME': 'cltbld', 14:18:52 INFO - 'MAIL': '/var/mail/cltbld', 14:18:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:52 INFO - 'MOZ_NO_REMOTE': '1', 14:18:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:18:52 INFO - 'NO_EM_RESTART': '1', 14:18:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:18:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:18:52 INFO - 'PWD': '/builds/slave/test', 14:18:52 INFO - 'SHELL': '/bin/bash', 14:18:52 INFO - 'SHLVL': '1', 14:18:52 INFO - 'TERM': 'linux', 14:18:52 INFO - 'TMOUT': '86400', 14:18:52 INFO - 'USER': 'cltbld', 14:18:52 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1463001510.561049-609160901', 14:18:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:52 INFO - '_': '/tools/buildbot/bin/python'} 14:18:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:18:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:18:53 INFO - Running setup.py (path:/tmp/pip-Yamyb8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:18:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:18:53 INFO - Running setup.py (path:/tmp/pip-jexYk2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:18:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:18:53 INFO - Running setup.py (path:/tmp/pip-EKTLxf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:18:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:18:53 INFO - Running setup.py (path:/tmp/pip-us_4JG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:18:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:18:53 INFO - Running setup.py (path:/tmp/pip-SJTKPc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:18:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:18:53 INFO - Running setup.py (path:/tmp/pip-QqcY2n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:18:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:18:53 INFO - Running setup.py (path:/tmp/pip-yPLUBN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:18:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:18:53 INFO - Running setup.py (path:/tmp/pip-C5Dowu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:18:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:18:53 INFO - Running setup.py (path:/tmp/pip-MOI4Jp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:18:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:18:53 INFO - Running setup.py (path:/tmp/pip-hcOOu9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:18:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:18:53 INFO - Running setup.py (path:/tmp/pip-rHffUm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:18:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:18:53 INFO - Running setup.py (path:/tmp/pip-eitibt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:18:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:18:53 INFO - Running setup.py (path:/tmp/pip-PaXlxs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:18:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:18:53 INFO - Running setup.py (path:/tmp/pip-qHNPN9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:18:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:18:53 INFO - Running setup.py (path:/tmp/pip-5TV_RT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:18:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:18:53 INFO - Running setup.py (path:/tmp/pip-GHmfc1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:18:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:18:53 INFO - Running setup.py (path:/tmp/pip-mLZ4X2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:18:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:18:53 INFO - Running setup.py install for manifestparser 14:18:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:18:54 INFO - Running setup.py install for mozcrash 14:18:54 INFO - Running setup.py install for mozdebug 14:18:54 INFO - Running setup.py install for mozdevice 14:18:54 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:18:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:18:54 INFO - Running setup.py install for mozfile 14:18:54 INFO - Running setup.py install for mozhttpd 14:18:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:18:54 INFO - Running setup.py install for mozinfo 14:18:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:18:54 INFO - Running setup.py install for mozInstall 14:18:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:18:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:18:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:18:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:18:54 INFO - Running setup.py install for mozleak 14:18:54 INFO - Running setup.py install for mozlog 14:18:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:18:54 INFO - Running setup.py install for moznetwork 14:18:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:18:55 INFO - Running setup.py install for mozprocess 14:18:55 INFO - Running setup.py install for mozprofile 14:18:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:18:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:18:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:18:55 INFO - Running setup.py install for mozrunner 14:18:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:18:55 INFO - Running setup.py install for mozscreenshot 14:18:55 INFO - Running setup.py install for moztest 14:18:55 INFO - Running setup.py install for mozversion 14:18:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:18:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:18:55 INFO - Cleaning up... 14:18:55 INFO - Return code: 0 14:18:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:18:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:18:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:18:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:18:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:18:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:55 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 0x7fd41e2a6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c4a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd99c0>, '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 0x1cda8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cdad50>, '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': '232498196343f89f466a4a9a000001c8-1463001510.561049-609160901', '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 14:18:55 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 14:18:55 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 14:18:55 INFO - Using env: {'DISPLAY': ':0', 14:18:55 INFO - 'HOME': '/home/cltbld', 14:18:55 INFO - 'LANG': 'en_US.UTF-8', 14:18:55 INFO - 'LANGUAGE': 'en_US:en', 14:18:55 INFO - 'LOGNAME': 'cltbld', 14:18:55 INFO - 'MAIL': '/var/mail/cltbld', 14:18:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:55 INFO - 'MOZ_NO_REMOTE': '1', 14:18:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:18:55 INFO - 'NO_EM_RESTART': '1', 14:18:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:18:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:18:55 INFO - 'PWD': '/builds/slave/test', 14:18:55 INFO - 'SHELL': '/bin/bash', 14:18:55 INFO - 'SHLVL': '1', 14:18:55 INFO - 'TERM': 'linux', 14:18:55 INFO - 'TMOUT': '86400', 14:18:55 INFO - 'USER': 'cltbld', 14:18:55 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1463001510.561049-609160901', 14:18:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:55 INFO - '_': '/tools/buildbot/bin/python'} 14:18:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:18:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:18:55 INFO - Running setup.py (path:/tmp/pip-6jAOs3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:18:55 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)) 14:18:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:18:55 INFO - Running setup.py (path:/tmp/pip-0WZoEq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:18:55 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)) 14:18:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:18:55 INFO - Running setup.py (path:/tmp/pip-NkUov0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:18:55 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)) 14:18:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:18:55 INFO - Running setup.py (path:/tmp/pip-d9tbJP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:18:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:18:56 INFO - Running setup.py (path:/tmp/pip-SgstuK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:18:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 14:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:18:56 INFO - Running setup.py (path:/tmp/pip-K1AMwt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:18:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 14:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:18:56 INFO - Running setup.py (path:/tmp/pip-m13KyU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:18:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 14:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:18:56 INFO - Running setup.py (path:/tmp/pip-_pJ3MA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:18:56 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)) 14:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:18:56 INFO - Running setup.py (path:/tmp/pip-sVXjUJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:18:56 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)) 14:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:18:56 INFO - Running setup.py (path:/tmp/pip-qOGu0p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:18:56 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)) 14:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:18:56 INFO - Running setup.py (path:/tmp/pip-UGySKf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:18:56 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)) 14:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:18:56 INFO - Running setup.py (path:/tmp/pip-Q_YrrE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:18:56 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)) 14:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:18:56 INFO - Running setup.py (path:/tmp/pip-huvRK7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:18:56 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)) 14:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:18:56 INFO - Running setup.py (path:/tmp/pip-xvb6Yq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:18:56 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)) 14:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:18:56 INFO - Running setup.py (path:/tmp/pip-cUpFgl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:18:56 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)) 14:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:18:56 INFO - Running setup.py (path:/tmp/pip-jFnnVg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:18:56 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)) 14:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:18:56 INFO - Running setup.py (path:/tmp/pip-ohZi33-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:18:56 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)) 14:18:56 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)) 14:18:56 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)) 14:18:56 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)) 14:18:56 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)) 14:18:56 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)) 14:18:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:18:56 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 14:18:56 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 14:18:56 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 14:18:56 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 14:18:56 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 14:18:56 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 14:18:58 INFO - Downloading blessings-1.6.tar.gz 14:18:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:18:58 INFO - Installing collected packages: blessings 14:18:58 INFO - Running setup.py install for blessings 14:18:58 INFO - Successfully installed blessings 14:18:58 INFO - Cleaning up... 14:18:58 INFO - Return code: 0 14:18:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:18:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:18:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:18:59 INFO - Reading from file tmpfile_stdout 14:18:59 INFO - Current package versions: 14:18:59 INFO - argparse == 1.2.1 14:18:59 INFO - blessings == 1.6 14:18:59 INFO - blobuploader == 1.2.4 14:18:59 INFO - docopt == 0.6.1 14:18:59 INFO - manifestparser == 1.1 14:18:59 INFO - mozInstall == 1.12 14:18:59 INFO - mozcrash == 0.17 14:18:59 INFO - mozdebug == 0.1 14:18:59 INFO - mozdevice == 0.48 14:18:59 INFO - mozfile == 1.2 14:18:59 INFO - mozhttpd == 0.7 14:18:59 INFO - mozinfo == 0.9 14:18:59 INFO - mozleak == 0.1 14:18:59 INFO - mozlog == 3.1 14:18:59 INFO - moznetwork == 0.27 14:18:59 INFO - mozprocess == 0.22 14:18:59 INFO - mozprofile == 0.28 14:18:59 INFO - mozrunner == 6.11 14:18:59 INFO - mozscreenshot == 0.1 14:18:59 INFO - mozsystemmonitor == 0.0 14:18:59 INFO - moztest == 0.7 14:18:59 INFO - mozversion == 1.4 14:18:59 INFO - psutil == 3.1.1 14:18:59 INFO - requests == 1.2.3 14:18:59 INFO - wsgiref == 0.1.2 14:18:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:18: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')]} 14:18:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:18:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18: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')]} 14:18:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:18:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:59 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 0x7fd41e2a6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c4a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd99c0>, '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 0x1cda8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cdad50>, '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': '232498196343f89f466a4a9a000001c8-1463001510.561049-609160901', '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 14:18:59 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 14:18:59 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 14:18:59 INFO - Using env: {'DISPLAY': ':0', 14:18:59 INFO - 'HOME': '/home/cltbld', 14:18:59 INFO - 'LANG': 'en_US.UTF-8', 14:18:59 INFO - 'LANGUAGE': 'en_US:en', 14:18:59 INFO - 'LOGNAME': 'cltbld', 14:18:59 INFO - 'MAIL': '/var/mail/cltbld', 14:18:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:59 INFO - 'MOZ_NO_REMOTE': '1', 14:18:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:18:59 INFO - 'NO_EM_RESTART': '1', 14:18:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:18:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:18:59 INFO - 'PWD': '/builds/slave/test', 14:18:59 INFO - 'SHELL': '/bin/bash', 14:18:59 INFO - 'SHLVL': '1', 14:18:59 INFO - 'TERM': 'linux', 14:18:59 INFO - 'TMOUT': '86400', 14:18:59 INFO - 'USER': 'cltbld', 14:18:59 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1463001510.561049-609160901', 14:18:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:59 INFO - '_': '/tools/buildbot/bin/python'} 14:18:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:18:59 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)) 14:18:59 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)) 14:18:59 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)) 14:18:59 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)) 14:18:59 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)) 14:18:59 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)) 14:18:59 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)) 14:18:59 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)) 14:18:59 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)) 14:18:59 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)) 14:18:59 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)) 14:18:59 INFO - Cleaning up... 14:18:59 INFO - Return code: 0 14:18:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:18: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')]} 14:18:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:18:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18: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')]} 14:18:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:18:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd41e2a6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c4a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd99c0>, '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 0x1cda8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cdad50>, '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': '232498196343f89f466a4a9a000001c8-1463001510.561049-609160901', '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 14:18: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', 'jsonschema'] in /builds/slave/test/build 14:18: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 jsonschema 14:18:59 INFO - Using env: {'DISPLAY': ':0', 14:18:59 INFO - 'HOME': '/home/cltbld', 14:18:59 INFO - 'LANG': 'en_US.UTF-8', 14:18:59 INFO - 'LANGUAGE': 'en_US:en', 14:18:59 INFO - 'LOGNAME': 'cltbld', 14:18:59 INFO - 'MAIL': '/var/mail/cltbld', 14:18:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:59 INFO - 'MOZ_NO_REMOTE': '1', 14:18:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:18:59 INFO - 'NO_EM_RESTART': '1', 14:18:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:18:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:18:59 INFO - 'PWD': '/builds/slave/test', 14:18:59 INFO - 'SHELL': '/bin/bash', 14:18:59 INFO - 'SHLVL': '1', 14:18:59 INFO - 'TERM': 'linux', 14:18:59 INFO - 'TMOUT': '86400', 14:18:59 INFO - 'USER': 'cltbld', 14:18:59 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1463001510.561049-609160901', 14:18:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:59 INFO - '_': '/tools/buildbot/bin/python'} 14:18:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:18:59 INFO - Downloading/unpacking jsonschema 14:18:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:18:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:19:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:19:01 INFO - Downloading/unpacking functools32 (from jsonschema) 14:19:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:19:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:19:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:19:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:19:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:19:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:19:01 INFO - Downloading functools32-3.2.3-2.tar.gz 14:19:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:19:01 INFO - warning: no files found matching '*.txt' 14:19:01 INFO - no previously-included directories found matching 'build' 14:19:01 INFO - no previously-included directories found matching 'dist' 14:19:01 INFO - no previously-included directories found matching '.git*' 14:19:01 INFO - Installing collected packages: jsonschema, functools32 14:19:01 INFO - Running setup.py install for functools32 14:19:01 INFO - warning: no files found matching '*.txt' 14:19:01 INFO - no previously-included directories found matching 'build' 14:19:01 INFO - no previously-included directories found matching 'dist' 14:19:01 INFO - no previously-included directories found matching '.git*' 14:19:01 INFO - Successfully installed jsonschema functools32 14:19:01 INFO - Cleaning up... 14:19:01 INFO - Return code: 0 14:19:01 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:19:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:19:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:19:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:19:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:19:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:19:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:19:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd41e2a6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c4a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd99c0>, '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 0x1cda8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cdad50>, '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': '232498196343f89f466a4a9a000001c8-1463001510.561049-609160901', '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 14:19:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 14:19:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 14:19:01 INFO - Using env: {'DISPLAY': ':0', 14:19:01 INFO - 'HOME': '/home/cltbld', 14:19:01 INFO - 'LANG': 'en_US.UTF-8', 14:19:01 INFO - 'LANGUAGE': 'en_US:en', 14:19:01 INFO - 'LOGNAME': 'cltbld', 14:19:01 INFO - 'MAIL': '/var/mail/cltbld', 14:19:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:19:01 INFO - 'MOZ_NO_REMOTE': '1', 14:19:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:19:01 INFO - 'NO_EM_RESTART': '1', 14:19:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:19:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:19:01 INFO - 'PWD': '/builds/slave/test', 14:19:01 INFO - 'SHELL': '/bin/bash', 14:19:01 INFO - 'SHLVL': '1', 14:19:01 INFO - 'TERM': 'linux', 14:19:01 INFO - 'TMOUT': '86400', 14:19:01 INFO - 'USER': 'cltbld', 14:19:01 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1463001510.561049-609160901', 14:19:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:19:01 INFO - '_': '/tools/buildbot/bin/python'} 14:19:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:19:02 INFO - Downloading/unpacking flake8 14:19: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 14:19: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 14:19: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 14:19: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 14:19: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 14:19: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 14:19:03 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:19:03 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:19:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:19:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:19:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:19:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:19:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:19:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:19:04 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:19:04 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:19: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 14:19: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 14:19: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 14:19: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 14:19: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 14:19: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 14:19:04 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:19: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 14:19: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 14:19: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 14:19: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 14:19: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 14:19: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 14:19:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:19:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:19:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:19:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:19:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:19:04 INFO - no previously-included directories found matching 'docs/_build' 14:19:04 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:19:04 INFO - Running setup.py install for pep8 14:19:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:19:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:19:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:19:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:19:04 INFO - no previously-included directories found matching 'docs/_build' 14:19:04 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:19:04 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:19:04 INFO - Cleaning up... 14:19:04 INFO - Return code: 0 14:19:04 INFO - Running post-action listener: _resource_record_post_action 14:19:04 INFO - Running post-action listener: _start_resource_monitoring 14:19:04 INFO - Starting resource monitoring. 14:19:04 INFO - ##### 14:19:04 INFO - ##### Finished create-virtualenv step (success) 14:19:04 INFO - ##### 14:19:04 INFO - ##### 14:19:04 INFO - ##### Running install step. 14:19:04 INFO - ##### 14:19:04 INFO - Running pre-action listener: _resource_record_pre_action 14:19:04 INFO - Running main action method: install 14:19:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:19:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:19:05 INFO - Reading from file tmpfile_stdout 14:19:05 INFO - Detecting whether we're running mozinstall >=1.0... 14:19:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:19:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:19:05 INFO - Reading from file tmpfile_stdout 14:19:05 INFO - Output received: 14:19:05 INFO - Usage: mozinstall [options] installer 14:19:05 INFO - Options: 14:19:05 INFO - -h, --help show this help message and exit 14:19:05 INFO - -d DEST, --destination=DEST 14:19:05 INFO - Directory to install application into. [default: 14:19:05 INFO - "/builds/slave/test"] 14:19:05 INFO - --app=APP Application being installed. [default: firefox] 14:19:05 INFO - mkdir: /builds/slave/test/build/application 14:19:05 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'] 14:19:05 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 14:19:21 INFO - Reading from file tmpfile_stdout 14:19:21 INFO - Output received: 14:19:21 INFO - /builds/slave/test/build/application/firefox/firefox 14:19:21 INFO - Running post-action listener: _resource_record_post_action 14:19:21 INFO - ##### 14:19:21 INFO - ##### Finished install step (success) 14:19:21 INFO - ##### 14:19:21 INFO - ##### 14:19:21 INFO - ##### Running run-tests step. 14:19:21 INFO - ##### 14:19:21 INFO - Running pre-action listener: _resource_record_pre_action 14:19:21 INFO - Running main action method: run_tests 14:19:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:19:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:19:21 INFO - Python 2.7.3 14:19:21 INFO - Return code: 0 14:19:21 INFO - grabbing minidump binary from tooltool 14:19:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:19:21 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd99c0>, '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 0x1cda8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cdad50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:19:21 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 14:19:21 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 14:19:21 INFO - Calling ['/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'] with output_timeout 600 14:19:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:19:21 INFO - Return code: 0 14:19:21 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:19:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:19:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:19:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:19:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:19:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:19:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:19:22 INFO - Return code: 0 14:19:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NZG4cLBdT5Sfc2N9UbPUOA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 14:19:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NZG4cLBdT5Sfc2N9UbPUOA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-025 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 14:19:22 INFO - Using env: {'DISPLAY': ':0', 14:19:22 INFO - 'HOME': '/home/cltbld', 14:19:22 INFO - 'LANG': 'en_US.UTF-8', 14:19:22 INFO - 'LANGUAGE': 'en_US:en', 14:19:22 INFO - 'LOGNAME': 'cltbld', 14:19:22 INFO - 'MAIL': '/var/mail/cltbld', 14:19:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:19:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:19:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:19:22 INFO - 'MOZ_NO_REMOTE': '1', 14:19:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:19:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:19:22 INFO - 'NO_EM_RESTART': '1', 14:19:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:19:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:19:22 INFO - 'PWD': '/builds/slave/test', 14:19:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:19:22 INFO - 'SHELL': '/bin/bash', 14:19:22 INFO - 'SHLVL': '1', 14:19:22 INFO - 'TERM': 'linux', 14:19:22 INFO - 'TMOUT': '86400', 14:19:22 INFO - 'USER': 'cltbld', 14:19:22 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1463001510.561049-609160901', 14:19:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:19:22 INFO - '_': '/tools/buildbot/bin/python'} 14:19:22 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NZG4cLBdT5Sfc2N9UbPUOA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 14:19:22 INFO - mozversion application_buildid: 20160511113038 14:19:22 INFO - mozversion application_changeset: 45daaf6edeae80ec8c67da50fa1d31f4a1b1a454 14:19:22 INFO - mozversion application_display_name: Nightly 14:19:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:19:22 INFO - mozversion application_name: Firefox 14:19:22 INFO - mozversion application_remotingname: firefox 14:19:22 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:19:22 INFO - mozversion application_vendor: Mozilla 14:19:22 INFO - mozversion application_version: 49.0a1 14:19:22 INFO - mozversion platform_buildid: 20160511113038 14:19:22 INFO - mozversion platform_changeset: 45daaf6edeae80ec8c67da50fa1d31f4a1b1a454 14:19:22 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:19:22 INFO - mozversion platform_version: 49.0a1 14:19:22 INFO - using testdate: 1463001562 14:19:22 INFO - actual date: 1463001562 14:19:22 INFO - starting webserver on 'localhost:52218' 14:19:22 INFO - SUITE-START | Running 2 tests 14:19:22 INFO - TEST-START | dromaeo_css 14:19:22 INFO - operating with platform_type : linux_ 14:19:22 INFO - Initialising browser for dromaeo_css test... 14:19:23 INFO - TEST-INFO | started process 13215 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCwniIF/profile http://localhost:52218/getInfo.html) 14:19:26 INFO - PROCESS | 13215 | __metrics Screen width/height:1600/1200 14:19:26 INFO - PROCESS | 13215 | colorDepth:24 14:19:26 INFO - PROCESS | 13215 | Browser inner width/height: 1024/697 14:19:26 INFO - PROCESS | 13215 | __metrics 14:19:27 ERROR - PROCESS | 13215 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 14:19:28 INFO - TEST-INFO | 13215: exit 0 14:19:28 INFO - Browser initialized. 14:19:28 INFO - Running cycle 1/1 for dromaeo_css test... 14:19:28 INFO - TEST-INFO | started process 13296 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCwniIF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:19:39 INFO - PROCESS | 13296 | RSS: Main: 151056384 14:19:39 INFO - PROCESS | 13296 | 14:20:30 INFO - PROCESS | 13296 | 1463001630812 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] 14:22:38 INFO - PROCESS | 13296 | Cycle 1(1): loaded http://localhost:52218/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52218/tests/dromaeo/cssquery-ext.html) 14:22:39 INFO - PROCESS | 13296 | RSS: Main: 285069312 14:22:39 INFO - PROCESS | 13296 | 14:25:42 INFO - PROCESS | 13296 | Cycle 1(1): loaded http://localhost:52218/tests/dromaeo/cssquery-ext.html (next: http://localhost:52218/tests/dromaeo/cssquery-jquery.html) 14:25:42 INFO - PROCESS | 13296 | RSS: Main: 234536960 14:25:42 INFO - PROCESS | 13296 | 14:28:44 INFO - PROCESS | 13296 | Cycle 1(1): loaded http://localhost:52218/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52218/tests/dromaeo/cssquery-mootools.html) 14:28:45 INFO - PROCESS | 13296 | RSS: Main: 235261952 14:28:45 INFO - PROCESS | 13296 | 14:31:47 INFO - PROCESS | 13296 | Cycle 1(1): loaded http://localhost:52218/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52218/tests/dromaeo/cssquery-prototype.html) 14:31:47 INFO - PROCESS | 13296 | RSS: Main: 232280064 14:31:47 INFO - PROCESS | 13296 | 14:34:50 INFO - PROCESS | 13296 | Cycle 1(1): loaded http://localhost:52218/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52218/tests/dromaeo/cssquery-yui.html) 14:34:50 INFO - PROCESS | 13296 | RSS: Main: 217587712 14:34:50 INFO - PROCESS | 13296 | 14:37:53 INFO - PROCESS | 13296 | Cycle 1(1): loaded http://localhost:52218/tests/dromaeo/cssquery-yui.html (next: http://localhost:52218/tests/dromaeo/cssquery-dojo.html) 14:37:53 INFO - PROCESS | 13296 | RSS: Main: 261578752 14:37:53 INFO - PROCESS | 13296 | 14:37:53 INFO - PROCESS | 13296 | __start_tp_report 14:37:53 INFO - PROCESS | 13296 | _x_x_mozilla_page_load 14:37:53 INFO - PROCESS | 13296 | _x_x_mozilla_page_load_details 14:37:53 INFO - PROCESS | 13296 | |i|pagename|runs| 14:37:53 INFO - PROCESS | 13296 | |0;dojo.html;3105.6117985251844;3119.485284927987;3182.2203560127764;3191.2500562367854;3192.521121831725;5257.553107985826;5307;5315.309009828727;5392.946070539293;5420.403755586887;5305.204219367087;5327.866803329919;5329.813456529022;5353.812616558421;5381.219723140142;4770.308305295722;4778.569928706415;4995.075910956485;5040.974795126038;5086.542211200991;4966.726830024347;4966.726830024347;4985.277134815449;5022.82420115296;5038.470960549126;4799.664023518355;4824.517548245165;4851.514848515138;4889.633277504201;4910.017996400734;4761.262004389325;4799.688020278671;4819;4834.661573689843;4870;4797.8320758773625;4808.350872632185;4903.926441103386;4911.066897289504;4937.037277730844;5165.328507294028;5318.468153184689;5328.147496400557;5363;5393.2179833923865;5652.802151924704;5664.801731939404;5713;5782.248307720011;5836.533077353802;5769.884602307972;5770.7691692332255;5812.360640329561;5830.708464576796;5833.445822646841;5017.222330538772;5128.25640282157;5371.409144994048;5471.316085489314;5478.616496845222;5881.206037185011;5922.703864806743;5935.99088155006;5974.970125149346;5994.130851026577;5594.636348637326;5654.773809047674;5660.575456840754;5662.924044431545;5672.716364181857;5538.972305138448;5551.8889622207325;5630.155476678531;5735.77056917727;5812.796552120655;5691.03252447085;5696.3449203341315;5702.45826646468;5714.085746280575;5744.109663002241;5697.715114244271;5704.34400043992;5708.229389032511;5710.857228569319;5720.970225359392;4246.40550322955;4249.915001699948;4287.656987440997;4308.763018033976;4336.8517668655495;3832.1952389997855;3847.846086156578;3850.7882066486054;3888.902777430587;3899.863504777319;5346.97326513365;5365.9731701342025;5377.623566350318;5387.676739395649;5392.595555333366;5592.161175823659;5727.140928860621;5754.223179870748;5773.595848290579;5796.927568399859;5433.1850222466155;5438.401775804658;5439.184122381675;5447.4824891635235;5465.672059676433;4738;4959.479254678279;4977.377827771528;4978.925316120261;5033.421156566968;5808.6224395414165;5877.353491115974;5886.411358864079;5925.170476133431;5927;5707.514861236841;5719.256496655408;5720.685362305113;5728.828135155952;5750.942490575041;5645.774169033192;5723.141528770718;5880.382559831327;5901.675407852609;5903.173555702291;5695.259616249861;5718.914216286676;5724.284464441945;5736.024875771045;5797.333306669787;5692.686902220252;5734.082546792493;5749.626274292157;5756.481916627524;5782.537397008314;5389.487998640123;5522.475364840334;5555.055640541037;5675.858103547444;5680.091185410314;5579.023670857665;5579.386267510489;5599.0761524349655;5634.380218176079;5664.348599911063;5454.727263636882;5495.780168793203;5497.862553436196;5504.972475137759;5508.669479831223;5481.835544933659;5589.385167631639;5635.239242702182;5640.85897852557;5677.687727175045;5343.305370301836;5395.163749618815;5486.561075113901;5507.228987941611;5543.362513311021 14:37:53 INFO - PROCESS | 13296 | |1;ext.html;559.1863838115543;600.8888355654204;603.8587070436872;608.4159207161125;619.5663035874887;42724.359134613005;44421.77789111054;44540;48100.51899481004;48132.27801582979;43838.34242486365;44310.33534496977;44514;44708.55291447085;44725.77637111818;8739.388242823004;8894.332925030616;8907.955460222689;8918.152775486318;8928.107189281085;8688.782780430509;8751.212390884819;8784.560771961409;8785.121487851227;8795.824083518326;8846.336524760636;8907.153820387053;8908.73273801787;8911.598978045971;8917.464952102862;8821.470711757314;8830.072842351557;8838.911610883873;8853.247473964688;8865;8687.261582765472;8732.170443807892;8760.123987601253;8794.34042446819;8795.692150774756;36230.818845905866;36723.44914826253;36767.63232367695;36804.631953680386;36998.81500592507;2976.2378602133444;3026.561148633458;3110.0669799060192;3136.9843150784327;3316.469364901628;30733.692663073307;31242.843785780926;31413.842930785428;31617.367652647048;31959.360812783845;3955.6242156995327;3974.602539746002;4032.5967403259733;4051.1897620476025;4054.776987265699;303605;304727;305372;305441;306243;49001.754991224814;53093;53291;53648.46351536435;54422;59253.70373148193;59968;59974.70012649909;60163.699181504686;60301.69849150726;13860.514881979083;13993;13993.090449120775;14008.439662413593;14067.507637232648;10142.594296228068;11983.46074426653;12054.15620906528;12509.56216532417;12796.680082997813;16415.015099094093;16539.50381488557;16562.17189140538;16564;16633.334666613442;5992.760289588367;6096.268447786294;6133.0800379942475;6150.138980542728;6199.814005579839;964.6430820596283;1067.4022547373495;1075.9139268858473;1115.4924509348227;1161.8896204860694;31304.84347578293;31660.208494787814;31719;31881;31892.521612175835;1124.9887501124883;1148.592249751343;1159.2291126400848;1214.2350319298785;1226.1845872494691;16378.754318685229;16511.587210319838;16652.50042498727;16746.246418911178;16805.495835124966;468384;468988;474553;474847;476117;53164.73417632887;53748.19377709337;53818;54341.72829135829;54555.454445455034;1216.7566486702694;1350.2910971739718;1378.696686728918;1386.5840247925582;1419.4180386041674;31150.532742008436;31541.842290788398;32176.35647287088;32204.19489512687;32629.836850815595;47913.76043119762;48522.75738621284;48631.27053094277;48675.756621216664;48775.756121219165;340627;347316;347768;349896;350972;34037.319253614296;39178.41232381573;39762.80118599504;40562.797186015065;44085.33871991987;47049.52950470588;47160.29259561041;47371.05257894892;47659.52340476551;47920.520794791606;38507.47604532816;38691.41962870503;39016.6098339013;39576.60423395729;39871.80064099661;38880.61119388883;39480;39642.80178599089;40077;40214.1957160861;39228;39702;39889.20221595494;40465.59534404736;40634.59365406308;33636.327273453906;34688.41187992089;35165.296694066485;35456;35535.822320888234;26487.205383838515;27371.726282737713;27482.862585687744;27551.173464796088;27674.723252767213 14:37:53 INFO - PROCESS | 13296 | |2;jquery.html;406.98372065117394;407.1571846278205;407.9347304431291;411.7097446300357;423.61451079517644;12339.568115115973;17524.91237543812;18788.62422751544;19188.808111918876;19394.127264273087;14770.704585908275;16340.918295408506;18250.543736406595;18321.816781832178;19204.9039754801;5455.536279416245;5666.376698563155;5685.8578535536735;5701.315842098933;5704.515116215127;5602.943970560304;5646.971765141168;5698.914516282259;5708.800191993281;5725.227094342252;4074.470318858544;5675.177099320596;5910.4089591040765;6241.687915604224;6285.434310912017;6283.371662833726;6305.842353941165;6322.367763223687;6379.8405039873915;6398.520110991671;5466.234727138204;5582.441755824385;5583.3858275590055;5609.214709940612;5609.382967873531;21688.34934951954;21746.238881639223;22423.103075876945;22832.77167228323;22836.65745013826;2198.9560208795892;2221.577900198957;2328.580855446019;2338.6258198688297;2800.537911244642;9609.951950240275;13578.592642220749;13960.511382101678;13991.860081399158;14724.116553006746;1865.4963159946738;1916.32928475034;1999.6900480425556;2015.5666531695756;2029.350607805503;79224.60387698082;81795.59102204451;81940;82054;83839.58080209621;10204.336718113298;10379.377237365783;10614.628488002883;10637.840432393521;10755.89244107549;14498.710025799424;14590.343434545472;14611.78082328766;14632.561023169323;14643.828493720477;7828.960855195802;8005.359571234288;8037.8392432152195;8109.878351824727;8151.551664658382;7237.638118094074;7324.707011719578;7483.476156668981;7847.803804904809;7856.135825059239;4303.677224208197;4368.301071828556;4393.868183954486;4461.732296062247;4541;1890.4801179675699;1965.0960558143415;1965.2728490458621;1971.9112639931238;1978.960420791576;819.5328662662345;920.2637889688223;929.159111004542;948.8339540580371;966.4201479112617;17400.825991740174;17748.112594370228;18073;18104;18499.260029598936;982.2780256511459;993.4684943555163;998.7503124218945;1010.6816352848977;1022.4325499347933;9534.570944307523;10294.227932905062;10332;10386.740331491623;10386.948065259776;497168;508297;510016;514607;518256;88907;92330;92473.53763231276;92686.53656731808;92898;1038.9064984151312;1043.7181960870523;1053.89461053894;1055.714956961616;1056.3397876327294;16647.91676041612;16989.49031529056;17191.140442978052;17335.393261235797;17404.651906962044;37711.434328484545;38145.61854381532;39307.80346098251;39544.604553954094;40963;54143.72928135334;54678.45321546893;54812;54865;54960.17559736527;8522.659093636184;8633.266172375419;8683.956580217058;8754.430961987706;8835.514046727492;10395.740106497398;11975.76048479043;13226.404811783685;13400.932995335352;13948.372323245276;7152.499325047197;12045.217060891015;12069.336186509827;12088.879111209128;12175.573854915036;11882.108841836724;11952.940235298767;12101.515939362327;12105.213161144497;12289.139760217056;6152.107944348134;9333.953330233577;11931.940340298243;12167.148299618942;12267.75464490723;7243.891341629986;8671.653133874826;8677.609507572048;8732.170443807829;8978.191962723386;9526;11359.602413915472;11918.284902905853;11929.164958452826;11949.283043017447 14:37:53 INFO - PROCESS | 13296 | |3;mootools.html;1239.5537606461667;1464.0264224290847;1505.6838064006558;1666.2252052795448;1843.2626949220319;7924.881126783102;8239.629216685249;8295.543745094024;8317.459365141262;8457.70398036069;7772.106207786092;7966.601669916496;8382.916170838289;8410.36922230832;8414.158584141584;1969.3599580136442;2231.787980141884;2262.208227120507;2311.9422014449606;2324.639680849471;2237.429455488848;2252.3355610094977;2254.9774502255013;2257.4582100295893;2276.089564174327;2221.7556068832414;2280.315905228433;2290.1297506947335;2302.1942320187886;2303.3090072978125;1995.4313020789077;2201.1855613423054;2266.8639881607155;2272.1706577099403;2282.4750307429385;2206.415299945516;2218.1681869299014;2232.928194466649;2243.080337061813;2243.4727838957833;8088.393370497236;8121.75634730959;8129.024517057932;8147.551884646342;8154.184581541857;4930.6795058321095;4963.503649635008;4973.552380285755;5026.145555255615;5028.773705183239;3194.648588655246;3200.8879689210767;3272.541844141822;3341.398548261312;3363.9159021024425;971.7424882406168;985.990140098597;1016.5273147986148;1026.3585259212991;1053.3048188195753;11524.711882202928;11802.350870702108;11823.822642660367;11825.231359961575;11907.464164112549;4707.293905914072;4727.101850648434;4728.0543891221205;4754.833580824655;4790.233562629963;10014;10018.448985305733;10040.196784257241;10041.899581004243;10073.445960472245;4430.955690443118;5203.843884683465;5206.739663016834;5238.92141617876;5239.764210610456;4504.414426124583;4666.486686464486;4676.508966558463;4719.2685133803625;4735.337052812609;3899.9275199319845;3928.0769019280447;3930.253251882133;3986.242613903407;4020.4974378202724;1273.2233337664018;1273.4587800184884;1276.1959965221852;1286.9742605148033;1288.3815768431018;826.404988408345;838.8112674648155;857.9785505362291;870.6082262981683;871.6513394642194;5382.407935127133;5562.72186390687;5578.693171875505;5634.774609015675;5673.801416950387;415.2649809836572;418.30352463149126;427.45499488152853;441.2234467337509;465.0373726386348;3911.198204368098;3968.583298753647;3980.9402858957137;3995.380715989026;4062.1266427718183;10139.188864890792;10556.841647375295;10717.410542420243;10747.462626868783;10793.136549076055;10485.423301718478;10685.091767199876;10691.679249622524;10702.143828493701;10716.517756700967;7550.848983020309;7649.541027538366;7748.496347737379;7962.044554653478;8005.1594582568;5632.324121105494;5778.046622307273;5809.24479817621;5878.617889837147;6076.726547305293;9312.115349041831;9767.462789546644;9891.406515609087;9941.403515789076;9979.550920208463;9151.77120571991;9629.614815407305;9636.180924621485;9869.309148359833;10057.497125143567;6538.673066346569;6772.86454270902;7359.227281135403;7374.6681399336085;7538.660760265691;8107.756767296991;8208.548529830678;8214.958925205574;8216.09622941464;8252.876206856781;7041.612711300928;7272.127344718668;7335.266473352622;7351.558906465629;7476.364509016795;6966.407855332353;6971.5468494547695;6972.337627925339;7057.929420705727;7130.144382674112;6240.812775616739;6377.202849643794;6380.170577824853;6558.967205163944;6562;4894.314795928502;4926.729029903389;4953.851384458472;4973.5523802857915;5018.397792264952;5024.547790698708;5057.544820966131;5092.083424983539;5097.668651537638;5161.845144645667 14:37:53 INFO - PROCESS | 13296 | |4;prototype.html;330.77837848641406;331.7793667211303;338.61059781251566;341.70442567179396;342.31195297452143;5107.012397747322;5124.9487505124935;5124.974375128119;5165.199394093916;5182.352205974254;5087.160618497953;5099.821506247282;5124.128898087325;5130.358705161855;5135.897282054357;3825.2923209206315;3844.2119365529998;3980.840766369342;3989.8005099744896;3991.6407523322896;3964.8612298569556;3972.404139379087;3987.6610488108545;3988.202359528106;3995.321964774787;3855.151866589346;3955.268275369066;3989.341758609826;3995.9001024974464;4024.9597504024878;3900.7074469414765;3945.2701250268647;3975.5626881043063;3990.3415936370466;3991.2416640838437;3493.061350950222;3509.929801403983;3523.7709548879243;3523.894283171509;3524.7356448266482;4883.365162528884;4907.656464047518;4950.925736113961;4981.601471882241;5024.799008039674;4447.398272010878;4459.576340247704;4559.361689363492;4569.634429245652;4607.861764147081;5294.947050529522;5323.414424413311;5328.227407025998;5330.200469929503;5343.332083489564;3897.8440862365474;3901.8634347797974;3910.7066969977363;3911.0026943129606;3943.7323538964924;5429;5521.69630670317;5563.332400111972;5568.916466253009;5653.773849046033;3954.762714237155;3960.0693836948294;3981.3828856527284;3990.880273591797;3994.7003974702016;4058.188362327546;4064.6748260139116;4075.673946084306;4077.1845630873945;4080.9797550612348;4485.730856148642;4513.638908887281;4571.885702857455;4613.284940834176;4617.445906491243;5329.546988505943;5346.4118946915805;5398.73006349681;5399.919001214985;5415.1029199378145;1381.5648070857649;1389.0901459544016;1390.3604342002793;1392.9442822287197;1393.1432169216062;885.8449771289999;924.893637231727;962.6967505235968;989.4014121456559;994.2990191914682;5093.337866077461;5130.7178105204575;5137.12668846297;5142.1772516397195;5172.301739265226;5440.646357986719;5459.645123066988;5517.282753242052;5518.172274158828;5519.254900588449;4989.90020199594;5048.242763585492;5105.851183483686;5120.48795120485;5144.279800827887;2858.571214317869;2865.3839424523826;2869.58391033299;2872.669642991041;2893.5659651052088;5383.623146379794;5499.752511136929;5519.475649813261;5541.501264886179;5610.747516361774;5502.9174562381595;5547.389787123494;5550.888982220414;5556.499915007668;5564.8330550083565;5577.2191893135;5590.8043218487155;5608.327000759853;5653.699649080734;5656.830295091236;5233.895322093613;5291.629585928948;5375.731213439234;5462.399136095106;5477.233187353853;5344.518993290622;5353.822159124987;5361.892762144657;5363.624546281723;5407.83776486706;5577.498025177753;5579.656544251343;5589.776408943597;5597.236870385816;5604.607677462538;3848.9422658659582;3944.861929832442;3948.881533553998;3983.9601603983588;4011.13760541485;5344.759485823225;5353.2505449237915;5357.785688572413;5409.486098820606;5424.159255315432;5288.074586947192;5338.813141540028;5350.394881535602;5360.195970604441;5369.744707222898;5152.098382783073;5295.549878260391;5303.337082864642;5328.733563321741;5359.544438722753;5023.723695196799;5094.847154585368;5117.692938423706;5164.612654050886;5241.868953276198;5277.577793776565;5284;5297.231901374356;5302.39022512416;5323.840284791308;5249.606279529127;5254.527092561688;5280;5287.709175995204;5297.17893726473 14:37:53 INFO - PROCESS | 13296 | |5;yui.html;672.9899051514227;675.9155105611802;697.4699228586275;715.7029832619463;721.2318880392381;10796.5681372745;11097.611583594577;11107.333559986406;11137.109031277509;11169;12255.203411778228;12477.438515266813;12526.749465010695;12537.937310313459;12606.873931260685;682.7746843541644;794.2653045932518;807.628490894188;825.1006403020706;827.2802661684343;822.321584692631;829.9957051967127;833.2001278772386;833.8540755367817;833.9374546908975;876.0363600039968;878.9824203515926;878.9912100879005;880.5377176982072;881.9250363719092;705.4497491956282;837.9036410812773;859.6948083430354;865.519636601689;867.7396780965717;632.8829166604193;634.0109429290322;634.0742515926753;636.8885445047098;638.543441439373;12085.93957030218;12090.758184836342;12116.09129315305;12125.514979400814;12136.575219867262;12438.626841194779;12933.353332333345;12986.09097363185;13056.477740890354;13228.801567976489;10635;10874.510647020903;10907.83638245427;10970.725731856688;11072.224944253905;4087.264292427362;4133.338665813455;4210.136921930997;4245.363195520666;4283.892902677427;51575.74212128953;52329.215061774106;54621.453785462036;54656.45343546553;55214.447855521736;10023.599056037823;10311;10356.585736570452;10499.947500262602;10531.262811603114;17721.29114835392;18679.87920724761;18746.812531874508;18764.24943002292;18810.717839232424;7009.1589009319205;7060.894086588705;7065.399441047466;7246;7699.422543309274;4076.3885417187657;4089.959100408958;4098.549159592442;4144.5026596808575;4213;3129.155128115396;3229.757768167397;3236.336551007038;3247.6589958054537;3254.153919980822;597.5757212379259;603.9547033972469;604.7490291529055;613.4448324266546;625.2746813696182;538.0557122250425;581.9388964158787;589.9734511946973;602.5330368964088;632.9556931014785;8479.236868681848;8489.915100848912;8519.829603407898;8545.188207120314;8659.263962563253;610.3926593039954;648.0508928040539;650.3658932540735;656.8522082531488;662.4634046422414;3939;3965.7025723070883;4003.799810009546;4024.8188831502653;4041.959580404217;63479.36520634734;64088.67955660192;64702;65064.67467662632;65130.674346627966;57177;58104.70947645235;58109;58444.70777646085;59063.11405328924;53451.198232025774;53671.46328536665;53764.73117634387;54139.45860541344;54316;7819.726309579365;7973.282404583615;8000.679972801023;8001.119876813662;8251.257386835214;32580.51129233016;32964.1758956028;33082.50376244407;33371.49942750812;33585.83207083949;42011.36982945319;43972.34041489444;45800.312995305765;46222.30666540072;47555.76222119006;9426.057394260519;9484.573194206416;9659.758506037406;9910.10809027191;10013.449260290463;8759.956200219212;10862.837057444303;11284.887151128383;11296.43517824122;11395.259308144945;11763;11902.345371004678;12012.879871201525;12107.152499324962;12135.089868260093;11713.121515886172;11886.524539018343;12022.519099236282;12055.336956467478;12172.208806427554;11880.821787673365;11936.462859171184;12110.515579376726;12146.817797733218;12253.326067066397;10183.84724229152;10262.138814417576;10314.896851031393;10495.947520262349;10667.413292269;10083.949580252052;10528;10531.526081326205;10534.262601617813;10614.575416983234 14:37:53 INFO - PROCESS | 13296 | __end_tp_report 14:37:53 INFO - PROCESS | 13296 | __start_cc_report 14:37:53 INFO - PROCESS | 13296 | _x_x_mozilla_cycle_collect,1046 14:37:53 INFO - PROCESS | 13296 | __end_cc_report 14:37:53 INFO - PROCESS | 13296 | __startTimestamp1463002673319__endTimestamp 14:37:53 INFO - PROCESS | 13296 | 14:37:53 INFO - PROCESS | 13296 | ------- Summary: start ------- 14:37:53 INFO - PROCESS | 13296 | Number of tests: 6 14:37:53 INFO - PROCESS | 13296 | 14:37:53 INFO - PROCESS | 13296 | [#0] dojo.html Cycles:165 Average:5314.41 Median:5497.86 stddev:603.02 (11.0%) stddev-sans-first:579.44 14:37:53 INFO - PROCESS | 13296 | Values: 3105.6 3119.5 3182.2 3191.3 3192.5 5257.6 5307.0 5315.3 5392.9 5420.4 5305.2 5327.9 5329.8 5353.8 5381.2 4770.3 4778.6 4995.1 5041.0 5086.5 4966.7 4966.7 4985.3 5022.8 5038.5 4799.7 4824.5 4851.5 4889.6 4910.0 4761.3 4799.7 4819.0 4834.7 4870.0 4797.8 4808.4 4903.9 4911.1 4937.0 5165.3 5318.5 5328.1 5363.0 5393.2 5652.8 5664.8 5713.0 5782.2 5836.5 5769.9 5770.8 5812.4 5830.7 5833.4 5017.2 5128.3 5371.4 5471.3 5478.6 5881.2 5922.7 5936.0 5975.0 5994.1 5594.6 5654.8 5660.6 5662.9 5672.7 5539.0 5551.9 5630.2 5735.8 5812.8 5691.0 5696.3 5702.5 5714.1 5744.1 5697.7 5704.3 5708.2 5710.9 5721.0 4246.4 4249.9 4287.7 4308.8 4336.9 3832.2 3847.8 3850.8 3888.9 3899.9 5347.0 5366.0 5377.6 5387.7 5392.6 5592.2 5727.1 5754.2 5773.6 5796.9 5433.2 5438.4 5439.2 5447.5 5465.7 4738.0 4959.5 4977.4 4978.9 5033.4 5808.6 5877.4 5886.4 5925.2 5927.0 5707.5 5719.3 5720.7 5728.8 5750.9 5645.8 5723.1 5880.4 5901.7 5903.2 5695.3 5718.9 5724.3 5736.0 5797.3 5692.7 5734.1 5749.6 5756.5 5782.5 5389.5 5522.5 5555.1 5675.9 5680.1 5579.0 5579.4 5599.1 5634.4 5664.3 5454.7 5495.8 5497.9 5505.0 5508.7 5481.8 5589.4 5635.2 5640.9 5677.7 5343.3 5395.2 5486.6 5507.2 5543.4 14:37:53 INFO - PROCESS | 13296 | 14:37:53 INFO - PROCESS | 13296 | [#1] ext.html Cycles:180 Average:54175.53 Median:21838.30 stddev:100734.41 (461.3%) stddev-sans-first:100936.56 14:37:53 INFO - PROCESS | 13296 | Values: 559.2 600.9 603.9 608.4 619.6 42724.4 44421.8 44540.0 48100.5 48132.3 43838.3 44310.3 44514.0 44708.6 44725.8 8739.4 8894.3 8908.0 8918.2 8928.1 8688.8 8751.2 8784.6 8785.1 8795.8 8846.3 8907.2 8908.7 8911.6 8917.5 8821.5 8830.1 8838.9 8853.2 8865.0 8687.3 8732.2 8760.1 8794.3 8795.7 36230.8 36723.4 36767.6 36804.6 36998.8 2976.2 3026.6 3110.1 3137.0 3316.5 30733.7 31242.8 31413.8 31617.4 31959.4 3955.6 3974.6 4032.6 4051.2 4054.8 303605.0 304727.0 305372.0 305441.0 306243.0 49001.8 53093.0 53291.0 53648.5 54422.0 59253.7 59968.0 59974.7 60163.7 60301.7 13860.5 13993.0 13993.1 14008.4 14067.5 10142.6 11983.5 12054.2 12509.6 12796.7 16415.0 16539.5 16562.2 16564.0 16633.3 5992.8 6096.3 6133.1 6150.1 6199.8 964.6 1067.4 1075.9 1115.5 1161.9 31304.8 31660.2 31719.0 31881.0 31892.5 1125.0 1148.6 1159.2 1214.2 1226.2 16378.8 16511.6 16652.5 16746.2 16805.5 468384.0 468988.0 474553.0 474847.0 476117.0 53164.7 53748.2 53818.0 54341.7 54555.5 1216.8 1350.3 1378.7 1386.6 1419.4 31150.5 31541.8 32176.4 32204.2 32629.8 47913.8 48522.8 48631.3 48675.8 48775.8 340627.0 347316.0 347768.0 349896.0 350972.0 34037.3 39178.4 39762.8 40562.8 44085.3 47049.5 47160.3 47371.1 47659.5 47920.5 38507.5 38691.4 39016.6 39576.6 39871.8 38880.6 39480.0 39642.8 40077.0 40214.2 39228.0 39702.0 39889.2 40465.6 40634.6 33636.3 34688.4 35165.3 35456.0 35535.8 26487.2 27371.7 27482.9 27551.2 27674.7 14:37:53 INFO - PROCESS | 13296 | 14:37:53 INFO - PROCESS | 13296 | [#2] jquery.html Cycles:180 Average:29193.21 Median:407.07 stddev:83943.98 (20621.5%) stddev-sans-first:84151.63 14:37:53 INFO - PROCESS | 13296 | Values: 407.0 407.2 407.9 411.7 423.6 12339.6 17524.9 18788.6 19188.8 19394.1 14770.7 16340.9 18250.5 18321.8 19204.9 5455.5 5666.4 5685.9 5701.3 5704.5 5602.9 5647.0 5698.9 5708.8 5725.2 4074.5 5675.2 5910.4 6241.7 6285.4 6283.4 6305.8 6322.4 6379.8 6398.5 5466.2 5582.4 5583.4 5609.2 5609.4 21688.3 21746.2 22423.1 22832.8 22836.7 2199.0 2221.6 2328.6 2338.6 2800.5 9610.0 13578.6 13960.5 13991.9 14724.1 1865.5 1916.3 1999.7 2015.6 2029.4 79224.6 81795.6 81940.0 82054.0 83839.6 10204.3 10379.4 10614.6 10637.8 10755.9 14498.7 14590.3 14611.8 14632.6 14643.8 7829.0 8005.4 8037.8 8109.9 8151.6 7237.6 7324.7 7483.5 7847.8 7856.1 4303.7 4368.3 4393.9 4461.7 4541.0 1890.5 1965.1 1965.3 1971.9 1979.0 819.5 920.3 929.2 948.8 966.4 17400.8 17748.1 18073.0 18104.0 18499.3 982.3 993.5 998.8 1010.7 1022.4 9534.6 10294.2 10332.0 10386.7 10386.9 497168.0 508297.0 510016.0 514607.0 518256.0 88907.0 92330.0 92473.5 92686.5 92898.0 1038.9 1043.7 1053.9 1055.7 1056.3 16647.9 16989.5 17191.1 17335.4 17404.7 37711.4 38145.6 39307.8 39544.6 40963.0 54143.7 54678.5 54812.0 54865.0 54960.2 8522.7 8633.3 8684.0 8754.4 8835.5 10395.7 11975.8 13226.4 13400.9 13948.4 7152.5 12045.2 12069.3 12088.9 12175.6 11882.1 11952.9 12101.5 12105.2 12289.1 6152.1 9334.0 11931.9 12167.1 12267.8 7243.9 8671.7 8677.6 8732.2 8978.2 9526.0 11359.6 11918.3 11929.2 11949.3 14:37:53 INFO - PROCESS | 13296 | 14:37:53 INFO - PROCESS | 13296 | [#3] mootools.html Cycles:180 Average:5536.77 Median:4910.52 stddev:3163.03 (64.4%) stddev-sans-first:3155.42 14:37:53 INFO - PROCESS | 13296 | Values: 1239.6 1464.0 1505.7 1666.2 1843.3 7924.9 8239.6 8295.5 8317.5 8457.7 7772.1 7966.6 8382.9 8410.4 8414.2 1969.4 2231.8 2262.2 2311.9 2324.6 2237.4 2252.3 2255.0 2257.5 2276.1 2221.8 2280.3 2290.1 2302.2 2303.3 1995.4 2201.2 2266.9 2272.2 2282.5 2206.4 2218.2 2232.9 2243.1 2243.5 8088.4 8121.8 8129.0 8147.6 8154.2 4930.7 4963.5 4973.6 5026.1 5028.8 3194.6 3200.9 3272.5 3341.4 3363.9 971.7 986.0 1016.5 1026.4 1053.3 11524.7 11802.4 11823.8 11825.2 11907.5 4707.3 4727.1 4728.1 4754.8 4790.2 10014.0 10018.4 10040.2 10041.9 10073.4 4431.0 5203.8 5206.7 5238.9 5239.8 4504.4 4666.5 4676.5 4719.3 4735.3 3899.9 3928.1 3930.3 3986.2 4020.5 1273.2 1273.5 1276.2 1287.0 1288.4 826.4 838.8 858.0 870.6 871.7 5382.4 5562.7 5578.7 5634.8 5673.8 415.3 418.3 427.5 441.2 465.0 3911.2 3968.6 3980.9 3995.4 4062.1 10139.2 10556.8 10717.4 10747.5 10793.1 10485.4 10685.1 10691.7 10702.1 10716.5 7550.8 7649.5 7748.5 7962.0 8005.2 5632.3 5778.0 5809.2 5878.6 6076.7 9312.1 9767.5 9891.4 9941.4 9979.6 9151.8 9629.6 9636.2 9869.3 10057.5 6538.7 6772.9 7359.2 7374.7 7538.7 8107.8 8208.5 8215.0 8216.1 8252.9 7041.6 7272.1 7335.3 7351.6 7476.4 6966.4 6971.5 6972.3 7057.9 7130.1 6240.8 6377.2 6380.2 6559.0 6562.0 4894.3 4926.7 4953.9 4973.6 5018.4 5024.5 5057.5 5092.1 5097.7 5161.8 14:37:53 INFO - PROCESS | 13296 | 14:37:53 INFO - PROCESS | 13296 | [#4] prototype.html Cycles:180 Average:4493.39 Median:5133.31 stddev:1301.24 (25.3%) stddev-sans-first:1266.82 14:37:53 INFO - PROCESS | 13296 | Values: 330.8 331.8 338.6 341.7 342.3 5107.0 5124.9 5125.0 5165.2 5182.4 5087.2 5099.8 5124.1 5130.4 5135.9 3825.3 3844.2 3980.8 3989.8 3991.6 3964.9 3972.4 3987.7 3988.2 3995.3 3855.2 3955.3 3989.3 3995.9 4025.0 3900.7 3945.3 3975.6 3990.3 3991.2 3493.1 3509.9 3523.8 3523.9 3524.7 4883.4 4907.7 4950.9 4981.6 5024.8 4447.4 4459.6 4559.4 4569.6 4607.9 5294.9 5323.4 5328.2 5330.2 5343.3 3897.8 3901.9 3910.7 3911.0 3943.7 5429.0 5521.7 5563.3 5568.9 5653.8 3954.8 3960.1 3981.4 3990.9 3994.7 4058.2 4064.7 4075.7 4077.2 4081.0 4485.7 4513.6 4571.9 4613.3 4617.4 5329.5 5346.4 5398.7 5399.9 5415.1 1381.6 1389.1 1390.4 1392.9 1393.1 885.8 924.9 962.7 989.4 994.3 5093.3 5130.7 5137.1 5142.2 5172.3 5440.6 5459.6 5517.3 5518.2 5519.3 4989.9 5048.2 5105.9 5120.5 5144.3 2858.6 2865.4 2869.6 2872.7 2893.6 5383.6 5499.8 5519.5 5541.5 5610.7 5502.9 5547.4 5550.9 5556.5 5564.8 5577.2 5590.8 5608.3 5653.7 5656.8 5233.9 5291.6 5375.7 5462.4 5477.2 5344.5 5353.8 5361.9 5363.6 5407.8 5577.5 5579.7 5589.8 5597.2 5604.6 3848.9 3944.9 3948.9 3984.0 4011.1 5344.8 5353.3 5357.8 5409.5 5424.2 5288.1 5338.8 5350.4 5360.2 5369.7 5152.1 5295.5 5303.3 5328.7 5359.5 5023.7 5094.8 5117.7 5164.6 5241.9 5277.6 5284.0 5297.2 5302.4 5323.8 5249.6 5254.5 5280.0 5287.7 5297.2 14:37:53 INFO - PROCESS | 13296 | 14:37:53 INFO - PROCESS | 13296 | [#5] yui.html Cycles:180 Average:14441.39 Median:24128.12 stddev:17715.07 (73.4%) stddev-sans-first:17734.59 14:37:53 INFO - PROCESS | 13296 | Values: 673.0 675.9 697.5 715.7 721.2 10796.6 11097.6 11107.3 11137.1 11169.0 12255.2 12477.4 12526.7 12537.9 12606.9 682.8 794.3 807.6 825.1 827.3 822.3 830.0 833.2 833.9 833.9 876.0 879.0 879.0 880.5 881.9 705.4 837.9 859.7 865.5 867.7 632.9 634.0 634.1 636.9 638.5 12085.9 12090.8 12116.1 12125.5 12136.6 12438.6 12933.4 12986.1 13056.5 13228.8 10635.0 10874.5 10907.8 10970.7 11072.2 4087.3 4133.3 4210.1 4245.4 4283.9 51575.7 52329.2 54621.5 54656.5 55214.4 10023.6 10311.0 10356.6 10499.9 10531.3 17721.3 18679.9 18746.8 18764.2 18810.7 7009.2 7060.9 7065.4 7246.0 7699.4 4076.4 4090.0 4098.5 4144.5 4213.0 3129.2 3229.8 3236.3 3247.7 3254.2 597.6 604.0 604.7 613.4 625.3 538.1 581.9 590.0 602.5 633.0 8479.2 8489.9 8519.8 8545.2 8659.3 610.4 648.1 650.4 656.9 662.5 3939.0 3965.7 4003.8 4024.8 4042.0 63479.4 64088.7 64702.0 65064.7 65130.7 57177.0 58104.7 58109.0 58444.7 59063.1 53451.2 53671.5 53764.7 54139.5 54316.0 7819.7 7973.3 8000.7 8001.1 8251.3 32580.5 32964.2 33082.5 33371.5 33585.8 42011.4 43972.3 45800.3 46222.3 47555.8 9426.1 9484.6 9659.8 9910.1 10013.4 8760.0 10862.8 11284.9 11296.4 11395.3 11763.0 11902.3 12012.9 12107.2 12135.1 11713.1 11886.5 12022.5 12055.3 12172.2 11880.8 11936.5 12110.5 12146.8 12253.3 10183.8 10262.1 10314.9 10495.9 10667.4 10083.9 10528.0 10531.5 10534.3 10614.6 14:37:53 INFO - PROCESS | 13296 | -------- Summary: end -------- 14:37:53 INFO - PROCESS | 13296 | 14:37:53 INFO - TEST-INFO | 13296: exit 0 14:37:53 INFO - TEST-OK | dromaeo_css | took 1110829ms 14:37:53 INFO - TEST-START | kraken 14:37:53 INFO - operating with platform_type : linux_ 14:37:53 INFO - Initialising browser for kraken test... 14:37:53 INFO - TEST-INFO | started process 13476 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzhHU0w/profile http://localhost:52218/getInfo.html) 14:37:57 INFO - PROCESS | 13476 | __metrics Screen width/height:1600/1200 14:37:57 INFO - PROCESS | 13476 | colorDepth:24 14:37:57 INFO - PROCESS | 13476 | Browser inner width/height: 1024/697 14:37:57 INFO - PROCESS | 13476 | __metrics 14:37:58 ERROR - PROCESS | 13476 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 14:37:59 INFO - TEST-INFO | 13476: exit 0 14:37:59 INFO - Browser initialized. 14:37:59 INFO - Running cycle 1/1 for kraken test... 14:37:59 INFO - TEST-INFO | started process 13555 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzhHU0w/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:38:10 INFO - PROCESS | 13555 | RSS: Main: 150781952 14:38:10 INFO - PROCESS | 13555 | 14:38:13 INFO - PROCESS | 13555 | Cycle 1(1): loaded http://localhost:52218/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52218/tests/kraken/driver.html?testName=audio-beat-detection) 14:38:13 INFO - PROCESS | 13555 | RSS: Main: 206893056 14:38:13 INFO - PROCESS | 13555 | 14:38:16 INFO - PROCESS | 13555 | Cycle 1(1): loaded http://localhost:52218/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52218/tests/kraken/driver.html?testName=audio-dft) 14:38:17 INFO - PROCESS | 13555 | RSS: Main: 196632576 14:38:17 INFO - PROCESS | 13555 | 14:38:20 INFO - PROCESS | 13555 | Cycle 1(1): loaded http://localhost:52218/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52218/tests/kraken/driver.html?testName=audio-fft) 14:38:20 INFO - PROCESS | 13555 | RSS: Main: 263610368 14:38:20 INFO - PROCESS | 13555 | 14:38:22 INFO - PROCESS | 13555 | Cycle 1(1): loaded http://localhost:52218/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52218/tests/kraken/driver.html?testName=audio-oscillator) 14:38:23 INFO - PROCESS | 13555 | RSS: Main: 172789760 14:38:23 INFO - PROCESS | 13555 | 14:38:25 INFO - PROCESS | 13555 | Cycle 1(1): loaded http://localhost:52218/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52218/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:38:26 INFO - PROCESS | 13555 | RSS: Main: 177688576 14:38:26 INFO - PROCESS | 13555 | 14:38:29 INFO - PROCESS | 13555 | Cycle 1(1): loaded http://localhost:52218/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52218/tests/kraken/driver.html?testName=imaging-darkroom) 14:38:30 INFO - PROCESS | 13555 | RSS: Main: 213188608 14:38:30 INFO - PROCESS | 13555 | 14:38:33 INFO - PROCESS | 13555 | Cycle 1(1): loaded http://localhost:52218/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52218/tests/kraken/driver.html?testName=imaging-desaturate) 14:38:34 INFO - PROCESS | 13555 | RSS: Main: 211206144 14:38:34 INFO - PROCESS | 13555 | 14:38:37 INFO - PROCESS | 13555 | Cycle 1(1): loaded http://localhost:52218/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52218/tests/kraken/driver.html?testName=json-parse-financial) 14:38:38 INFO - PROCESS | 13555 | RSS: Main: 212500480 14:38:38 INFO - PROCESS | 13555 | 14:38:39 INFO - PROCESS | 13555 | Cycle 1(1): loaded http://localhost:52218/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52218/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:38:40 INFO - PROCESS | 13555 | RSS: Main: 201265152 14:38:40 INFO - PROCESS | 13555 | 14:38:41 INFO - PROCESS | 13555 | Cycle 1(1): loaded http://localhost:52218/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52218/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:38:42 INFO - PROCESS | 13555 | RSS: Main: 202891264 14:38:42 INFO - PROCESS | 13555 | 14:38:44 INFO - PROCESS | 13555 | Cycle 1(1): loaded http://localhost:52218/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52218/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:38:45 INFO - PROCESS | 13555 | RSS: Main: 213245952 14:38:45 INFO - PROCESS | 13555 | 14:38:48 INFO - PROCESS | 13555 | Cycle 1(1): loaded http://localhost:52218/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52218/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:38:48 INFO - PROCESS | 13555 | RSS: Main: 218923008 14:38:48 INFO - PROCESS | 13555 | 14:38:51 INFO - PROCESS | 13555 | Cycle 1(1): loaded http://localhost:52218/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52218/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:38:52 INFO - PROCESS | 13555 | RSS: Main: 216350720 14:38:52 INFO - PROCESS | 13555 | 14:38:53 INFO - PROCESS | 13555 | Cycle 1(1): loaded http://localhost:52218/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52218/tests/kraken/driver.html?testName=ai-astar) 14:38:54 INFO - PROCESS | 13555 | RSS: Main: 262664192 14:38:54 INFO - PROCESS | 13555 | 14:38:54 INFO - PROCESS | 13555 | __start_tp_report 14:38:54 INFO - PROCESS | 13555 | _x_x_mozilla_page_load 14:38:54 INFO - PROCESS | 13555 | _x_x_mozilla_page_load_details 14:38:54 INFO - PROCESS | 13555 | |i|pagename|runs| 14:38:54 INFO - PROCESS | 13555 | |0;ai-astar;112;107;116;111;111;113;112;111;113;112 14:38:54 INFO - PROCESS | 13555 | |1;audio-beat-detection;156;134;157;209;134;156;152;133;186;132 14:38:54 INFO - PROCESS | 13555 | |2;audio-dft;162;161;160;161;161;163;163;163;161;163 14:38:54 INFO - PROCESS | 13555 | |3;audio-fft;78;77;77;150;78;78;78;76;130;77 14:38:54 INFO - PROCESS | 13555 | |4;audio-oscillator;93;93;146;93;93;93;121;94;93;122 14:38:54 INFO - PROCESS | 13555 | |5;imaging-gaussian-blur;117;118;119;118;118;117;117;117;118;119 14:38:54 INFO - PROCESS | 13555 | |6;imaging-darkroom;147;148;149;147;148;148;147;148;146;148 14:38:54 INFO - PROCESS | 13555 | |7;imaging-desaturate;96;96;96;96;97;97;97;96;97;95 14:38:54 INFO - PROCESS | 13555 | |8;json-parse-financial;61;62;63;62;62;62;61;115;58;59 14:38:54 INFO - PROCESS | 13555 | |9;json-stringify-tinderbox;58;59;59;59;59;59;59;59;58;59 14:38:54 INFO - PROCESS | 13555 | |10;stanford-crypto-aes;83;80;86;81;85;82;88;86;82;82 14:38:54 INFO - PROCESS | 13555 | |11;stanford-crypto-ccm;132;132;137;138;130;132;139;134;268;155 14:38:54 INFO - PROCESS | 13555 | |12;stanford-crypto-pbkdf2;176;171;172;175;175;173;173;179;174;171 14:38:54 INFO - PROCESS | 13555 | |13;stanford-crypto-sha256-iterative;71;68;72;67;70;66;67;66;67;69 14:38:54 INFO - PROCESS | 13555 | __end_tp_report 14:38:54 INFO - PROCESS | 13555 | __start_cc_report 14:38:54 INFO - PROCESS | 13555 | _x_x_mozilla_cycle_collect,1702 14:38:54 INFO - PROCESS | 13555 | __end_cc_report 14:38:54 INFO - PROCESS | 13555 | __startTimestamp1463002734182__endTimestamp 14:38:54 INFO - PROCESS | 13555 | 14:38:54 INFO - PROCESS | 13555 | ------- Summary: start ------- 14:38:54 INFO - PROCESS | 13555 | Number of tests: 14 14:38:54 INFO - PROCESS | 13555 | 14:38:54 INFO - PROCESS | 13555 | [#0] ai-astar Cycles:10 Average:111.80 Median:112.00 stddev:2.25 (2.0%) stddev-sans-first:2.39 14:38:54 INFO - PROCESS | 13555 | Values: 112.0 107.0 116.0 111.0 111.0 113.0 112.0 111.0 113.0 112.0 14:38:54 INFO - PROCESS | 13555 | 14:38:54 INFO - PROCESS | 13555 | [#1] audio-beat-detection Cycles:10 Average:154.90 Median:156.00 stddev:25.36 (16.3%) stddev-sans-first:26.89 14:38:54 INFO - PROCESS | 13555 | Values: 156.0 134.0 157.0 209.0 134.0 156.0 152.0 133.0 186.0 132.0 14:38:54 INFO - PROCESS | 13555 | 14:38:54 INFO - PROCESS | 13555 | [#2] audio-dft Cycles:10 Average:161.80 Median:162.50 stddev:1.14 (0.7%) stddev-sans-first:1.20 14:38:54 INFO - PROCESS | 13555 | Values: 162.0 161.0 160.0 161.0 161.0 163.0 163.0 163.0 161.0 163.0 14:38:54 INFO - PROCESS | 13555 | 14:38:54 INFO - PROCESS | 13555 | [#3] audio-fft Cycles:10 Average:89.90 Median:77.50 stddev:26.83 (34.6%) stddev-sans-first:28.11 14:38:54 INFO - PROCESS | 13555 | Values: 78.0 77.0 77.0 150.0 78.0 78.0 78.0 76.0 130.0 77.0 14:38:54 INFO - PROCESS | 13555 | 14:38:54 INFO - PROCESS | 13555 | [#4] audio-oscillator Cycles:10 Average:104.10 Median:93.00 stddev:18.86 (20.3%) stddev-sans-first:19.58 14:38:54 INFO - PROCESS | 13555 | Values: 93.0 93.0 146.0 93.0 93.0 93.0 121.0 94.0 93.0 122.0 14:38:54 INFO - PROCESS | 13555 | 14:38:54 INFO - PROCESS | 13555 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.79 (0.7%) stddev-sans-first:0.78 14:38:54 INFO - PROCESS | 13555 | Values: 117.0 118.0 119.0 118.0 118.0 117.0 117.0 117.0 118.0 119.0 14:38:54 INFO - PROCESS | 13555 | 14:38:54 INFO - PROCESS | 13555 | [#6] imaging-darkroom Cycles:10 Average:147.60 Median:148.00 stddev:0.84 (0.6%) stddev-sans-first:0.87 14:38:54 INFO - PROCESS | 13555 | Values: 147.0 148.0 149.0 147.0 148.0 148.0 147.0 148.0 146.0 148.0 14:38:54 INFO - PROCESS | 13555 | 14:38:54 INFO - PROCESS | 13555 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.50 stddev:0.67 (0.7%) stddev-sans-first:0.71 14:38:54 INFO - PROCESS | 13555 | Values: 96.0 96.0 96.0 96.0 97.0 97.0 97.0 96.0 97.0 95.0 14:38:54 INFO - PROCESS | 13555 | 14:38:54 INFO - PROCESS | 13555 | [#8] json-parse-financial Cycles:10 Average:66.50 Median:62.00 stddev:17.11 (27.6%) stddev-sans-first:18.03 14:38:54 INFO - PROCESS | 13555 | Values: 61.0 62.0 63.0 62.0 62.0 62.0 61.0 115.0 58.0 59.0 14:38:54 INFO - PROCESS | 13555 | 14:38:54 INFO - PROCESS | 13555 | [#9] json-stringify-tinderbox Cycles:10 Average:58.80 Median:59.00 stddev:0.42 (0.7%) stddev-sans-first:0.33 14:38:54 INFO - PROCESS | 13555 | Values: 58.0 59.0 59.0 59.0 59.0 59.0 59.0 59.0 58.0 59.0 14:38:54 INFO - PROCESS | 13555 | 14:38:54 INFO - PROCESS | 13555 | [#10] stanford-crypto-aes Cycles:10 Average:83.50 Median:84.00 stddev:2.59 (3.1%) stddev-sans-first:2.74 14:38:54 INFO - PROCESS | 13555 | Values: 83.0 80.0 86.0 81.0 85.0 82.0 88.0 86.0 82.0 82.0 14:38:54 INFO - PROCESS | 13555 | 14:38:54 INFO - PROCESS | 13555 | [#11] stanford-crypto-ccm Cycles:10 Average:149.70 Median:137.50 stddev:42.18 (30.7%) stddev-sans-first:44.25 14:38:54 INFO - PROCESS | 13555 | Values: 132.0 132.0 137.0 138.0 130.0 132.0 139.0 134.0 268.0 155.0 14:38:54 INFO - PROCESS | 13555 | 14:38:54 INFO - PROCESS | 13555 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.90 Median:174.50 stddev:2.47 (1.4%) stddev-sans-first:2.50 14:38:54 INFO - PROCESS | 13555 | Values: 176.0 171.0 172.0 175.0 175.0 173.0 173.0 179.0 174.0 171.0 14:38:54 INFO - PROCESS | 13555 | 14:38:54 INFO - PROCESS | 13555 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.30 Median:68.50 stddev:2.11 (3.1%) stddev-sans-first:2.00 14:38:54 INFO - PROCESS | 13555 | Values: 71.0 68.0 72.0 67.0 70.0 66.0 67.0 66.0 67.0 69.0 14:38:54 INFO - PROCESS | 13555 | -------- Summary: end -------- 14:38:54 INFO - PROCESS | 13555 | 14:38:54 INFO - TEST-INFO | 13555: exit 0 14:38:54 INFO - TEST-OK | kraken | took 61158ms 14:38:54 INFO - SUITE-END | took 1171s 14:38:55 INFO - Completed test suite (00:19:32) 14:38:55 INFO - javascript benchmark 14:38:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3105.6117985251844, 3119.485284927987, 3182.2203560127764, 3191.2500562367854, 3192.521121831725, 5257.553107985826, 5307.0, 5315.309009828727, 5392.946070539293, 5420.403755586887, 5305.204219367087, 5327.866803329919, 5329.813456529022, 5353.812616558421, 5381.219723140142, 4770.308305295722, 4778.569928706415, 4995.075910956485, 5040.974795126038, 5086.542211200991, 4966.726830024347, 4966.726830024347, 4985.277134815449, 5022.82420115296, 5038.470960549126, 4799.664023518355, 4824.517548245165, 4851.514848515138, 4889.633277504201, 4910.017996400734, 4761.262004389325, 4799.688020278671, 4819.0, 4834.661573689843, 4870.0, 4797.8320758773625, 4808.350872632185, 4903.926441103386, 4911.066897289504, 4937.037277730844, 5165.328507294028, 5318.468153184689, 5328.147496400557, 5363.0, 5393.2179833923865, 5652.802151924704, 5664.801731939404, 5713.0, 5782.248307720011, 5836.533077353802, 5769.884602307972, 5770.7691692332255, 5812.360640329561, 5830.708464576796, 5833.445822646841, 5017.222330538772, 5128.25640282157, 5371.409144994048, 5471.316085489314, 5478.616496845222, 5881.206037185011, 5922.703864806743, 5935.99088155006, 5974.970125149346, 5994.130851026577, 5594.636348637326, 5654.773809047674, 5660.575456840754, 5662.924044431545, 5672.716364181857, 5538.972305138448, 5551.8889622207325, 5630.155476678531, 5735.77056917727, 5812.796552120655, 5691.03252447085, 5696.3449203341315, 5702.45826646468, 5714.085746280575, 5744.109663002241, 5697.715114244271, 5704.34400043992, 5708.229389032511, 5710.857228569319, 5720.970225359392, 4246.40550322955, 4249.915001699948, 4287.656987440997, 4308.763018033976, 4336.8517668655495, 3832.1952389997855, 3847.846086156578, 3850.7882066486054, 3888.902777430587, 3899.863504777319, 5346.97326513365, 5365.9731701342025, 5377.623566350318, 5387.676739395649, 5392.595555333366, 5592.161175823659, 5727.140928860621, 5754.223179870748, 5773.595848290579, 5796.927568399859, 5433.1850222466155, 5438.401775804658, 5439.184122381675, 5447.4824891635235, 5465.672059676433, 4738.0, 4959.479254678279, 4977.377827771528, 4978.925316120261, 5033.421156566968, 5808.6224395414165, 5877.353491115974, 5886.411358864079, 5925.170476133431, 5927.0, 5707.514861236841, 5719.256496655408, 5720.685362305113, 5728.828135155952, 5750.942490575041, 5645.774169033192, 5723.141528770718, 5880.382559831327, 5901.675407852609, 5903.173555702291, 5695.259616249861, 5718.914216286676, 5724.284464441945, 5736.024875771045, 5797.333306669787, 5692.686902220252, 5734.082546792493, 5749.626274292157, 5756.481916627524, 5782.537397008314, 5389.487998640123, 5522.475364840334, 5555.055640541037, 5675.858103547444, 5680.091185410314, 5579.023670857665, 5579.386267510489, 5599.0761524349655, 5634.380218176079, 5664.348599911063, 5454.727263636882, 5495.780168793203, 5497.862553436196, 5504.972475137759, 5508.669479831223, 5481.835544933659, 5589.385167631639, 5635.239242702182, 5640.85897852557, 5677.687727175045, 5343.305370301836, 5395.163749618815, 5486.561075113901, 5507.228987941611, 5543.362513311021], "value": 5274.212577458953, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [559.1863838115543, 600.8888355654204, 603.8587070436872, 608.4159207161125, 619.5663035874887, 42724.359134613005, 44421.77789111054, 44540.0, 48100.51899481004, 48132.27801582979, 43838.34242486365, 44310.33534496977, 44514.0, 44708.55291447085, 44725.77637111818, 8739.388242823004, 8894.332925030616, 8907.955460222689, 8918.152775486318, 8928.107189281085, 8688.782780430509, 8751.212390884819, 8784.560771961409, 8785.121487851227, 8795.824083518326, 8846.336524760636, 8907.153820387053, 8908.73273801787, 8911.598978045971, 8917.464952102862, 8821.470711757314, 8830.072842351557, 8838.911610883873, 8853.247473964688, 8865.0, 8687.261582765472, 8732.170443807892, 8760.123987601253, 8794.34042446819, 8795.692150774756, 36230.818845905866, 36723.44914826253, 36767.63232367695, 36804.631953680386, 36998.81500592507, 2976.2378602133444, 3026.561148633458, 3110.0669799060192, 3136.9843150784327, 3316.469364901628, 30733.692663073307, 31242.843785780926, 31413.842930785428, 31617.367652647048, 31959.360812783845, 3955.6242156995327, 3974.602539746002, 4032.5967403259733, 4051.1897620476025, 4054.776987265699, 303605.0, 304727.0, 305372.0, 305441.0, 306243.0, 49001.754991224814, 53093.0, 53291.0, 53648.46351536435, 54422.0, 59253.70373148193, 59968.0, 59974.70012649909, 60163.699181504686, 60301.69849150726, 13860.514881979083, 13993.0, 13993.090449120775, 14008.439662413593, 14067.507637232648, 10142.594296228068, 11983.46074426653, 12054.15620906528, 12509.56216532417, 12796.680082997813, 16415.015099094093, 16539.50381488557, 16562.17189140538, 16564.0, 16633.334666613442, 5992.760289588367, 6096.268447786294, 6133.0800379942475, 6150.138980542728, 6199.814005579839, 964.6430820596283, 1067.4022547373495, 1075.9139268858473, 1115.4924509348227, 1161.8896204860694, 31304.84347578293, 31660.208494787814, 31719.0, 31881.0, 31892.521612175835, 1124.9887501124883, 1148.592249751343, 1159.2291126400848, 1214.2350319298785, 1226.1845872494691, 16378.754318685229, 16511.587210319838, 16652.50042498727, 16746.246418911178, 16805.495835124966, 468384.0, 468988.0, 474553.0, 474847.0, 476117.0, 53164.73417632887, 53748.19377709337, 53818.0, 54341.72829135829, 54555.454445455034, 1216.7566486702694, 1350.2910971739718, 1378.696686728918, 1386.5840247925582, 1419.4180386041674, 31150.532742008436, 31541.842290788398, 32176.35647287088, 32204.19489512687, 32629.836850815595, 47913.76043119762, 48522.75738621284, 48631.27053094277, 48675.756621216664, 48775.756121219165, 340627.0, 347316.0, 347768.0, 349896.0, 350972.0, 34037.319253614296, 39178.41232381573, 39762.80118599504, 40562.797186015065, 44085.33871991987, 47049.52950470588, 47160.29259561041, 47371.05257894892, 47659.52340476551, 47920.520794791606, 38507.47604532816, 38691.41962870503, 39016.6098339013, 39576.60423395729, 39871.80064099661, 38880.61119388883, 39480.0, 39642.80178599089, 40077.0, 40214.1957160861, 39228.0, 39702.0, 39889.20221595494, 40465.59534404736, 40634.59365406308, 33636.327273453906, 34688.41187992089, 35165.296694066485, 35456.0, 35535.822320888234, 26487.205383838515, 27371.726282737713, 27482.862585687744, 27551.173464796088, 27674.723252767213], "value": 19347.475948099906, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [406.98372065117394, 407.1571846278205, 407.9347304431291, 411.7097446300357, 423.61451079517644, 12339.568115115973, 17524.91237543812, 18788.62422751544, 19188.808111918876, 19394.127264273087, 14770.704585908275, 16340.918295408506, 18250.543736406595, 18321.816781832178, 19204.9039754801, 5455.536279416245, 5666.376698563155, 5685.8578535536735, 5701.315842098933, 5704.515116215127, 5602.943970560304, 5646.971765141168, 5698.914516282259, 5708.800191993281, 5725.227094342252, 4074.470318858544, 5675.177099320596, 5910.4089591040765, 6241.687915604224, 6285.434310912017, 6283.371662833726, 6305.842353941165, 6322.367763223687, 6379.8405039873915, 6398.520110991671, 5466.234727138204, 5582.441755824385, 5583.3858275590055, 5609.214709940612, 5609.382967873531, 21688.34934951954, 21746.238881639223, 22423.103075876945, 22832.77167228323, 22836.65745013826, 2198.9560208795892, 2221.577900198957, 2328.580855446019, 2338.6258198688297, 2800.537911244642, 9609.951950240275, 13578.592642220749, 13960.511382101678, 13991.860081399158, 14724.116553006746, 1865.4963159946738, 1916.32928475034, 1999.6900480425556, 2015.5666531695756, 2029.350607805503, 79224.60387698082, 81795.59102204451, 81940.0, 82054.0, 83839.58080209621, 10204.336718113298, 10379.377237365783, 10614.628488002883, 10637.840432393521, 10755.89244107549, 14498.710025799424, 14590.343434545472, 14611.78082328766, 14632.561023169323, 14643.828493720477, 7828.960855195802, 8005.359571234288, 8037.8392432152195, 8109.878351824727, 8151.551664658382, 7237.638118094074, 7324.707011719578, 7483.476156668981, 7847.803804904809, 7856.135825059239, 4303.677224208197, 4368.301071828556, 4393.868183954486, 4461.732296062247, 4541.0, 1890.4801179675699, 1965.0960558143415, 1965.2728490458621, 1971.9112639931238, 1978.960420791576, 819.5328662662345, 920.2637889688223, 929.159111004542, 948.8339540580371, 966.4201479112617, 17400.825991740174, 17748.112594370228, 18073.0, 18104.0, 18499.260029598936, 982.2780256511459, 993.4684943555163, 998.7503124218945, 1010.6816352848977, 1022.4325499347933, 9534.570944307523, 10294.227932905062, 10332.0, 10386.740331491623, 10386.948065259776, 497168.0, 508297.0, 510016.0, 514607.0, 518256.0, 88907.0, 92330.0, 92473.53763231276, 92686.53656731808, 92898.0, 1038.9064984151312, 1043.7181960870523, 1053.89461053894, 1055.714956961616, 1056.3397876327294, 16647.91676041612, 16989.49031529056, 17191.140442978052, 17335.393261235797, 17404.651906962044, 37711.434328484545, 38145.61854381532, 39307.80346098251, 39544.604553954094, 40963.0, 54143.72928135334, 54678.45321546893, 54812.0, 54865.0, 54960.17559736527, 8522.659093636184, 8633.266172375419, 8683.956580217058, 8754.430961987706, 8835.514046727492, 10395.740106497398, 11975.76048479043, 13226.404811783685, 13400.932995335352, 13948.372323245276, 7152.499325047197, 12045.217060891015, 12069.336186509827, 12088.879111209128, 12175.573854915036, 11882.108841836724, 11952.940235298767, 12101.515939362327, 12105.213161144497, 12289.139760217056, 6152.107944348134, 9333.953330233577, 11931.940340298243, 12167.148299618942, 12267.75464490723, 7243.891341629986, 8671.653133874826, 8677.609507572048, 8732.170443807829, 8978.191962723386, 9526.0, 11359.602413915472, 11918.284902905853, 11929.164958452826, 11949.283043017447], "value": 9086.398009669272, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1239.5537606461667, 1464.0264224290847, 1505.6838064006558, 1666.2252052795448, 1843.2626949220319, 7924.881126783102, 8239.629216685249, 8295.543745094024, 8317.459365141262, 8457.70398036069, 7772.106207786092, 7966.601669916496, 8382.916170838289, 8410.36922230832, 8414.158584141584, 1969.3599580136442, 2231.787980141884, 2262.208227120507, 2311.9422014449606, 2324.639680849471, 2237.429455488848, 2252.3355610094977, 2254.9774502255013, 2257.4582100295893, 2276.089564174327, 2221.7556068832414, 2280.315905228433, 2290.1297506947335, 2302.1942320187886, 2303.3090072978125, 1995.4313020789077, 2201.1855613423054, 2266.8639881607155, 2272.1706577099403, 2282.4750307429385, 2206.415299945516, 2218.1681869299014, 2232.928194466649, 2243.080337061813, 2243.4727838957833, 8088.393370497236, 8121.75634730959, 8129.024517057932, 8147.551884646342, 8154.184581541857, 4930.6795058321095, 4963.503649635008, 4973.552380285755, 5026.145555255615, 5028.773705183239, 3194.648588655246, 3200.8879689210767, 3272.541844141822, 3341.398548261312, 3363.9159021024425, 971.7424882406168, 985.990140098597, 1016.5273147986148, 1026.3585259212991, 1053.3048188195753, 11524.711882202928, 11802.350870702108, 11823.822642660367, 11825.231359961575, 11907.464164112549, 4707.293905914072, 4727.101850648434, 4728.0543891221205, 4754.833580824655, 4790.233562629963, 10014.0, 10018.448985305733, 10040.196784257241, 10041.899581004243, 10073.445960472245, 4430.955690443118, 5203.843884683465, 5206.739663016834, 5238.92141617876, 5239.764210610456, 4504.414426124583, 4666.486686464486, 4676.508966558463, 4719.2685133803625, 4735.337052812609, 3899.9275199319845, 3928.0769019280447, 3930.253251882133, 3986.242613903407, 4020.4974378202724, 1273.2233337664018, 1273.4587800184884, 1276.1959965221852, 1286.9742605148033, 1288.3815768431018, 826.404988408345, 838.8112674648155, 857.9785505362291, 870.6082262981683, 871.6513394642194, 5382.407935127133, 5562.72186390687, 5578.693171875505, 5634.774609015675, 5673.801416950387, 415.2649809836572, 418.30352463149126, 427.45499488152853, 441.2234467337509, 465.0373726386348, 3911.198204368098, 3968.583298753647, 3980.9402858957137, 3995.380715989026, 4062.1266427718183, 10139.188864890792, 10556.841647375295, 10717.410542420243, 10747.462626868783, 10793.136549076055, 10485.423301718478, 10685.091767199876, 10691.679249622524, 10702.143828493701, 10716.517756700967, 7550.848983020309, 7649.541027538366, 7748.496347737379, 7962.044554653478, 8005.1594582568, 5632.324121105494, 5778.046622307273, 5809.24479817621, 5878.617889837147, 6076.726547305293, 9312.115349041831, 9767.462789546644, 9891.406515609087, 9941.403515789076, 9979.550920208463, 9151.77120571991, 9629.614815407305, 9636.180924621485, 9869.309148359833, 10057.497125143567, 6538.673066346569, 6772.86454270902, 7359.227281135403, 7374.6681399336085, 7538.660760265691, 8107.756767296991, 8208.548529830678, 8214.958925205574, 8216.09622941464, 8252.876206856781, 7041.612711300928, 7272.127344718668, 7335.266473352622, 7351.558906465629, 7476.364509016795, 6966.407855332353, 6971.5468494547695, 6972.337627925339, 7057.929420705727, 7130.144382674112, 6240.812775616739, 6377.202849643794, 6380.170577824853, 6558.967205163944, 6562.0, 4894.314795928502, 4926.729029903389, 4953.851384458472, 4973.5523802857915, 5018.397792264952, 5024.547790698708, 5057.544820966131, 5092.083424983539, 5097.668651537638, 5161.845144645667], "value": 4355.474040400257, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [330.77837848641406, 331.7793667211303, 338.61059781251566, 341.70442567179396, 342.31195297452143, 5107.012397747322, 5124.9487505124935, 5124.974375128119, 5165.199394093916, 5182.352205974254, 5087.160618497953, 5099.821506247282, 5124.128898087325, 5130.358705161855, 5135.897282054357, 3825.2923209206315, 3844.2119365529998, 3980.840766369342, 3989.8005099744896, 3991.6407523322896, 3964.8612298569556, 3972.404139379087, 3987.6610488108545, 3988.202359528106, 3995.321964774787, 3855.151866589346, 3955.268275369066, 3989.341758609826, 3995.9001024974464, 4024.9597504024878, 3900.7074469414765, 3945.2701250268647, 3975.5626881043063, 3990.3415936370466, 3991.2416640838437, 3493.061350950222, 3509.929801403983, 3523.7709548879243, 3523.894283171509, 3524.7356448266482, 4883.365162528884, 4907.656464047518, 4950.925736113961, 4981.601471882241, 5024.799008039674, 4447.398272010878, 4459.576340247704, 4559.361689363492, 4569.634429245652, 4607.861764147081, 5294.947050529522, 5323.414424413311, 5328.227407025998, 5330.200469929503, 5343.332083489564, 3897.8440862365474, 3901.8634347797974, 3910.7066969977363, 3911.0026943129606, 3943.7323538964924, 5429.0, 5521.69630670317, 5563.332400111972, 5568.916466253009, 5653.773849046033, 3954.762714237155, 3960.0693836948294, 3981.3828856527284, 3990.880273591797, 3994.7003974702016, 4058.188362327546, 4064.6748260139116, 4075.673946084306, 4077.1845630873945, 4080.9797550612348, 4485.730856148642, 4513.638908887281, 4571.885702857455, 4613.284940834176, 4617.445906491243, 5329.546988505943, 5346.4118946915805, 5398.73006349681, 5399.919001214985, 5415.1029199378145, 1381.5648070857649, 1389.0901459544016, 1390.3604342002793, 1392.9442822287197, 1393.1432169216062, 885.8449771289999, 924.893637231727, 962.6967505235968, 989.4014121456559, 994.2990191914682, 5093.337866077461, 5130.7178105204575, 5137.12668846297, 5142.1772516397195, 5172.301739265226, 5440.646357986719, 5459.645123066988, 5517.282753242052, 5518.172274158828, 5519.254900588449, 4989.90020199594, 5048.242763585492, 5105.851183483686, 5120.48795120485, 5144.279800827887, 2858.571214317869, 2865.3839424523826, 2869.58391033299, 2872.669642991041, 2893.5659651052088, 5383.623146379794, 5499.752511136929, 5519.475649813261, 5541.501264886179, 5610.747516361774, 5502.9174562381595, 5547.389787123494, 5550.888982220414, 5556.499915007668, 5564.8330550083565, 5577.2191893135, 5590.8043218487155, 5608.327000759853, 5653.699649080734, 5656.830295091236, 5233.895322093613, 5291.629585928948, 5375.731213439234, 5462.399136095106, 5477.233187353853, 5344.518993290622, 5353.822159124987, 5361.892762144657, 5363.624546281723, 5407.83776486706, 5577.498025177753, 5579.656544251343, 5589.776408943597, 5597.236870385816, 5604.607677462538, 3848.9422658659582, 3944.861929832442, 3948.881533553998, 3983.9601603983588, 4011.13760541485, 5344.759485823225, 5353.2505449237915, 5357.785688572413, 5409.486098820606, 5424.159255315432, 5288.074586947192, 5338.813141540028, 5350.394881535602, 5360.195970604441, 5369.744707222898, 5152.098382783073, 5295.549878260391, 5303.337082864642, 5328.733563321741, 5359.544438722753, 5023.723695196799, 5094.847154585368, 5117.692938423706, 5164.612654050886, 5241.868953276198, 5277.577793776565, 5284.0, 5297.231901374356, 5302.39022512416, 5323.840284791308, 5249.606279529127, 5254.527092561688, 5280.0, 5287.709175995204, 5297.17893726473], "value": 4086.3771051086383, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [672.9899051514227, 675.9155105611802, 697.4699228586275, 715.7029832619463, 721.2318880392381, 10796.5681372745, 11097.611583594577, 11107.333559986406, 11137.109031277509, 11169.0, 12255.203411778228, 12477.438515266813, 12526.749465010695, 12537.937310313459, 12606.873931260685, 682.7746843541644, 794.2653045932518, 807.628490894188, 825.1006403020706, 827.2802661684343, 822.321584692631, 829.9957051967127, 833.2001278772386, 833.8540755367817, 833.9374546908975, 876.0363600039968, 878.9824203515926, 878.9912100879005, 880.5377176982072, 881.9250363719092, 705.4497491956282, 837.9036410812773, 859.6948083430354, 865.519636601689, 867.7396780965717, 632.8829166604193, 634.0109429290322, 634.0742515926753, 636.8885445047098, 638.543441439373, 12085.93957030218, 12090.758184836342, 12116.09129315305, 12125.514979400814, 12136.575219867262, 12438.626841194779, 12933.353332333345, 12986.09097363185, 13056.477740890354, 13228.801567976489, 10635.0, 10874.510647020903, 10907.83638245427, 10970.725731856688, 11072.224944253905, 4087.264292427362, 4133.338665813455, 4210.136921930997, 4245.363195520666, 4283.892902677427, 51575.74212128953, 52329.215061774106, 54621.453785462036, 54656.45343546553, 55214.447855521736, 10023.599056037823, 10311.0, 10356.585736570452, 10499.947500262602, 10531.262811603114, 17721.29114835392, 18679.87920724761, 18746.812531874508, 18764.24943002292, 18810.717839232424, 7009.1589009319205, 7060.894086588705, 7065.399441047466, 7246.0, 7699.422543309274, 4076.3885417187657, 4089.959100408958, 4098.549159592442, 4144.5026596808575, 4213.0, 3129.155128115396, 3229.757768167397, 3236.336551007038, 3247.6589958054537, 3254.153919980822, 597.5757212379259, 603.9547033972469, 604.7490291529055, 613.4448324266546, 625.2746813696182, 538.0557122250425, 581.9388964158787, 589.9734511946973, 602.5330368964088, 632.9556931014785, 8479.236868681848, 8489.915100848912, 8519.829603407898, 8545.188207120314, 8659.263962563253, 610.3926593039954, 648.0508928040539, 650.3658932540735, 656.8522082531488, 662.4634046422414, 3939.0, 3965.7025723070883, 4003.799810009546, 4024.8188831502653, 4041.959580404217, 63479.36520634734, 64088.67955660192, 64702.0, 65064.67467662632, 65130.674346627966, 57177.0, 58104.70947645235, 58109.0, 58444.70777646085, 59063.11405328924, 53451.198232025774, 53671.46328536665, 53764.73117634387, 54139.45860541344, 54316.0, 7819.726309579365, 7973.282404583615, 8000.679972801023, 8001.119876813662, 8251.257386835214, 32580.51129233016, 32964.1758956028, 33082.50376244407, 33371.49942750812, 33585.83207083949, 42011.36982945319, 43972.34041489444, 45800.312995305765, 46222.30666540072, 47555.76222119006, 9426.057394260519, 9484.573194206416, 9659.758506037406, 9910.10809027191, 10013.449260290463, 8759.956200219212, 10862.837057444303, 11284.887151128383, 11296.43517824122, 11395.259308144945, 11763.0, 11902.345371004678, 12012.879871201525, 12107.152499324962, 12135.089868260093, 11713.121515886172, 11886.524539018343, 12022.519099236282, 12055.336956467478, 12172.208806427554, 11880.821787673365, 11936.462859171184, 12110.515579376726, 12146.817797733218, 12253.326067066397, 10183.84724229152, 10262.138814417576, 10314.896851031393, 10495.947520262349, 10667.413292269, 10083.949580252052, 10528.0, 10531.526081326205, 10534.262601617813, 10614.575416983234], "value": 6345.358849217829, "unit": "score"}], "name": "dromaeo_css", "value": 6865.547944111335, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 107.0, 116.0, 111.0, 111.0, 113.0, 112.0, 111.0, 113.0, 112.0], "value": 111.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 134.0, 157.0, 209.0, 134.0, 156.0, 152.0, 133.0, 186.0, 132.0], "value": 154.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 160.0, 161.0, 161.0, 163.0, 163.0, 163.0, 161.0, 163.0], "value": 161.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 77.0, 77.0, 150.0, 78.0, 78.0, 78.0, 76.0, 130.0, 77.0], "value": 89.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 146.0, 93.0, 93.0, 93.0, 121.0, 94.0, 93.0, 122.0], "value": 104.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 119.0, 118.0, 118.0, 117.0, 117.0, 117.0, 118.0, 119.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 149.0, 147.0, 148.0, 148.0, 147.0, 148.0, 146.0, 148.0], "value": 147.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 96.0, 97.0, 97.0, 97.0, 96.0, 97.0, 95.0], "value": 96.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 63.0, 62.0, 62.0, 62.0, 61.0, 115.0, 58.0, 59.0], "value": 66.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 59.0, 59.0, 59.0, 59.0, 59.0, 59.0, 58.0, 59.0], "value": 58.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 80.0, 86.0, 81.0, 85.0, 82.0, 88.0, 86.0, 82.0, 82.0], "value": 83.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 132.0, 137.0, 138.0, 130.0, 132.0, 139.0, 134.0, 268.0, 155.0], "value": 149.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 171.0, 172.0, 175.0, 175.0, 173.0, 173.0, 179.0, 174.0, 171.0], "value": 173.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 68.0, 72.0, 67.0, 70.0, 66.0, 67.0, 66.0, 67.0, 69.0], "value": 68.3, "unit": "score"}], "name": "kraken", "value": 1584.8999999999999, "alertThreshold": 2.0}]} 14:38:55 INFO - Return code: 0 14:38:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 14:38:55 ERROR - # TBPL SUCCESS # 14:38:55 INFO - Running post-action listener: _resource_record_post_action 14:38:55 INFO - ##### 14:38:55 INFO - ##### Finished run-tests step (success) 14:38:55 INFO - ##### 14:38:55 INFO - Running post-run listener: _resource_record_post_run 14:38:56 INFO - Total resource usage - Wall time: 1190s; CPU: 25.0%; Read bytes: 4096; Write bytes: 544100352; Read time: 12; Write time: 569240 14:38:56 INFO - install - Wall time: 17s; CPU: 27.0%; Read bytes: 0; Write bytes: 248807424; Read time: 0; Write time: 318412 14:38:56 INFO - run-tests - Wall time: 1174s; CPU: 25.0%; Read bytes: 4096; Write bytes: 295292928; Read time: 12; Write time: 250828 14:38:56 INFO - Running post-run listener: _upload_blobber_files 14:38:56 INFO - Blob upload gear active. 14:38:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:38:56 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 14:38:56 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:38:56 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:38:56 INFO - (blobuploader) - INFO - Open directory for files ... 14:38:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:38:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:38:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:38:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:38:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:38:57 INFO - (blobuploader) - INFO - Done attempting. 14:38:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:38:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:38:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:38:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:38:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:38:58 INFO - (blobuploader) - INFO - Done attempting. 14:38:58 INFO - (blobuploader) - INFO - Iteration through files over. 14:38:58 INFO - Return code: 0 14:38:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:38:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:38:58 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9b24e95c83b12b0190d40d4fd423d39914471ec08d7c237599bf878fefe5656f28dd4c0697da4483099485fc18bc7653a08be857bc68335e34ac40248863e7d7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a7d49920672eb483ef1b25a86dc0f501b63a1944f67d03ef8324f72d830186dbf4b4affe3cf05250f49547c226cf62f9fdd04fa951ca94eadb6fc499ace4ff42"} 14:38:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:38:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:38:58 INFO - Contents: 14:38:58 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9b24e95c83b12b0190d40d4fd423d39914471ec08d7c237599bf878fefe5656f28dd4c0697da4483099485fc18bc7653a08be857bc68335e34ac40248863e7d7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a7d49920672eb483ef1b25a86dc0f501b63a1944f67d03ef8324f72d830186dbf4b4affe3cf05250f49547c226cf62f9fdd04fa951ca94eadb6fc499ace4ff42"} 14:38:58 INFO - Running post-run listener: copy_logs_to_upload_dir 14:38:58 INFO - Copying logs to upload dir... 14:38:58 INFO - mkdir: /builds/slave/test/build/upload/logs 14:38:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1226.724953 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 26 secs) (at 2016-05-11 14:38:58.123666) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-11 14:38:58.126916) ========= 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=232498196343f89f466a4a9a000001c8-1463001510.561049-609160901 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9b24e95c83b12b0190d40d4fd423d39914471ec08d7c237599bf878fefe5656f28dd4c0697da4483099485fc18bc7653a08be857bc68335e34ac40248863e7d7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a7d49920672eb483ef1b25a86dc0f501b63a1944f67d03ef8324f72d830186dbf4b4affe3cf05250f49547c226cf62f9fdd04fa951ca94eadb6fc499ace4ff42"} build_url:https://queue.taskcluster.net/v1/task/NZG4cLBdT5Sfc2N9UbPUOA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.005480 build_url: 'https://queue.taskcluster.net/v1/task/NZG4cLBdT5Sfc2N9UbPUOA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9b24e95c83b12b0190d40d4fd423d39914471ec08d7c237599bf878fefe5656f28dd4c0697da4483099485fc18bc7653a08be857bc68335e34ac40248863e7d7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a7d49920672eb483ef1b25a86dc0f501b63a1944f67d03ef8324f72d830186dbf4b4affe3cf05250f49547c226cf62f9fdd04fa951ca94eadb6fc499ace4ff42"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-11 14:38:58.140611) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 14:38:58.140899) ========= 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=232498196343f89f466a4a9a000001c8-1463001510.561049-609160901 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.002159 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 14:38:58.221457) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-11 14:38:58.221876) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-11 14:38:58.222195) ========= ========= Total master_lag: 0.14 =========