builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-021 starttime: 1463001445.06 results: success (0) buildid: 20160511113038 builduid: 2fdd31845b8c47a4b3ce4fe60afdb39d revision: 45daaf6edeae80ec8c67da50fa1d31f4a1b1a454 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-11 14:17:25.064163) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-11 14:17:25.064753) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-11 14:17:25.065060) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-11 14:17:25.082190) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 14:17:25.082517) ========= 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=df17445c3590ff7897617a0e00000225-1463001443.698483-1944011536 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-11 14:17:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.2M=0s 2016-05-11 14:17:25 (43.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.218929 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 14:17:25.331264) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 14:17:25.331616) ========= 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=df17445c3590ff7897617a0e00000225-1463001443.698483-1944011536 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.096024 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 14:17:25.438730) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-11 14:17:25.439098) ========= 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=df17445c3590ff7897617a0e00000225-1463001443.698483-1944011536 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-11 14:17:25,488 truncating revision to first 12 chars 2016-05-11 14:17:25,488 Setting DEBUG logging. 2016-05-11 14:17:25,488 attempt 1/10 2016-05-11 14:17:25,488 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:17:26,263 unpacking tar archive at: fx-team-45daaf6edeae/testing/mozharness/ program finished with exit code 0 elapsedTime=1.039324 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-11 14:17:26.491348) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-11 14:17:26.491723) ========= script_repo_revision: 45daaf6edeae80ec8c67da50fa1d31f4a1b1a454 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-11 14:17:26.492163) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-11 14:17:26.492440) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-11 14:17:26.501571) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2016-05-11 14:17:26.502053) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=df17445c3590ff7897617a0e00000225-1463001443.698483-1944011536 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:17:26 INFO - MultiFileLogger online at 20160511 14:17:26 in /builds/slave/test 14:17:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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:17:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:17:26 INFO - {'append_to_log': False, 14:17:26 INFO - 'base_work_dir': '/builds/slave/test', 14:17:26 INFO - 'blob_upload_branch': 'Fx-Team', 14:17:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:17:26 INFO - 'branch': 'Fx-Team', 14:17:26 INFO - 'buildbot_json_path': 'buildprops.json', 14:17:26 INFO - 'config_files': ('talos/linux_config.py',), 14:17:26 INFO - 'default_actions': ('clobber', 14:17:26 INFO - 'read-buildbot-config', 14:17:26 INFO - 'download-and-extract', 14:17:26 INFO - 'populate-webroot', 14:17:26 INFO - 'create-virtualenv', 14:17:26 INFO - 'install', 14:17:26 INFO - 'run-tests'), 14:17:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:17:26 INFO - 'download_minidump_stackwalk': True, 14:17:26 INFO - 'download_symbols': 'ondemand', 14:17:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:17:26 INFO - 'tooltool.py': '/tools/tooltool.py', 14:17:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:17:26 INFO - '/tools/misc-python/virtualenv.py')}, 14:17:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:17:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:17:26 INFO - 'installer_path': 'installer.exe', 14:17:26 INFO - 'log_level': 'info', 14:17:26 INFO - 'log_name': 'talos', 14:17:26 INFO - 'log_to_console': True, 14:17:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:17:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:17:26 INFO - 'opt_config_files': (), 14:17:26 INFO - 'pip_index': False, 14:17:26 INFO - 'sps_profile': False, 14:17:26 INFO - 'sps_profile_interval': 0, 14:17:26 INFO - 'suite': 'dromaeojs-e10s', 14:17:26 INFO - 'system_bits': '32', 14:17:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:17:26 INFO - 'title': 'talos-linux64-ix-021', 14:17:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:17:26 INFO - 'use_talos_json': True, 14:17:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:17:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:17:26 INFO - 'work_dir': 'build'} 14:17:26 INFO - ##### 14:17:26 INFO - ##### Running clobber step. 14:17:26 INFO - ##### 14:17:26 INFO - Running pre-action listener: _resource_record_pre_action 14:17:26 INFO - Running main action method: clobber 14:17:26 INFO - rmtree: /builds/slave/test/build 14:17:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:17:27 INFO - Running post-action listener: _resource_record_post_action 14:17:27 INFO - ##### 14:17:27 INFO - ##### Finished clobber step (success) 14:17:27 INFO - ##### 14:17:27 INFO - ##### 14:17:27 INFO - ##### Running read-buildbot-config step. 14:17:27 INFO - ##### 14:17:27 INFO - Running pre-action listener: _resource_record_pre_action 14:17:27 INFO - Running main action method: read_buildbot_config 14:17:27 INFO - Using buildbot properties: 14:17:27 INFO - { 14:17:27 INFO - "project": "", 14:17:27 INFO - "product": "firefox", 14:17:27 INFO - "script_repo_revision": "production", 14:17:27 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 14:17:27 INFO - "repository": "", 14:17:27 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 14:17:27 INFO - "buildid": "20160511113038", 14:17:27 INFO - "pgo_build": "True", 14:17:27 INFO - "basedir": "/builds/slave/test", 14:17:27 INFO - "buildnumber": 316, 14:17:27 INFO - "slavename": "talos-linux64-ix-021", 14:17:27 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 14:17:27 INFO - "platform": "ubuntu64_hw", 14:17:27 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 14:17:27 INFO - "branch": "fx-team", 14:17:27 INFO - "repo_path": "integration/fx-team", 14:17:27 INFO - "revision": "45daaf6edeae80ec8c67da50fa1d31f4a1b1a454", 14:17:27 INFO - "stage_platform": "linux64-pgo", 14:17:27 INFO - "builduid": "2fdd31845b8c47a4b3ce4fe60afdb39d", 14:17:27 INFO - "slavebuilddir": "test" 14:17:27 INFO - } 14:17:27 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:17:27 INFO - Running post-action listener: _resource_record_post_action 14:17:27 INFO - ##### 14:17:27 INFO - ##### Finished read-buildbot-config step (success) 14:17:27 INFO - ##### 14:17:27 INFO - ##### 14:17:27 INFO - ##### Running download-and-extract step. 14:17:27 INFO - ##### 14:17:27 INFO - Running pre-action listener: _resource_record_pre_action 14:17:27 INFO - Running main action method: download_and_extract 14:17:27 INFO - mkdir: /builds/slave/test/build/tests 14:17:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:17:27 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:17:27 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:17:27 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:17:27 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:17:27 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:17:29 INFO - Downloaded 1361 bytes. 14:17:29 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 14:17:29 INFO - Using the following test package requirements: 14:17:29 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 14:17:29 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:17:29 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:17:29 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:17:29 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:17:29 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:17:29 INFO - u'jsshell-linux-x86_64.zip'], 14:17:29 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:17:29 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:17:29 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 14:17:29 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:17:29 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:17:29 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:17:29 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:17:29 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:17:29 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:17:29 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:17:29 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:17:29 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:17:29 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:17:29 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:17:29 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:17:29 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:17:29 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:17:29 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:17:30 INFO - Downloaded 23902892 bytes. 14:17:30 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:17:30 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:17:31 INFO - Return code: 0 14:17:31 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:17:31 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:17:31 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:17:31 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:17:31 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:17:31 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:17:31 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:17:33 INFO - Downloaded 23902892 bytes. 14:17:33 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:17:33 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:17:42 INFO - Return code: 0 14:17:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:17:42 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:17:42 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:17:42 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:17:42 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:17:42 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:17:43 INFO - Downloaded 10840152 bytes. 14:17:43 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:17:43 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:17:43 INFO - Return code: 0 14:17:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:17:43 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:17:43 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:17:43 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:17:43 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:17:43 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:17:45 INFO - Downloaded 58340981 bytes. 14:17:46 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:17:46 INFO - mkdir: /builds/slave/test/properties 14:17:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:17:46 INFO - Writing to file /builds/slave/test/properties/build_url 14:17:46 INFO - Contents: 14:17:46 INFO - build_url:https://queue.taskcluster.net/v1/task/NZG4cLBdT5Sfc2N9UbPUOA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:17:47 INFO - Running post-action listener: _resource_record_post_action 14:17:47 INFO - Running post-action listener: set_extra_try_arguments 14:17:47 INFO - ##### 14:17:47 INFO - ##### Finished download-and-extract step (success) 14:17:47 INFO - ##### 14:17:47 INFO - ##### 14:17:47 INFO - ##### Running populate-webroot step. 14:17:47 INFO - ##### 14:17:47 INFO - Running pre-action listener: _resource_record_pre_action 14:17:47 INFO - Running main action method: populate_webroot 14:17:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:17:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:17:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:17:47 INFO - '--tppagecycles', 14:17:47 INFO - '7'], 14:17:47 INFO - 'tests': ['tsvgm']}}, 14:17:47 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:17:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:17:47 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:17:47 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:17:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:17:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:17:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:17:47 INFO - 'talos_options': ['--disable-e10s'], 14:17:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:17:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:17:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:17:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:17:47 INFO - 'talos_options': ['--disable-e10s'], 14:17:47 INFO - 'tests': ['damp', 'tps']}, 14:17:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:17:47 INFO - 'tests': ['damp', 'tps']}, 14:17:47 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:17:47 INFO - 'tests': ['dromaeo_dom']}, 14:17:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:17:47 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:17:47 INFO - 'tests': ['a11yr', 14:17:47 INFO - 'ts_paint', 14:17:47 INFO - 'tpaint', 14:17:47 INFO - 'sessionrestore', 14:17:47 INFO - 'sessionrestore_no_auto_restore', 14:17:47 INFO - 'tabpaint']}, 14:17:47 INFO - 'other-e10s': {'tests': ['a11yr', 14:17:47 INFO - 'ts_paint', 14:17:47 INFO - 'tpaint', 14:17:47 INFO - 'sessionrestore', 14:17:47 INFO - 'sessionrestore_no_auto_restore', 14:17:47 INFO - 'tabpaint']}, 14:17:47 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:17:47 INFO - 'ts_paint', 14:17:47 INFO - 'tpaint', 14:17:47 INFO - 'sessionrestore', 14:17:47 INFO - 'sessionrestore_no_auto_restore', 14:17:47 INFO - 'tabpaint']}, 14:17:47 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:17:47 INFO - 'ts_paint', 14:17:47 INFO - 'tpaint', 14:17:47 INFO - 'sessionrestore', 14:17:47 INFO - 'sessionrestore_no_auto_restore', 14:17:47 INFO - 'tabpaint']}, 14:17:47 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:17:47 INFO - 'tests': ['a11yr', 14:17:47 INFO - 'ts_paint', 14:17:47 INFO - 'tpaint', 14:17:47 INFO - 'sessionrestore', 14:17:47 INFO - 'sessionrestore_no_auto_restore', 14:17:47 INFO - 'tabpaint']}, 14:17:47 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:17:47 INFO - 'tests': ['a11yr', 14:17:47 INFO - 'ts_paint', 14:17:47 INFO - 'tpaint', 14:17:47 INFO - 'sessionrestore', 14:17:47 INFO - 'sessionrestore_no_auto_restore', 14:17:47 INFO - 'tabpaint']}, 14:17:47 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:17:47 INFO - 'tests': ['tsvgx', 14:17:47 INFO - 'tsvgr_opacity', 14:17:47 INFO - 'tart', 14:17:47 INFO - 'tscrollx', 14:17:47 INFO - 'cart']}, 14:17:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:17:47 INFO - 'tsvgr_opacity', 14:17:47 INFO - 'tart', 14:17:47 INFO - 'tscrollx', 14:17:47 INFO - 'cart']}, 14:17:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:17:47 INFO - 'talos_options': ['--disable-e10s'], 14:17:47 INFO - 'tests': ['tp5o']}, 14:17:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:17:47 INFO - 'tests': ['tp5o']}, 14:17:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:17:47 INFO - 'talos_options': ['--disable-e10s', 14:17:47 INFO - '--xperf_path', 14:17:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:17:47 INFO - 'tests': ['tp5n']}, 14:17:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:17:47 INFO - 'talos_options': ['--xperf_path', 14:17:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:17:47 INFO - 'tests': ['tp5n']}}, 14:17:47 INFO - 'talos.zip': {'path': '', 14:17:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:17:47 INFO - Running post-action listener: _resource_record_post_action 14:17:47 INFO - ##### 14:17:47 INFO - ##### Finished populate-webroot step (success) 14:17:47 INFO - ##### 14:17:47 INFO - ##### 14:17:47 INFO - ##### Running create-virtualenv step. 14:17:47 INFO - ##### 14:17:47 INFO - Running pre-action listener: _resource_record_pre_action 14:17:47 INFO - Running main action method: create_virtualenv 14:17:47 INFO - Creating virtualenv /builds/slave/test/build/venv 14:17:47 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 14:17:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:17:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:17:47 INFO - Using real prefix '/usr' 14:17:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:17:49 INFO - Installing distribute.............................................................................................................................................................................................done. 14:17:52 INFO - Installing pip.................done. 14:17:52 INFO - Return code: 0 14:17:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:17: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:17:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:17:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17: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:17:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:17:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6cc6ab9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x228c770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231b9c0>, '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 0x231c8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x231cd50>, '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': 'df17445c3590ff7897617a0e00000225-1463001443.698483-1944011536', '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:17:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:17:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:17:52 INFO - Using env: {'DISPLAY': ':0', 14:17:52 INFO - 'HOME': '/home/cltbld', 14:17:52 INFO - 'LANG': 'en_US.UTF-8', 14:17:52 INFO - 'LANGUAGE': 'en_US:en', 14:17:52 INFO - 'LOGNAME': 'cltbld', 14:17:52 INFO - 'MAIL': '/var/mail/cltbld', 14:17:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:17:52 INFO - 'MOZ_NO_REMOTE': '1', 14:17:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:17:52 INFO - 'NO_EM_RESTART': '1', 14:17:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:17:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:17:52 INFO - 'PWD': '/builds/slave/test', 14:17:52 INFO - 'SHELL': '/bin/bash', 14:17:52 INFO - 'SHLVL': '1', 14:17:52 INFO - 'TERM': 'linux', 14:17:52 INFO - 'TMOUT': '86400', 14:17:52 INFO - 'USER': 'cltbld', 14:17:52 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1463001443.698483-1944011536', 14:17:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:17:52 INFO - '_': '/tools/buildbot/bin/python'} 14:17:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:17:53 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:17:53 INFO - Cleaning up... 14:17:53 INFO - Return code: 0 14:17:53 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 14:17:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:17:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:17:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:17:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:17:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:53 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 0x7f6cc6ab9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x228c770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231b9c0>, '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 0x231c8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x231cd50>, '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': 'df17445c3590ff7897617a0e00000225-1463001443.698483-1944011536', '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:17:53 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:17:53 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:17:53 INFO - Using env: {'DISPLAY': ':0', 14:17:53 INFO - 'HOME': '/home/cltbld', 14:17:53 INFO - 'LANG': 'en_US.UTF-8', 14:17:53 INFO - 'LANGUAGE': 'en_US:en', 14:17:53 INFO - 'LOGNAME': 'cltbld', 14:17:53 INFO - 'MAIL': '/var/mail/cltbld', 14:17:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:17:53 INFO - 'MOZ_NO_REMOTE': '1', 14:17:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:17:53 INFO - 'NO_EM_RESTART': '1', 14:17:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:17:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:17:53 INFO - 'PWD': '/builds/slave/test', 14:17:53 INFO - 'SHELL': '/bin/bash', 14:17:53 INFO - 'SHLVL': '1', 14:17:53 INFO - 'TERM': 'linux', 14:17:53 INFO - 'TMOUT': '86400', 14:17:53 INFO - 'USER': 'cltbld', 14:17:53 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1463001443.698483-1944011536', 14:17:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:17:53 INFO - '_': '/tools/buildbot/bin/python'} 14:17:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:17:53 INFO - Downloading/unpacking psutil>=0.7.1 14:17:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:17:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:17:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:17:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:17:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:17:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:17:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:17:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:17:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:17:55 INFO - Installing collected packages: psutil 14:17:55 INFO - Running setup.py install for psutil 14:17:55 INFO - building 'psutil._psutil_linux' extension 14:17:55 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:17:57 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:17:57 INFO - building 'psutil._psutil_posix' extension 14:17:57 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:17:57 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:17:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:17:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:17:58 INFO - Successfully installed psutil 14:17:58 INFO - Cleaning up... 14:17:58 INFO - Return code: 0 14:17:58 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 14:17:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:17:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:17:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:17:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:17:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f6cc6ab9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x228c770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231b9c0>, '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 0x231c8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x231cd50>, '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': 'df17445c3590ff7897617a0e00000225-1463001443.698483-1944011536', '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:17:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 14:17:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 14:17:58 INFO - Using env: {'DISPLAY': ':0', 14:17:58 INFO - 'HOME': '/home/cltbld', 14:17:58 INFO - 'LANG': 'en_US.UTF-8', 14:17:58 INFO - 'LANGUAGE': 'en_US:en', 14:17:58 INFO - 'LOGNAME': 'cltbld', 14:17:58 INFO - 'MAIL': '/var/mail/cltbld', 14:17:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:17:58 INFO - 'MOZ_NO_REMOTE': '1', 14:17:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:17:58 INFO - 'NO_EM_RESTART': '1', 14:17:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:17:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:17:58 INFO - 'PWD': '/builds/slave/test', 14:17:58 INFO - 'SHELL': '/bin/bash', 14:17:58 INFO - 'SHLVL': '1', 14:17:58 INFO - 'TERM': 'linux', 14:17:58 INFO - 'TMOUT': '86400', 14:17:58 INFO - 'USER': 'cltbld', 14:17:58 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1463001443.698483-1944011536', 14:17:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:17:58 INFO - '_': '/tools/buildbot/bin/python'} 14:17:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:17:58 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:17:58 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:17:58 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:17:58 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:17:58 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:17:58 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:17:58 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:01 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:18:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:18:01 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:01 INFO - Installing collected packages: mozsystemmonitor 14:18:01 INFO - Running setup.py install for mozsystemmonitor 14:18:01 INFO - Successfully installed mozsystemmonitor 14:18:01 INFO - Cleaning up... 14:18:01 INFO - Return code: 0 14:18:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:18: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:18:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:18:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18: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:18:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:18:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18: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', '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 0x7f6cc6ab9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x228c770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231b9c0>, '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 0x231c8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x231cd50>, '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': 'df17445c3590ff7897617a0e00000225-1463001443.698483-1944011536', '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: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:18: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 blobuploader==1.2.4 14:18:01 INFO - Using env: {'DISPLAY': ':0', 14:18:01 INFO - 'HOME': '/home/cltbld', 14:18:01 INFO - 'LANG': 'en_US.UTF-8', 14:18:01 INFO - 'LANGUAGE': 'en_US:en', 14:18:01 INFO - 'LOGNAME': 'cltbld', 14:18:01 INFO - 'MAIL': '/var/mail/cltbld', 14:18:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:01 INFO - 'MOZ_NO_REMOTE': '1', 14:18:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:18:01 INFO - 'NO_EM_RESTART': '1', 14:18:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:18:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:18:01 INFO - 'PWD': '/builds/slave/test', 14:18:01 INFO - 'SHELL': '/bin/bash', 14:18:01 INFO - 'SHLVL': '1', 14:18:01 INFO - 'TERM': 'linux', 14:18:01 INFO - 'TMOUT': '86400', 14:18:01 INFO - 'USER': 'cltbld', 14:18:01 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1463001443.698483-1944011536', 14:18:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:01 INFO - '_': '/tools/buildbot/bin/python'} 14:18:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:18:01 INFO - Downloading/unpacking blobuploader==1.2.4 14:18: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:18: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:18: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:18: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:18: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:18: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:18:03 INFO - Downloading blobuploader-1.2.4.tar.gz 14:18:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:18:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:18: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:18: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:18: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:18: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:18: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:18: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:18:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:18:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:18: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:18: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:18: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:18: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:18: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:18: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:18:04 INFO - Downloading docopt-0.6.1.tar.gz 14:18:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:18:04 INFO - Installing collected packages: blobuploader, requests, docopt 14:18:04 INFO - Running setup.py install for blobuploader 14:18:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:18:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:18:04 INFO - Running setup.py install for requests 14:18:04 INFO - Running setup.py install for docopt 14:18:04 INFO - Successfully installed blobuploader requests docopt 14:18:04 INFO - Cleaning up... 14:18:04 INFO - Return code: 0 14:18:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:18:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:18:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:18:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:18:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:18:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:04 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 0x7f6cc6ab9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x228c770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231b9c0>, '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 0x231c8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x231cd50>, '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': 'df17445c3590ff7897617a0e00000225-1463001443.698483-1944011536', '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:04 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:04 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:04 INFO - Using env: {'DISPLAY': ':0', 14:18:04 INFO - 'HOME': '/home/cltbld', 14:18:04 INFO - 'LANG': 'en_US.UTF-8', 14:18:04 INFO - 'LANGUAGE': 'en_US:en', 14:18:04 INFO - 'LOGNAME': 'cltbld', 14:18:04 INFO - 'MAIL': '/var/mail/cltbld', 14:18:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:04 INFO - 'MOZ_NO_REMOTE': '1', 14:18:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:18:04 INFO - 'NO_EM_RESTART': '1', 14:18:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:18:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:18:04 INFO - 'PWD': '/builds/slave/test', 14:18:04 INFO - 'SHELL': '/bin/bash', 14:18:04 INFO - 'SHLVL': '1', 14:18:04 INFO - 'TERM': 'linux', 14:18:04 INFO - 'TMOUT': '86400', 14:18:04 INFO - 'USER': 'cltbld', 14:18:04 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1463001443.698483-1944011536', 14:18:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:04 INFO - '_': '/tools/buildbot/bin/python'} 14:18:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:18:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:18:05 INFO - Running setup.py (path:/tmp/pip-HBBi8B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:18:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:18:05 INFO - Running setup.py (path:/tmp/pip-CEjnuG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:18:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:18:05 INFO - Running setup.py (path:/tmp/pip-q761OI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:18:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:18:05 INFO - Running setup.py (path:/tmp/pip-qbE7UU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:18:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:18:05 INFO - Running setup.py (path:/tmp/pip-JGIAdz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:18:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:18:05 INFO - Running setup.py (path:/tmp/pip-imz3Zq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:18:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:18:05 INFO - Running setup.py (path:/tmp/pip-EES25D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:18:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:18:05 INFO - Running setup.py (path:/tmp/pip-kUw9cE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:18:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:18:05 INFO - Running setup.py (path:/tmp/pip-hqmP0n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:18:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:18:05 INFO - Running setup.py (path:/tmp/pip-Mf9gjm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:18:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:18:05 INFO - Running setup.py (path:/tmp/pip-MBpZOO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:18:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:18:05 INFO - Running setup.py (path:/tmp/pip-Ot3XEt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:18:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:18:05 INFO - Running setup.py (path:/tmp/pip-quzIn0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:18:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:18:06 INFO - Running setup.py (path:/tmp/pip-B3MteN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:18:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:18:06 INFO - Running setup.py (path:/tmp/pip-l1iQb0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:18:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:18:06 INFO - Running setup.py (path:/tmp/pip-xfRBoI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:18:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:18:06 INFO - Running setup.py (path:/tmp/pip-OdaXdU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:18:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:18:06 INFO - Running setup.py install for manifestparser 14:18:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:18:06 INFO - Running setup.py install for mozcrash 14:18:06 INFO - Running setup.py install for mozdebug 14:18:06 INFO - Running setup.py install for mozdevice 14:18:06 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:18:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:18:06 INFO - Running setup.py install for mozfile 14:18:06 INFO - Running setup.py install for mozhttpd 14:18:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:18:06 INFO - Running setup.py install for mozinfo 14:18:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:18:07 INFO - Running setup.py install for mozInstall 14:18:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:18:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:18:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:18:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:18:07 INFO - Running setup.py install for mozleak 14:18:07 INFO - Running setup.py install for mozlog 14:18:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:18:07 INFO - Running setup.py install for moznetwork 14:18:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:18:07 INFO - Running setup.py install for mozprocess 14:18:07 INFO - Running setup.py install for mozprofile 14:18:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:18:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:18:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:18:07 INFO - Running setup.py install for mozrunner 14:18:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:18:07 INFO - Running setup.py install for mozscreenshot 14:18:07 INFO - Running setup.py install for moztest 14:18:07 INFO - Running setup.py install for mozversion 14:18:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:18:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:18:08 INFO - Cleaning up... 14:18:08 INFO - Return code: 0 14:18:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:18:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:18:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:18:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:18:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:18:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6cc6ab9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x228c770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231b9c0>, '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 0x231c8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x231cd50>, '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': 'df17445c3590ff7897617a0e00000225-1463001443.698483-1944011536', '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:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:18:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:18:08 INFO - Using env: {'DISPLAY': ':0', 14:18:08 INFO - 'HOME': '/home/cltbld', 14:18:08 INFO - 'LANG': 'en_US.UTF-8', 14:18:08 INFO - 'LANGUAGE': 'en_US:en', 14:18:08 INFO - 'LOGNAME': 'cltbld', 14:18:08 INFO - 'MAIL': '/var/mail/cltbld', 14:18:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:08 INFO - 'MOZ_NO_REMOTE': '1', 14:18:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:18:08 INFO - 'NO_EM_RESTART': '1', 14:18:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:18:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:18:08 INFO - 'PWD': '/builds/slave/test', 14:18:08 INFO - 'SHELL': '/bin/bash', 14:18:08 INFO - 'SHLVL': '1', 14:18:08 INFO - 'TERM': 'linux', 14:18:08 INFO - 'TMOUT': '86400', 14:18:08 INFO - 'USER': 'cltbld', 14:18:08 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1463001443.698483-1944011536', 14:18:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:08 INFO - '_': '/tools/buildbot/bin/python'} 14:18:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:18:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:18:08 INFO - Running setup.py (path:/tmp/pip-D0moOp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:18:08 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:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:18:08 INFO - Running setup.py (path:/tmp/pip-calU5D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:18:08 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:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:18:08 INFO - Running setup.py (path:/tmp/pip-U6Ae6F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:18:08 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:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:18:08 INFO - Running setup.py (path:/tmp/pip-OmMXqL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:18:08 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:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:18:08 INFO - Running setup.py (path:/tmp/pip-l7O1QF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:18:08 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:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:18:08 INFO - Running setup.py (path:/tmp/pip-rKikIv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:18:08 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:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:18:08 INFO - Running setup.py (path:/tmp/pip-RdVWjE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:18:08 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:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:18:08 INFO - Running setup.py (path:/tmp/pip-0tkYgW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:18:08 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:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:18:08 INFO - Running setup.py (path:/tmp/pip-FUXMmA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:18:08 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:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:18:08 INFO - Running setup.py (path:/tmp/pip-xUE1sf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:18:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:18:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:18:09 INFO - Running setup.py (path:/tmp/pip-4Ex8W4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:18:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 14:18:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:18:09 INFO - Running setup.py (path:/tmp/pip-tCgPvU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:18:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 14:18:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:18:09 INFO - Running setup.py (path:/tmp/pip-DwMXD5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:18:09 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:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:18:09 INFO - Running setup.py (path:/tmp/pip-rKgAR4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:18:09 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:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:18:09 INFO - Running setup.py (path:/tmp/pip-tAwT5a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:18:09 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:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:18:09 INFO - Running setup.py (path:/tmp/pip-yPPCSR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:18:09 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:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:18:09 INFO - Running setup.py (path:/tmp/pip-mMUs82-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:18:09 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:09 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:09 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:09 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:09 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:09 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:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:18:09 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:09 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:09 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:09 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:09 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:09 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:11 INFO - Downloading blessings-1.6.tar.gz 14:18:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:18:11 INFO - Installing collected packages: blessings 14:18:11 INFO - Running setup.py install for blessings 14:18:11 INFO - Successfully installed blessings 14:18:11 INFO - Cleaning up... 14:18:11 INFO - Return code: 0 14:18:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:18:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:18:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:18:11 INFO - Reading from file tmpfile_stdout 14:18:11 INFO - Current package versions: 14:18:11 INFO - argparse == 1.2.1 14:18:11 INFO - blessings == 1.6 14:18:11 INFO - blobuploader == 1.2.4 14:18:11 INFO - docopt == 0.6.1 14:18:11 INFO - manifestparser == 1.1 14:18:11 INFO - mozInstall == 1.12 14:18:11 INFO - mozcrash == 0.17 14:18:11 INFO - mozdebug == 0.1 14:18:11 INFO - mozdevice == 0.48 14:18:11 INFO - mozfile == 1.2 14:18:11 INFO - mozhttpd == 0.7 14:18:11 INFO - mozinfo == 0.9 14:18:11 INFO - mozleak == 0.1 14:18:11 INFO - mozlog == 3.1 14:18:11 INFO - moznetwork == 0.27 14:18:11 INFO - mozprocess == 0.22 14:18:11 INFO - mozprofile == 0.28 14:18:11 INFO - mozrunner == 6.11 14:18:11 INFO - mozscreenshot == 0.1 14:18:11 INFO - mozsystemmonitor == 0.0 14:18:11 INFO - moztest == 0.7 14:18:11 INFO - mozversion == 1.4 14:18:11 INFO - psutil == 3.1.1 14:18:11 INFO - requests == 1.2.3 14:18:11 INFO - wsgiref == 0.1.2 14:18:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:18:11 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:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:18:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:11 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:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:18:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:11 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 0x7f6cc6ab9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x228c770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231b9c0>, '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 0x231c8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x231cd50>, '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': 'df17445c3590ff7897617a0e00000225-1463001443.698483-1944011536', '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:11 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:11 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:11 INFO - Using env: {'DISPLAY': ':0', 14:18:11 INFO - 'HOME': '/home/cltbld', 14:18:11 INFO - 'LANG': 'en_US.UTF-8', 14:18:11 INFO - 'LANGUAGE': 'en_US:en', 14:18:11 INFO - 'LOGNAME': 'cltbld', 14:18:11 INFO - 'MAIL': '/var/mail/cltbld', 14:18:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:11 INFO - 'MOZ_NO_REMOTE': '1', 14:18:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:18:11 INFO - 'NO_EM_RESTART': '1', 14:18:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:18:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:18:11 INFO - 'PWD': '/builds/slave/test', 14:18:11 INFO - 'SHELL': '/bin/bash', 14:18:11 INFO - 'SHLVL': '1', 14:18:11 INFO - 'TERM': 'linux', 14:18:11 INFO - 'TMOUT': '86400', 14:18:11 INFO - 'USER': 'cltbld', 14:18:11 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1463001443.698483-1944011536', 14:18:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:11 INFO - '_': '/tools/buildbot/bin/python'} 14:18:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:18:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:18:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 14:18:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 14:18:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:18:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 14:18:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 14:18:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 14:18:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 14:18:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 14:18:12 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:18:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:18:12 INFO - Cleaning up... 14:18:12 INFO - Return code: 0 14:18:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:18:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:18:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:18:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:18:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:18:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6cc6ab9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x228c770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231b9c0>, '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 0x231c8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x231cd50>, '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': 'df17445c3590ff7897617a0e00000225-1463001443.698483-1944011536', '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:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:18:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:18:12 INFO - Using env: {'DISPLAY': ':0', 14:18:12 INFO - 'HOME': '/home/cltbld', 14:18:12 INFO - 'LANG': 'en_US.UTF-8', 14:18:12 INFO - 'LANGUAGE': 'en_US:en', 14:18:12 INFO - 'LOGNAME': 'cltbld', 14:18:12 INFO - 'MAIL': '/var/mail/cltbld', 14:18:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:12 INFO - 'MOZ_NO_REMOTE': '1', 14:18:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:18:12 INFO - 'NO_EM_RESTART': '1', 14:18:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:18:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:18:12 INFO - 'PWD': '/builds/slave/test', 14:18:12 INFO - 'SHELL': '/bin/bash', 14:18:12 INFO - 'SHLVL': '1', 14:18:12 INFO - 'TERM': 'linux', 14:18:12 INFO - 'TMOUT': '86400', 14:18:12 INFO - 'USER': 'cltbld', 14:18:12 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1463001443.698483-1944011536', 14:18:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:12 INFO - '_': '/tools/buildbot/bin/python'} 14:18:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:18:12 INFO - Downloading/unpacking jsonschema 14:18:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:18:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:18:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:18:14 INFO - Downloading/unpacking functools32 (from jsonschema) 14:18:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:18:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:18:14 INFO - Downloading functools32-3.2.3-2.tar.gz 14:18:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:18:14 INFO - warning: no files found matching '*.txt' 14:18:14 INFO - no previously-included directories found matching 'build' 14:18:14 INFO - no previously-included directories found matching 'dist' 14:18:14 INFO - no previously-included directories found matching '.git*' 14:18:14 INFO - Installing collected packages: jsonschema, functools32 14:18:14 INFO - Running setup.py install for functools32 14:18:14 INFO - warning: no files found matching '*.txt' 14:18:14 INFO - no previously-included directories found matching 'build' 14:18:14 INFO - no previously-included directories found matching 'dist' 14:18:14 INFO - no previously-included directories found matching '.git*' 14:18:14 INFO - Successfully installed jsonschema functools32 14:18:14 INFO - Cleaning up... 14:18:14 INFO - Return code: 0 14:18:14 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:18:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:18:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:18:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:18:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:18:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6cc6ab9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x228c770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231b9c0>, '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 0x231c8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x231cd50>, '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': 'df17445c3590ff7897617a0e00000225-1463001443.698483-1944011536', '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:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 14:18:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 14:18:14 INFO - Using env: {'DISPLAY': ':0', 14:18:14 INFO - 'HOME': '/home/cltbld', 14:18:14 INFO - 'LANG': 'en_US.UTF-8', 14:18:14 INFO - 'LANGUAGE': 'en_US:en', 14:18:14 INFO - 'LOGNAME': 'cltbld', 14:18:14 INFO - 'MAIL': '/var/mail/cltbld', 14:18:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:14 INFO - 'MOZ_NO_REMOTE': '1', 14:18:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:18:14 INFO - 'NO_EM_RESTART': '1', 14:18:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:18:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:18:14 INFO - 'PWD': '/builds/slave/test', 14:18:14 INFO - 'SHELL': '/bin/bash', 14:18:14 INFO - 'SHLVL': '1', 14:18:14 INFO - 'TERM': 'linux', 14:18:14 INFO - 'TMOUT': '86400', 14:18:14 INFO - 'USER': 'cltbld', 14:18:14 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1463001443.698483-1944011536', 14:18:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:14 INFO - '_': '/tools/buildbot/bin/python'} 14:18:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:18:14 INFO - Downloading/unpacking flake8 14:18:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:18:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:18:18 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:18:18 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:18:18 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:18 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:18 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:18 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:18 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:18 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:18 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:18:18 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:18:18 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:18 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:18 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:18 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:18 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:18 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:18 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:18:18 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:18 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:18 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:18 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:18 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:18 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:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:18:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:18:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:18:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:18:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:18:18 INFO - no previously-included directories found matching 'docs/_build' 14:18:18 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:18:18 INFO - Running setup.py install for pep8 14:18:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:18:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:18:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:18:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:18:19 INFO - no previously-included directories found matching 'docs/_build' 14:18:19 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:18:19 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:18:19 INFO - Cleaning up... 14:18:19 INFO - Return code: 0 14:18:19 INFO - Running post-action listener: _resource_record_post_action 14:18:19 INFO - Running post-action listener: _start_resource_monitoring 14:18:19 INFO - Starting resource monitoring. 14:18:19 INFO - ##### 14:18:19 INFO - ##### Finished create-virtualenv step (success) 14:18:19 INFO - ##### 14:18:19 INFO - ##### 14:18:19 INFO - ##### Running install step. 14:18:19 INFO - ##### 14:18:19 INFO - Running pre-action listener: _resource_record_pre_action 14:18:19 INFO - Running main action method: install 14:18:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:18:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:18:19 INFO - Reading from file tmpfile_stdout 14:18:19 INFO - Detecting whether we're running mozinstall >=1.0... 14:18:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:18:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:18:19 INFO - Reading from file tmpfile_stdout 14:18:19 INFO - Output received: 14:18:19 INFO - Usage: mozinstall [options] installer 14:18:19 INFO - Options: 14:18:19 INFO - -h, --help show this help message and exit 14:18:19 INFO - -d DEST, --destination=DEST 14:18:19 INFO - Directory to install application into. [default: 14:18:19 INFO - "/builds/slave/test"] 14:18:19 INFO - --app=APP Application being installed. [default: firefox] 14:18:19 INFO - mkdir: /builds/slave/test/build/application 14:18:19 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:18:19 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:18:35 INFO - Reading from file tmpfile_stdout 14:18:35 INFO - Output received: 14:18:35 INFO - /builds/slave/test/build/application/firefox/firefox 14:18:35 INFO - Running post-action listener: _resource_record_post_action 14:18:35 INFO - ##### 14:18:35 INFO - ##### Finished install step (success) 14:18:35 INFO - ##### 14:18:35 INFO - ##### 14:18:35 INFO - ##### Running run-tests step. 14:18:35 INFO - ##### 14:18:35 INFO - Running pre-action listener: _resource_record_pre_action 14:18:35 INFO - Running main action method: run_tests 14:18:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:18:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:18:35 INFO - Python 2.7.3 14:18:35 INFO - Return code: 0 14:18:35 INFO - grabbing minidump binary from tooltool 14:18:35 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:35 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 0x231b9c0>, '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 0x231c8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x231cd50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:18:35 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:18:35 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:18:35 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:18:36 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:18:36 INFO - Return code: 0 14:18:36 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:18:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:18:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:18:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:18:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:18:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:18:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:18:37 INFO - Return code: 0 14:18:37 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-e10s', '--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-021', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 14:18:37 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-e10s --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-021 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 14:18:37 INFO - Using env: {'DISPLAY': ':0', 14:18:37 INFO - 'HOME': '/home/cltbld', 14:18:37 INFO - 'LANG': 'en_US.UTF-8', 14:18:37 INFO - 'LANGUAGE': 'en_US:en', 14:18:37 INFO - 'LOGNAME': 'cltbld', 14:18:37 INFO - 'MAIL': '/var/mail/cltbld', 14:18:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:18:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:18:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:37 INFO - 'MOZ_NO_REMOTE': '1', 14:18:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:18:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:18:37 INFO - 'NO_EM_RESTART': '1', 14:18:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:18:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:18:37 INFO - 'PWD': '/builds/slave/test', 14:18:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:18:37 INFO - 'SHELL': '/bin/bash', 14:18:37 INFO - 'SHLVL': '1', 14:18:37 INFO - 'TERM': 'linux', 14:18:37 INFO - 'TMOUT': '86400', 14:18:37 INFO - 'USER': 'cltbld', 14:18:37 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1463001443.698483-1944011536', 14:18:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:37 INFO - '_': '/tools/buildbot/bin/python'} 14:18:37 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--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-021', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 14:18:38 INFO - mozversion application_buildid: 20160511113038 14:18:38 INFO - mozversion application_changeset: 45daaf6edeae80ec8c67da50fa1d31f4a1b1a454 14:18:38 INFO - mozversion application_display_name: Nightly 14:18:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:18:38 INFO - mozversion application_name: Firefox 14:18:38 INFO - mozversion application_remotingname: firefox 14:18:38 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:18:38 INFO - mozversion application_vendor: Mozilla 14:18:38 INFO - mozversion application_version: 49.0a1 14:18:38 INFO - mozversion platform_buildid: 20160511113038 14:18:38 INFO - mozversion platform_changeset: 45daaf6edeae80ec8c67da50fa1d31f4a1b1a454 14:18:38 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:18:38 INFO - mozversion platform_version: 49.0a1 14:18:38 INFO - using testdate: 1463001518 14:18:38 INFO - actual date: 1463001518 14:18:38 INFO - starting webserver on 'localhost:37275' 14:18:38 INFO - SUITE-START | Running 2 tests 14:18:38 INFO - TEST-START | dromaeo_css 14:18:38 INFO - operating with platform_type : linux_ 14:18:38 INFO - Initialising browser for dromaeo_css test... 14:18:38 INFO - TEST-INFO | started process 3321 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeIEiUe/profile http://localhost:37275/getInfo.html) 14:18:46 INFO - PROCESS | 3321 | 14:18:46 INFO - PROCESS | 3321 | (process:3385): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 14:18:47 INFO - PROCESS | 3321 | __metrics Screen width/height:1600/1200 14:18:47 INFO - PROCESS | 3321 | colorDepth:24 14:18:47 INFO - PROCESS | 3321 | Browser inner width/height: 1024/697 14:18:47 INFO - PROCESS | 3321 | __metrics 14:18:48 ERROR - PROCESS | 3321 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 14:18:49 INFO - TEST-INFO | 3321: exit 0 14:18:49 INFO - Browser initialized. 14:18:49 INFO - Running cycle 1/1 for dromaeo_css test... 14:18:49 INFO - TEST-INFO | started process 3438 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeIEiUe/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:18:50 INFO - PROCESS | 3438 | 14:18:50 INFO - PROCESS | 3438 | (process:3500): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 14:19:00 INFO - PROCESS | 3438 | RSS: Main: 163147776 14:19:00 INFO - PROCESS | 3438 | 14:19:50 INFO - PROCESS | 3438 | 1463001590541 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:21:58 INFO - PROCESS | 3438 | Cycle 1(1): loaded http://localhost:37275/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37275/tests/dromaeo/cssquery-ext.html) 14:21:59 INFO - PROCESS | 3438 | RSS: Main: 165072896 14:21:59 INFO - PROCESS | 3438 | 14:25:01 INFO - PROCESS | 3438 | Cycle 1(1): loaded http://localhost:37275/tests/dromaeo/cssquery-ext.html (next: http://localhost:37275/tests/dromaeo/cssquery-jquery.html) 14:25:02 INFO - PROCESS | 3438 | RSS: Main: 166080512 14:25:02 INFO - PROCESS | 3438 | 14:28:04 INFO - PROCESS | 3438 | Cycle 1(1): loaded http://localhost:37275/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37275/tests/dromaeo/cssquery-mootools.html) 14:28:04 INFO - PROCESS | 3438 | RSS: Main: 167587840 14:28:04 INFO - PROCESS | 3438 | 14:31:06 INFO - PROCESS | 3438 | Cycle 1(1): loaded http://localhost:37275/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37275/tests/dromaeo/cssquery-prototype.html) 14:31:07 INFO - PROCESS | 3438 | RSS: Main: 165015552 14:31:07 INFO - PROCESS | 3438 | 14:34:09 INFO - PROCESS | 3438 | Cycle 1(1): loaded http://localhost:37275/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37275/tests/dromaeo/cssquery-yui.html) 14:34:10 INFO - PROCESS | 3438 | RSS: Main: 166383616 14:34:10 INFO - PROCESS | 3438 | 14:37:12 INFO - PROCESS | 3438 | Cycle 1(1): loaded http://localhost:37275/tests/dromaeo/cssquery-yui.html (next: http://localhost:37275/tests/dromaeo/cssquery-dojo.html) 14:37:12 INFO - PROCESS | 3438 | RSS: Main: 168284160 14:37:12 INFO - PROCESS | 3438 | 14:37:12 INFO - PROCESS | 3438 | __start_tp_report 14:37:12 INFO - PROCESS | 3438 | _x_x_mozilla_page_load 14:37:12 INFO - PROCESS | 3438 | _x_x_mozilla_page_load_details 14:37:12 INFO - PROCESS | 3438 | |i|pagename|runs| 14:37:12 INFO - PROCESS | 3438 | |0;dojo.html;3219.7585181111417;3225.629052658945;3256.674332566742;3262.054004338741;3263.4452143135663;5467.398586155525;5495.560355171587;5527.309086364205;5582.972085139569;5583.609147359686;5407;5438.755256013479;5449.264349312852;5520.558355331574;5557.083081291592;4905.117078925792;4943.209086546135;5045.747712614373;5099.566536844354;5132.948670513303;998.9736419680247;4885.633577481685;5006.349174607296;5015.799368025275;5017.573506251973;5009.49905009498;5011.696958790741;5045.772940217699;5047.671901326402;5061.519155680205;5048.697078175322;5055.873603159914;5061.342025536694;5070.61970352225;5085.821996230151;4930.975345123287;4955.628327875424;4975.651704380694;5006.249062640597;5017.724025178613;5424.83725488232;5425.294711687495;5435.1847222916485;5453.645513041679;5478.068728316196;5739.598228124033;5887.8528036799;5895.73469193883;5906.645601263938;5931.4661680448535;5906.881862362771;5946.345901950782;5971.552133589998;5981.162637230791;6020.879582408371;5591.916121258185;5633.211350410946;5634.267545219136;5636.2954630671165;5639.407862174454;5989.281286245591;6070.119832624245;6113.602615829956;6148.047052706837;6178.814635560941;5665.745041473144;5685.459881311269;5688.260526131577;5698.373178950312;5712.914306285409;5855.268091488564;5862.618929769551;5864.736086876101;5865.88268234633;5892.94107058924;5851.795187168429;5868.178455016301;5912.497437717842;5946.07835785454;5970.58205925581;5879.706014699248;5879.794207202727;5931.73307201177;5938.2280303560265;5951.940480595139;4406.339049142654;4446.510883802779;4452.30989196675;4506.459224893034;4548.7043342183315;3950.0322421007036;3964.8414063437717;3965.107850733562;3999.2201520703184;4002.659773919191;5650.265465489542;5678.971605141948;5709.685967271756;5725.198472213893;5726.9713651431475;5861.794837180678;6025.8192254232445;6040.486558642477;6045.818625441244;6054.545909056838;5663.716814159276;5686.630369026083;5722.198892155102;5725.627834190765;5728.684922329312;5079.8984020319385;5133.768980395891;5135.204043373283;5155.149400348901;5213.452587478336;6046.5767396281835;6125.20492926512;6204.5967012144065;6238.376162383816;6247.562670613013;5968.313643931004;6098.250697042237;6103.216452666926;6106.7640410362355;6137.478314343331;6253.843653908689;6279.215098112736;6304.810855674337;6309.779157729457;6310.6213627182515;5733.827985160452;5852.531797456279;5867.471927526543;5965.194698715618;5969.910451343147;5966.791162309299;5975.043992961106;6009.038553831366;6022.277326720821;6086.72609732572;5822;5880.353161152356;5887.911681324869;5888.528917686661;5903.0555111182;5623.550115990793;5742.827715168552;5773.134029895549;5803.535717142703;5864.003119469615;5684.232628595087;5699.173619825019;5720.570957178312;5722.971385143214;5726.370099288992;5811.854703632443;5848.853778655568;5864.032434648235;5874.236349274567;5882.764689412375;5595.860103497445;5718.714064296852;5730.5702072345575;5767.106098554731;5800.245968024298 14:37:12 INFO - PROCESS | 3438 | |1;ext.html;594.3848117198701;649.7011374767607;656.2748163279579;665.2283351312477;688.8346796768777;38147.04632384188;38995;43290;43482.7825860871;43505.129897402076;43854.34218486725;44151.77924110375;44489.33266001005;44565.99999999992;44610.33084503735;8645.74062778116;8681.34889883258;8691.217790398863;8730.170633789812;8767.386282960195;8756.69351572695;8862.86705699415;8871.290296776242;8877.112288771103;8884.422512536665;8881.822363552725;8886.066962968893;8916.643334266622;8931.285497160245;8936.508492032935;8821.117888211193;8908.153725396078;8921.420107692978;8926.687565935194;8934.329925255632;8863.11368863115;8877.866831997526;8939.418937769024;8945.552722363856;8953.776155596097;35896.461553076726;41411.58588414107;41530;41541;41922;3003.714647108521;3066.034199227236;3159.794613350125;3189.617245930503;3290.9506357404657;30396;31112.066638000895;31291.374172516422;31397.52903706446;31473.842630786927;4079.836806527765;4143.56492568282;4159.625633692952;4202;4258.488981322261;301822;302929;303532;304819;305777.9999999978;30899.69100309013;31239.06282811474;31248;35291.4706279406;35662.46506302407;36761.26477470436;36831;37289;37346.813265933495;37363;15116.848831511545;15275.923620381827;15340.846591534166;15351.539453816404;15385.384584616713;13062.34688265583;13070.738585228242;13072.869271307165;13145.079844410991;13195.934020329836;8504.617292221865;8552.871706924401;8612.526311052952;8614.22471977525;8624.094470080676;3366.9326613468083;3371.8819841305435;3392.508086327469;3394.9490757638655;3435.8282085895607;1040.4446886338058;1063.1229235880276;1064.771074219031;1069.9572017119383;1086.0334302470808;30694.53958190629;31448.52827207594;31856.362872742415;31952;32243.35513289768;1119.936060742298;1132.4394424759632;1133.019937753837;1140.9087273018138;1176.9823452648218;16534.503964881074;16894.915525422293;17061.914690426718;17086;17308.740368894476;452564;453356.06541640527;455376;455605;456603;55799.16301255485;57072.42927570671;57075.714621426625;57081.714591427604;57343.42656573464;1290.11627035481;1401.4044031286662;1416.405109853864;1460.1020372470855;1470.2722152534564;30613.387732245676;30712;30771.384572308878;30775.538366924065;31136.68863311338;50057.749711251214;50129.248061278384;50287.245691313925;50581;50600.74699626478;397053;398226;401045;401341;403968;27795.722042779315;27840.164795056182;27967.160985170478;28287.29281767972;28366.290842729097;46750.449189473795;46937.53062469468;47620;47801.28298075601;48047.75976120237;39429.802850985565;39532.60467395289;39780.801095994335;40011.399829002;40163.1967360657;39906.60093399029;40284.59715402809;40605.796971014955;41139.588604113575;41528.58471415247;37799;40665.39001914914;41453.17093658049;42133.57866421297;42254.366184506645;33518.162045949044;34007.48988765121;34138.82930585331;35438.82280588581;35889.82055089708;26087.869560652074;26773;27426.235688632198;27439.862800685867;27643.861780691772 14:37:12 INFO - PROCESS | 3438 | |2;jquery.html;404.9068714195733;409.9418339189645;415.43915713786384;416.7645280416563;431.8855503291628;18201.81798182018;18870.62258754824;19807;19896.50258743532;19942.70085948712;11948.342841143734;12079.75840483192;12240.265584064962;12245.938770306158;12375.814362784542;5213.400458947222;5319.893602127955;5333.120035194188;5343.091674415339;5350.438203988583;5177.178437751434;5743.741531631086;5763.567732420064;5764.827055188351;5799.449052340021;5693.544516438675;5695.77216911323;5701.0308247598;5711.2575365202465;5717.256756621633;5191.143461328877;5299.54953828925;5305.336832895888;5313.787448502075;5316.893662126736;4960.975195124038;5117.053345131126;5137.48625137487;5138.152204886189;5158.123119069767;20391.49021274465;21690.674639880413;22587.435314117116;23009;23150;2328.1025963839415;2360.386299562109;2408.373822806083;2506.661600683921;2542.898284068635;9377.296702747253;10066.949665251701;10089;10100.949495252551;10884.455254950535;1801.6036471976145;1833.578276996285;1865.4590168851016;1899.7815251246006;1960.882347059181;57226;75373;76464.61767691237;82281.88590570448;83285.58357208235;9690.37012594179;11050.281731687415;11077.667669969915;11139.387333696563;11186.776264474665;15551.688966220612;15843.603909902115;15890.920545397199;15936.760948585781;15960.76058859118;7947.3244774194845;8000.599970001476;8022.558759268296;8108.39187060961;8130.756077317572;7284.235155308722;7448.776536703907;7603.353714934182;7642.04474440695;7650.1202361728;4707.29390591414;4722.268048452495;4731.266653668687;4773.403324584427;4834.419869615669;1945.2863255758139;1994.8803071815737;2016.445477493701;2054.250198677472;2091.843111766593;918.3984490158956;939.145377706284;1005.7485628592851;1026.7627508851815;1042.3381152967768;17211.741823872653;17834.46496605104;17959.461216163538;18076.909615451837;18602;914.3690853311194;936.438137117724;953.7949340891741;976.4190306767462;1020.9183265338755;9946.154576861049;9972.052654997764;10178.389296642225;10267.075963163352;10409.271351005356;451620;452481.2127818085;452678;468526;475382;85088.57455712682;89856;91467;92706.53646731858;93343;1049.8740151181908;1062.8724553053682;1103.7626910214342;1113.504490501719;1129.6667483092508;16969.830301696824;17198.742018869478;17302.04838733882;17320;17357.47927562175;39234;40271;40512.59487405088;41018.79490602528;41380.58619413888;53862.730686346316;55344.72327638336;55403;55547.72226139005;56366.15450768324;8443.788905277417;8633.266172375419;8729.214370706666;8744.387892847439;9089.636414543344;9662.855057174289;13380.130291531019;13630;13699.794503082263;14025.649358766112;11731.296122232694;11951.820722689341;11991.64025079249;12113.212641178296;12244.265344079384;11856;11896.881031189578;11965.940170299442;12227.510899563918;12265.202761820454;11532.94233528827;11915.76168476643;12108.878911210775;12330.19853709506;12439.440225190068;8643.740687779376;8765.211130998241;8891.422057566237;8935.659651052394;9021.007689154056;12300.938495307466;12345.38273086324;12429;12431.751364972832;12496.625101246977 14:37:12 INFO - PROCESS | 3438 | |3;mootools.html;1542.2674229740874;1606.196901549225;1705.1303835044139;1814.9183286752095;1929.8745581537198;7937.841243175148;8520.957395213023;8563.10087440819;8991.685291014815;8992.595333210013;8540.316774658027;8789.692360767358;8852.734417967455;8854.955725221382;8876.423032502882;2297.655351697242;2367.6093444581625;2371.027878569787;2371.7391086980506;2374.0385144016614;2309.064828744353;2349.4126468382906;2378.2508509819436;2380.4048987753063;2394.2697477269426;2328.790408863202;2355.269866341431;2370.502194539149;2375.287413775869;2376;2254.2673631069806;2266.286119872235;2283.4177284792436;2305.2853615379204;2334.8132149428006;2308.499475341025;2322.941926451835;2329.126577533425;2333.404981729648;2337.9181728639587;8644.351673624504;8666.133386661346;8675;8723.127687231226;8741.25699315559;5114.718690472023;5176.352955880515;5245.055889939809;5259.421463638997;5293.814716484943;3329.317489914586;3436.4501679731375;3461.048211741766;3487.5814902211896;3501.089716673683;1053.3627155570923;1059.0838924330399;1095.5453486803046;2162.632352500063;2193.3529608765452;11391;11709.297442153498;11756.94121529387;11807.11446641514;12027.158098933078;4562.019165879352;4602.815887364535;4608.078384323148;4655.185342565105;4755.476897541268;9200.125988031126;9232.446053236827;9263;9355.204807591432;9357.625694972261;5084.3644544431945;5175.689458632419;5187.481251874782;5207.297014903015;5223.869403264949;4377.299632058855;4805.879853003703;4845.63657725672;4894.657373983787;4949.109160351171;3888.786116763605;3894.4742459768136;4000.7799571023293;4021.8994525136522;4041.2321658884716;1189.6193218170104;1206.6983254186453;1232.5994051933158;1236.5486597392066;1247.4324182496941;836.7615229659518;843.9957800210959;850.7830503221638;855.6235256487125;872.4242000279785;5371.57027437804;5596.86007849807;5777.913331300034;5782.855428614318;5910.143029260733;444.8109553439775;448.854122410218;449.49207395642713;459.2239115894195;470.1419908666697;3720.720945929066;3749.1939233065023;3752.962470375316;3774.301754175486;3791.545014598266;10667.51996160159;10955.287906286067;11083.279586826831;11130.276532025393;11131.276467029616;10206.336588121749;10746.194035447374;10750.677479675622;10933.343999360064;10952;7971.083325417535;8013.519188848688;8058.476199047043;8074.878876816852;8147.144549822302;5970.880582388241;6004.939950600438;6030.1256317832795;6039.124326972652;6169.444749972524;9560.330776845554;10020.448875311637;10098.697039088838;10194.796104078025;10333.74165645865;10181.185505159718;10205.234607404325;10352.585896564355;10427.270091093551;10498.947505262426;7391.778246652609;7396.0754905636795;7436.59098749574;7456.105267367733;7487.812804679708;8227;8230.300424463987;8241.752747417588;8274.462159959583;8286.212809783061;7154.391876690332;7354.043974283309;7382.2617738225745;7566.24337566239;7630.465867389452;7276.927230727837;7354.154272258758;7388.408927285912;7436.144843343085;7452.21751716062;6856.965715171392;6901.344372284625;6924.549904256207;6933;6934.06390137325;4628.699134556243;4732.408448943882;4766.1659209638865;4766.6901651392545;4783.425988881357;4851.58761505276;4907.043126590281;4989.027139707868;4996.675216110941;5111.948880511147 14:37:12 INFO - PROCESS | 3438 | |4;prototype.html;334.7539558424559;335.8606178435949;337.886807919347;340.58958954459877;345.5732170769101;5503.944960550399;5563.636908957306;5669.177969194469;5701;5731.856703582413;5558.666480011202;5598.636088654234;5609.80365687201;5625.606207565472;5643.830685079454;4171.207470580595;4378.8248470061235;4409.456690158451;4411.095725376306;4424.115176964604;4198.727082739628;4298.742075475466;4302.849400270991;4305.461817272841;4322.805473753689;4246.40550322955;4289.506706728719;4295.9785201073955;4304.203722311367;4305.483341998949;4301.612854843048;4304.203722311367;4316.158349121891;4329.177456283296;4331.718438301532;3561.2343346180437;3748.3815170496837;3762.830672619739;3766.6421689939684;3768.7361884668085;5348.171033489815;5359.705216213107;5360.249565060894;5378.892422151535;5397.8380648580605;4900.191468407708;4931.742405686563;4954.479779623124;4958.429780575244;4985.700857948535;5667.546596272329;5755.30936287644;5769.221155144044;5779.306483222041;5788.797392091299;4137.91724165518;4147.398627199039;4158.521769996459;4165.083681590046;4170.603792639695;5905;6129.233845769279;6131.325554189036;6159.35326790685;6202.658853763041;4123.505179378494;4127.422160897477;4159.542450330461;4173.288951529858;4174.666026717855;4208.537060923296;4215.59951804578;4218.409422680827;4234.132002939452;4238.919075635693;4879.438864530624;4879.902401951941;4883.4628190898975;4922.433920099163;4942.5304596063315;5814.389489103668;5900.409959004065;5904.468597826216;5907.970460147758;5940.46535811779;1474.992625036868;1486.145466356849;1490.4499320706343;1496.1247670113105;1497.2214448486725;908.8046070094962;929.0894922975386;942.58997336159;947.8388673925311;952.3999680536626;5092.236164575269;5599.860003499945;5669.40471250521;5717.913596416667;5773.653580785166;6037.607555508878;6082.635041897412;6094.939050609526;6100.23747031621;6104.389561043949;5544.473275038865;5678.801241956512;5697.230873832063;5724.942750572441;5741.19623252745;3227.580414546141;3250.3499300140065;3251.9349613007607;3265.6407795142513;3270.6238782540313;6248.4688801452385;6266.968665156736;6291.213598300213;6306.779262725782;6355.332690067568;5881.3530511643685;6271.247450305901;6286.434220920048;6302.621842689453;6341.446345645347;6375.458086062644;6382.170317858741;6391.1371964785085;6400.615963042233;6420.582662126947;5965.254343207099;6087.299960504599;6128.601640893327;6129.946467933292;6132.17215675878;6035.547333949883;6045.183900173421;6083.330833608211;6095.664738439428;6096.695165241631;6090.451859332681;6379.681015949277;6394.232692076795;6406.1031455597185;6419.55063145594;4319.308910574293;4349.434573505424;4358.368036634607;4379.912401751883;4385.166818304512;6150.323464419;6183.84540386476;6216.906746398718;6230.345813689679;6243.656598887105;5712.657525481592;5965.28416590012;5975.25309336333;5983.910241346296;6002.069679199731;5915.674637894957;5975.954208013493;6006.687425341188;6017.87964240704;6039.849003774941;5701.572382071278;5801.680907550125;5808.273965754281;5834.620749651429;5871.588988770916;5948.791792287249;5951.226340575698;5979.970100149471;6028.849278768066;6039.094135879654;5785.247917770663;5916.378780228014;5937.5249980000635;5940.198073260054;5966.284045914518 14:37:12 INFO - PROCESS | 3438 | |5;yui.html;690.0803436480787;696.9128858892635;728.1517032656955;758.2190343945734;764.2548515197683;11749.588764393247;12578.874211257884;12614.621561353151;12625.810612840814;12640.810387844189;12079.818802717966;12145.75708485832;12209.877901221007;12229.143959922809;12255;670.5473805181507;797.9680812767482;810.5177419435456;813.0771574263224;833.679033572076;816.1145157504086;817.1828171828172;819.213554987213;821.5153059694779;826.4834478450969;877.784942689042;884.7920738626418;884.8451520983803;885.7741275974618;887.9422837515573;868.097178933908;870.2081106193365;875.5403413208053;876.4653561327617;878.4334104502624;633.6768248193408;636.7325723196269;637.2130418932614;638.798778384812;641.5669423139409;12049.879501204963;12157.209781364272;12216.389180541026;12226.816597751042;12239.632811015596;12272.509099636003;12525.123241373107;12620.68448288791;12709.74580508394;12949.741005179843;9326.766830829216;9637.277204209713;9654.71035868925;9890.15933645641;9910.306278560503;3646.2707458508403;3655.3785856404475;3663.084228942764;3691.409374500094;3755.887323380303;52290.7385463074;53931;54249.45750542523;54268;54657.45342546563;9845.901540984498;9896.653617123366;10050.949745251228;10271.897281027244;10685.62600309001;18750.1562429691;18904.52738681544;18924;18974.14616342268;19044.333448329242;7175.569465832067;7239;7267.745628902963;7317.451191160684;7353.080864891888;4289.442372491556;4289.549597292302;4408.647308215335;4415.161119387306;4469.932951005738;3272.2473831018997;3275.606927168755;3374.662533746655;3382.5771778527683;3397.048826328632;700.2087640965779;707.4375871182423;709.3155105323387;710.2613282186571;715.8675645005586;608.5587948737218;652.663878102768;657.3393739291981;663.6283681138577;680.1430197950618;8878.73363799087;9246;9364.484953327632;9389.859152112724;9392.90607093934;668.8628831089615;672.6334147889412;682.331315310998;688.1810645332039;690.8083555866091;4491.30384790358;4526.026904215543;4543.636509079266;4742.193827049341;4907.1167189905445;66174;66256.33743662502;67546;68432.6578367105;69583.65208173927;55395;56154;58609.70695146497;60145.398546014854;60769.39230607726;50930.23604645933;52131.73934130381;53148.46851531512;53588.73205633947;53764.46235537673;8781.780455488664;8959.148880856308;9010.098990100938;9065.90934090677;9136.223421009288;33524.32951340911;33895.66104338925;34005.65994340025;34274.48588271228;34774;41377.793111034254;41771.7911410441;46539.37112201057;47406;48247;10588.682339529827;10698.62554810578;10888;10917.454127293762;11050.226484146355;11924.701882453008;12253.509859605516;12520.060995425198;12654.177478463871;13022.869771302545;11001.834972475259;12144.574939877415;12337.136400451882;12660.683482913;12937.611871643865;11954.282743035446;12595.74808503843;12813.871861281641;12888.291143987171;12951.093423460266;10983.121350292116;11338.94330528375;11471.56605424322;11548.307101573933;11788.233764805604;9540.427574345562;9584.37701549397;9701;10363.32638378503;10566.947165264124;9984.700458986243;10130.949345253226;10263.538140783832;10511.211659125443;10550.683479495627 14:37:12 INFO - PROCESS | 3438 | __end_tp_report 14:37:12 INFO - PROCESS | 3438 | __start_cc_report 14:37:12 INFO - PROCESS | 3438 | _x_x_mozilla_cycle_collect,336 14:37:12 INFO - PROCESS | 3438 | __end_cc_report 14:37:12 INFO - PROCESS | 3438 | __startTimestamp1463002632778__endTimestamp 14:37:12 INFO - PROCESS | 3438 | 14:37:12 INFO - PROCESS | 3438 | ------- Summary: start ------- 14:37:12 INFO - PROCESS | 3438 | Number of tests: 6 14:37:12 INFO - PROCESS | 3438 | 14:37:12 INFO - PROCESS | 3438 | [#0] dojo.html Cycles:165 Average:5493.83 Median:5725.20 stddev:734.06 (12.8%) stddev-sans-first:714.30 14:37:12 INFO - PROCESS | 3438 | Values: 3219.8 3225.6 3256.7 3262.1 3263.4 5467.4 5495.6 5527.3 5583.0 5583.6 5407.0 5438.8 5449.3 5520.6 5557.1 4905.1 4943.2 5045.7 5099.6 5132.9 999.0 4885.6 5006.3 5015.8 5017.6 5009.5 5011.7 5045.8 5047.7 5061.5 5048.7 5055.9 5061.3 5070.6 5085.8 4931.0 4955.6 4975.7 5006.2 5017.7 5424.8 5425.3 5435.2 5453.6 5478.1 5739.6 5887.9 5895.7 5906.6 5931.5 5906.9 5946.3 5971.6 5981.2 6020.9 5591.9 5633.2 5634.3 5636.3 5639.4 5989.3 6070.1 6113.6 6148.0 6178.8 5665.7 5685.5 5688.3 5698.4 5712.9 5855.3 5862.6 5864.7 5865.9 5892.9 5851.8 5868.2 5912.5 5946.1 5970.6 5879.7 5879.8 5931.7 5938.2 5951.9 4406.3 4446.5 4452.3 4506.5 4548.7 3950.0 3964.8 3965.1 3999.2 4002.7 5650.3 5679.0 5709.7 5725.2 5727.0 5861.8 6025.8 6040.5 6045.8 6054.5 5663.7 5686.6 5722.2 5725.6 5728.7 5079.9 5133.8 5135.2 5155.1 5213.5 6046.6 6125.2 6204.6 6238.4 6247.6 5968.3 6098.3 6103.2 6106.8 6137.5 6253.8 6279.2 6304.8 6309.8 6310.6 5733.8 5852.5 5867.5 5965.2 5969.9 5966.8 5975.0 6009.0 6022.3 6086.7 5822.0 5880.4 5887.9 5888.5 5903.1 5623.6 5742.8 5773.1 5803.5 5864.0 5684.2 5699.2 5720.6 5723.0 5726.4 5811.9 5848.9 5864.0 5874.2 5882.8 5595.9 5718.7 5730.6 5767.1 5800.2 14:37:12 INFO - PROCESS | 3438 | 14:37:12 INFO - PROCESS | 3438 | [#1] ext.html Cycles:180 Average:53543.17 Median:218292.80 stddev:103522.47 (47.4%) stddev-sans-first:103736.54 14:37:12 INFO - PROCESS | 3438 | Values: 594.4 649.7 656.3 665.2 688.8 38147.0 38995.0 43290.0 43482.8 43505.1 43854.3 44151.8 44489.3 44566.0 44610.3 8645.7 8681.3 8691.2 8730.2 8767.4 8756.7 8862.9 8871.3 8877.1 8884.4 8881.8 8886.1 8916.6 8931.3 8936.5 8821.1 8908.2 8921.4 8926.7 8934.3 8863.1 8877.9 8939.4 8945.6 8953.8 35896.5 41411.6 41530.0 41541.0 41922.0 3003.7 3066.0 3159.8 3189.6 3291.0 30396.0 31112.1 31291.4 31397.5 31473.8 4079.8 4143.6 4159.6 4202.0 4258.5 301822.0 302929.0 303532.0 304819.0 305778.0 30899.7 31239.1 31248.0 35291.5 35662.5 36761.3 36831.0 37289.0 37346.8 37363.0 15116.8 15275.9 15340.8 15351.5 15385.4 13062.3 13070.7 13072.9 13145.1 13195.9 8504.6 8552.9 8612.5 8614.2 8624.1 3366.9 3371.9 3392.5 3394.9 3435.8 1040.4 1063.1 1064.8 1070.0 1086.0 30694.5 31448.5 31856.4 31952.0 32243.4 1119.9 1132.4 1133.0 1140.9 1177.0 16534.5 16894.9 17061.9 17086.0 17308.7 452564.0 453356.1 455376.0 455605.0 456603.0 55799.2 57072.4 57075.7 57081.7 57343.4 1290.1 1401.4 1416.4 1460.1 1470.3 30613.4 30712.0 30771.4 30775.5 31136.7 50057.7 50129.2 50287.2 50581.0 50600.7 397053.0 398226.0 401045.0 401341.0 403968.0 27795.7 27840.2 27967.2 28287.3 28366.3 46750.4 46937.5 47620.0 47801.3 48047.8 39429.8 39532.6 39780.8 40011.4 40163.2 39906.6 40284.6 40605.8 41139.6 41528.6 37799.0 40665.4 41453.2 42133.6 42254.4 33518.2 34007.5 34138.8 35438.8 35889.8 26087.9 26773.0 27426.2 27439.9 27643.9 14:37:12 INFO - PROCESS | 3438 | 14:37:12 INFO - PROCESS | 3438 | [#2] jquery.html Cycles:180 Average:27590.21 Median:20337.95 stddev:75938.43 (373.4%) stddev-sans-first:76124.03 14:37:12 INFO - PROCESS | 3438 | Values: 404.9 409.9 415.4 416.8 431.9 18201.8 18870.6 19807.0 19896.5 19942.7 11948.3 12079.8 12240.3 12245.9 12375.8 5213.4 5319.9 5333.1 5343.1 5350.4 5177.2 5743.7 5763.6 5764.8 5799.4 5693.5 5695.8 5701.0 5711.3 5717.3 5191.1 5299.5 5305.3 5313.8 5316.9 4961.0 5117.1 5137.5 5138.2 5158.1 20391.5 21690.7 22587.4 23009.0 23150.0 2328.1 2360.4 2408.4 2506.7 2542.9 9377.3 10066.9 10089.0 10100.9 10884.5 1801.6 1833.6 1865.5 1899.8 1960.9 57226.0 75373.0 76464.6 82281.9 83285.6 9690.4 11050.3 11077.7 11139.4 11186.8 15551.7 15843.6 15890.9 15936.8 15960.8 7947.3 8000.6 8022.6 8108.4 8130.8 7284.2 7448.8 7603.4 7642.0 7650.1 4707.3 4722.3 4731.3 4773.4 4834.4 1945.3 1994.9 2016.4 2054.3 2091.8 918.4 939.1 1005.7 1026.8 1042.3 17211.7 17834.5 17959.5 18076.9 18602.0 914.4 936.4 953.8 976.4 1020.9 9946.2 9972.1 10178.4 10267.1 10409.3 451620.0 452481.2 452678.0 468526.0 475382.0 85088.6 89856.0 91467.0 92706.5 93343.0 1049.9 1062.9 1103.8 1113.5 1129.7 16969.8 17198.7 17302.0 17320.0 17357.5 39234.0 40271.0 40512.6 41018.8 41380.6 53862.7 55344.7 55403.0 55547.7 56366.2 8443.8 8633.3 8729.2 8744.4 9089.6 9662.9 13380.1 13630.0 13699.8 14025.6 11731.3 11951.8 11991.6 12113.2 12244.3 11856.0 11896.9 11965.9 12227.5 12265.2 11532.9 11915.8 12108.9 12330.2 12439.4 8643.7 8765.2 8891.4 8935.7 9021.0 12300.9 12345.4 12429.0 12431.8 12496.6 14:37:12 INFO - PROCESS | 3438 | 14:37:12 INFO - PROCESS | 3438 | [#3] mootools.html Cycles:180 Average:5680.46 Median:4743.94 stddev:3213.44 (67.7%) stddev-sans-first:3207.41 14:37:12 INFO - PROCESS | 3438 | Values: 1542.3 1606.2 1705.1 1814.9 1929.9 7937.8 8521.0 8563.1 8991.7 8992.6 8540.3 8789.7 8852.7 8855.0 8876.4 2297.7 2367.6 2371.0 2371.7 2374.0 2309.1 2349.4 2378.3 2380.4 2394.3 2328.8 2355.3 2370.5 2375.3 2376.0 2254.3 2266.3 2283.4 2305.3 2334.8 2308.5 2322.9 2329.1 2333.4 2337.9 8644.4 8666.1 8675.0 8723.1 8741.3 5114.7 5176.4 5245.1 5259.4 5293.8 3329.3 3436.5 3461.0 3487.6 3501.1 1053.4 1059.1 1095.5 2162.6 2193.4 11391.0 11709.3 11756.9 11807.1 12027.2 4562.0 4602.8 4608.1 4655.2 4755.5 9200.1 9232.4 9263.0 9355.2 9357.6 5084.4 5175.7 5187.5 5207.3 5223.9 4377.3 4805.9 4845.6 4894.7 4949.1 3888.8 3894.5 4000.8 4021.9 4041.2 1189.6 1206.7 1232.6 1236.5 1247.4 836.8 844.0 850.8 855.6 872.4 5371.6 5596.9 5777.9 5782.9 5910.1 444.8 448.9 449.5 459.2 470.1 3720.7 3749.2 3753.0 3774.3 3791.5 10667.5 10955.3 11083.3 11130.3 11131.3 10206.3 10746.2 10750.7 10933.3 10952.0 7971.1 8013.5 8058.5 8074.9 8147.1 5970.9 6004.9 6030.1 6039.1 6169.4 9560.3 10020.4 10098.7 10194.8 10333.7 10181.2 10205.2 10352.6 10427.3 10498.9 7391.8 7396.1 7436.6 7456.1 7487.8 8227.0 8230.3 8241.8 8274.5 8286.2 7154.4 7354.0 7382.3 7566.2 7630.5 7276.9 7354.2 7388.4 7436.1 7452.2 6857.0 6901.3 6924.5 6933.0 6934.1 4628.7 4732.4 4766.2 4766.7 4783.4 4851.6 4907.0 4989.0 4996.7 5111.9 14:37:12 INFO - PROCESS | 3438 | 14:37:12 INFO - PROCESS | 3438 | [#4] prototype.html Cycles:180 Average:4962.42 Median:5701.29 stddev:1496.37 (26.2%) stddev-sans-first:1459.70 14:37:12 INFO - PROCESS | 3438 | Values: 334.8 335.9 337.9 340.6 345.6 5503.9 5563.6 5669.2 5701.0 5731.9 5558.7 5598.6 5609.8 5625.6 5643.8 4171.2 4378.8 4409.5 4411.1 4424.1 4198.7 4298.7 4302.8 4305.5 4322.8 4246.4 4289.5 4296.0 4304.2 4305.5 4301.6 4304.2 4316.2 4329.2 4331.7 3561.2 3748.4 3762.8 3766.6 3768.7 5348.2 5359.7 5360.2 5378.9 5397.8 4900.2 4931.7 4954.5 4958.4 4985.7 5667.5 5755.3 5769.2 5779.3 5788.8 4137.9 4147.4 4158.5 4165.1 4170.6 5905.0 6129.2 6131.3 6159.4 6202.7 4123.5 4127.4 4159.5 4173.3 4174.7 4208.5 4215.6 4218.4 4234.1 4238.9 4879.4 4879.9 4883.5 4922.4 4942.5 5814.4 5900.4 5904.5 5908.0 5940.5 1475.0 1486.1 1490.4 1496.1 1497.2 908.8 929.1 942.6 947.8 952.4 5092.2 5599.9 5669.4 5717.9 5773.7 6037.6 6082.6 6094.9 6100.2 6104.4 5544.5 5678.8 5697.2 5724.9 5741.2 3227.6 3250.3 3251.9 3265.6 3270.6 6248.5 6267.0 6291.2 6306.8 6355.3 5881.4 6271.2 6286.4 6302.6 6341.4 6375.5 6382.2 6391.1 6400.6 6420.6 5965.3 6087.3 6128.6 6129.9 6132.2 6035.5 6045.2 6083.3 6095.7 6096.7 6090.5 6379.7 6394.2 6406.1 6419.6 4319.3 4349.4 4358.4 4379.9 4385.2 6150.3 6183.8 6216.9 6230.3 6243.7 5712.7 5965.3 5975.3 5983.9 6002.1 5915.7 5976.0 6006.7 6017.9 6039.8 5701.6 5801.7 5808.3 5834.6 5871.6 5948.8 5951.2 5980.0 6028.8 6039.1 5785.2 5916.4 5937.5 5940.2 5966.3 14:37:12 INFO - PROCESS | 3438 | 14:37:12 INFO - PROCESS | 3438 | [#5] yui.html Cycles:180 Average:14663.68 Median:52211.24 stddev:17910.15 (34.3%) stddev-sans-first:17929.65 14:37:12 INFO - PROCESS | 3438 | Values: 690.1 696.9 728.2 758.2 764.3 11749.6 12578.9 12614.6 12625.8 12640.8 12079.8 12145.8 12209.9 12229.1 12255.0 670.5 798.0 810.5 813.1 833.7 816.1 817.2 819.2 821.5 826.5 877.8 884.8 884.8 885.8 887.9 868.1 870.2 875.5 876.5 878.4 633.7 636.7 637.2 638.8 641.6 12049.9 12157.2 12216.4 12226.8 12239.6 12272.5 12525.1 12620.7 12709.7 12949.7 9326.8 9637.3 9654.7 9890.2 9910.3 3646.3 3655.4 3663.1 3691.4 3755.9 52290.7 53931.0 54249.5 54268.0 54657.5 9845.9 9896.7 10050.9 10271.9 10685.6 18750.2 18904.5 18924.0 18974.1 19044.3 7175.6 7239.0 7267.7 7317.5 7353.1 4289.4 4289.5 4408.6 4415.2 4469.9 3272.2 3275.6 3374.7 3382.6 3397.0 700.2 707.4 709.3 710.3 715.9 608.6 652.7 657.3 663.6 680.1 8878.7 9246.0 9364.5 9389.9 9392.9 668.9 672.6 682.3 688.2 690.8 4491.3 4526.0 4543.6 4742.2 4907.1 66174.0 66256.3 67546.0 68432.7 69583.7 55395.0 56154.0 58609.7 60145.4 60769.4 50930.2 52131.7 53148.5 53588.7 53764.5 8781.8 8959.1 9010.1 9065.9 9136.2 33524.3 33895.7 34005.7 34274.5 34774.0 41377.8 41771.8 46539.4 47406.0 48247.0 10588.7 10698.6 10888.0 10917.5 11050.2 11924.7 12253.5 12520.1 12654.2 13022.9 11001.8 12144.6 12337.1 12660.7 12937.6 11954.3 12595.7 12813.9 12888.3 12951.1 10983.1 11338.9 11471.6 11548.3 11788.2 9540.4 9584.4 9701.0 10363.3 10566.9 9984.7 10130.9 10263.5 10511.2 10550.7 14:37:12 INFO - PROCESS | 3438 | -------- Summary: end -------- 14:37:12 INFO - PROCESS | 3438 | 14:37:13 INFO - TEST-INFO | 3438: exit 0 14:37:13 INFO - TEST-OK | dromaeo_css | took 1115159ms 14:37:13 INFO - TEST-START | kraken 14:37:13 INFO - operating with platform_type : linux_ 14:37:13 INFO - Initialising browser for kraken test... 14:37:13 INFO - TEST-INFO | started process 3673 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3HTR2E/profile http://localhost:37275/getInfo.html) 14:37:17 INFO - PROCESS | 3673 | 14:37:17 INFO - PROCESS | 3673 | (process:3743): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 14:37:18 INFO - PROCESS | 3673 | __metrics Screen width/height:1600/1200 14:37:18 INFO - PROCESS | 3673 | colorDepth:24 14:37:18 INFO - PROCESS | 3673 | Browser inner width/height: 1024/697 14:37:18 INFO - PROCESS | 3673 | __metrics 14:37:19 ERROR - PROCESS | 3673 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 14:37:20 INFO - TEST-INFO | 3673: exit 0 14:37:20 INFO - Browser initialized. 14:37:20 INFO - Running cycle 1/1 for kraken test... 14:37:20 INFO - TEST-INFO | started process 3794 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3HTR2E/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:37:22 INFO - PROCESS | 3794 | 14:37:22 INFO - PROCESS | 3794 | (process:3854): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 14:37:32 INFO - PROCESS | 3794 | RSS: Main: 163274752 14:37:32 INFO - PROCESS | 3794 | 14:37:34 INFO - PROCESS | 3794 | Cycle 1(1): loaded http://localhost:37275/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37275/tests/kraken/driver.html?testName=audio-beat-detection) 14:37:35 INFO - PROCESS | 3794 | RSS: Main: 167632896 14:37:35 INFO - PROCESS | 3794 | 14:37:38 INFO - PROCESS | 3794 | Cycle 1(1): loaded http://localhost:37275/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37275/tests/kraken/driver.html?testName=audio-dft) 14:37:38 INFO - PROCESS | 3794 | RSS: Main: 167997440 14:37:38 INFO - PROCESS | 3794 | 14:37:41 INFO - PROCESS | 3794 | Cycle 1(1): loaded http://localhost:37275/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37275/tests/kraken/driver.html?testName=audio-fft) 14:37:42 INFO - PROCESS | 3794 | RSS: Main: 162717696 14:37:42 INFO - PROCESS | 3794 | 14:37:44 INFO - PROCESS | 3794 | Cycle 1(1): loaded http://localhost:37275/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37275/tests/kraken/driver.html?testName=audio-oscillator) 14:37:45 INFO - PROCESS | 3794 | RSS: Main: 163008512 14:37:45 INFO - PROCESS | 3794 | 14:37:47 INFO - PROCESS | 3794 | Cycle 1(1): loaded http://localhost:37275/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37275/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:37:48 INFO - PROCESS | 3794 | RSS: Main: 163344384 14:37:48 INFO - PROCESS | 3794 | 14:37:51 INFO - PROCESS | 3794 | Cycle 1(1): loaded http://localhost:37275/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37275/tests/kraken/driver.html?testName=imaging-darkroom) 14:37:51 INFO - PROCESS | 3794 | RSS: Main: 163557376 14:37:51 INFO - PROCESS | 3794 | 14:37:55 INFO - PROCESS | 3794 | Cycle 1(1): loaded http://localhost:37275/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37275/tests/kraken/driver.html?testName=imaging-desaturate) 14:37:56 INFO - PROCESS | 3794 | RSS: Main: 162471936 14:37:56 INFO - PROCESS | 3794 | 14:37:59 INFO - PROCESS | 3794 | Cycle 1(1): loaded http://localhost:37275/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37275/tests/kraken/driver.html?testName=json-parse-financial) 14:37:59 INFO - PROCESS | 3794 | RSS: Main: 163069952 14:37:59 INFO - PROCESS | 3794 | 14:38:01 INFO - PROCESS | 3794 | Cycle 1(1): loaded http://localhost:37275/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37275/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:38:02 INFO - PROCESS | 3794 | RSS: Main: 163463168 14:38:02 INFO - PROCESS | 3794 | 14:38:03 INFO - PROCESS | 3794 | Cycle 1(1): loaded http://localhost:37275/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37275/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:38:04 INFO - PROCESS | 3794 | RSS: Main: 163401728 14:38:04 INFO - PROCESS | 3794 | 14:38:06 INFO - PROCESS | 3794 | Cycle 1(1): loaded http://localhost:37275/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37275/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:38:07 INFO - PROCESS | 3794 | RSS: Main: 163430400 14:38:07 INFO - PROCESS | 3794 | 14:38:09 INFO - PROCESS | 3794 | Cycle 1(1): loaded http://localhost:37275/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:38:10 INFO - PROCESS | 3794 | RSS: Main: 163971072 14:38:10 INFO - PROCESS | 3794 | 14:38:13 INFO - PROCESS | 3794 | Cycle 1(1): loaded http://localhost:37275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:38:14 INFO - PROCESS | 3794 | RSS: Main: 163594240 14:38:14 INFO - PROCESS | 3794 | 14:38:15 INFO - PROCESS | 3794 | Cycle 1(1): loaded http://localhost:37275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37275/tests/kraken/driver.html?testName=ai-astar) 14:38:16 INFO - PROCESS | 3794 | RSS: Main: 164921344 14:38:16 INFO - PROCESS | 3794 | 14:38:16 INFO - PROCESS | 3794 | __start_tp_report 14:38:16 INFO - PROCESS | 3794 | _x_x_mozilla_page_load 14:38:16 INFO - PROCESS | 3794 | _x_x_mozilla_page_load_details 14:38:16 INFO - PROCESS | 3794 | |i|pagename|runs| 14:38:16 INFO - PROCESS | 3794 | |0;ai-astar;111;115;104;110;111;113;106;111;113;114 14:38:16 INFO - PROCESS | 3794 | |1;audio-beat-detection;153;125;164;204;125;157;155;130;186;130 14:38:16 INFO - PROCESS | 3794 | |2;audio-dft;162;168;161;160;164;169;166;165;164;162 14:38:16 INFO - PROCESS | 3794 | |3;audio-fft;76;76;75;166;75;74;74;77;172;76 14:38:16 INFO - PROCESS | 3794 | |4;audio-oscillator;94;92;186;92;92;93;148;92;92;143 14:38:16 INFO - PROCESS | 3794 | |5;imaging-gaussian-blur;118;117;118;117;118;118;117;118;117;118 14:38:16 INFO - PROCESS | 3794 | |6;imaging-darkroom;146;147;146;147;147;147;147;146;147;146 14:38:16 INFO - PROCESS | 3794 | |7;imaging-desaturate;95;95;96;96;96;96;95;96;96;96 14:38:16 INFO - PROCESS | 3794 | |8;json-parse-financial;60;62;67;60;63;62;62;119;61;60 14:38:16 INFO - PROCESS | 3794 | |9;json-stringify-tinderbox;59;59;61;59;59;59;58;59;59;59 14:38:16 INFO - PROCESS | 3794 | |10;stanford-crypto-aes;84;84;78;79;79;83;82;81;79;79 14:38:16 INFO - PROCESS | 3794 | |11;stanford-crypto-ccm;122;126;131;124;127;136;126;137;206;129 14:38:16 INFO - PROCESS | 3794 | |12;stanford-crypto-pbkdf2;171;176;174;175;173;167;169;173;170;174 14:38:16 INFO - PROCESS | 3794 | |13;stanford-crypto-sha256-iterative;67;65;67;65;62;77;64;63;64;64 14:38:16 INFO - PROCESS | 3794 | __end_tp_report 14:38:16 INFO - PROCESS | 3794 | __start_cc_report 14:38:16 INFO - PROCESS | 3794 | _x_x_mozilla_cycle_collect,859 14:38:16 INFO - PROCESS | 3794 | __end_cc_report 14:38:16 INFO - PROCESS | 3794 | __startTimestamp1463002696078__endTimestamp 14:38:16 INFO - PROCESS | 3794 | 14:38:16 INFO - PROCESS | 3794 | ------- Summary: start ------- 14:38:16 INFO - PROCESS | 3794 | Number of tests: 14 14:38:16 INFO - PROCESS | 3794 | 14:38:16 INFO - PROCESS | 3794 | [#0] ai-astar Cycles:10 Average:110.80 Median:112.00 stddev:3.46 (3.1%) stddev-sans-first:3.67 14:38:16 INFO - PROCESS | 3794 | Values: 111.0 115.0 104.0 110.0 111.0 113.0 106.0 111.0 113.0 114.0 14:38:16 INFO - PROCESS | 3794 | 14:38:16 INFO - PROCESS | 3794 | [#1] audio-beat-detection Cycles:10 Average:152.90 Median:156.00 stddev:26.78 (17.2%) stddev-sans-first:28.41 14:38:16 INFO - PROCESS | 3794 | Values: 153.0 125.0 164.0 204.0 125.0 157.0 155.0 130.0 186.0 130.0 14:38:16 INFO - PROCESS | 3794 | 14:38:16 INFO - PROCESS | 3794 | [#2] audio-dft Cycles:10 Average:164.10 Median:164.50 stddev:2.96 (1.8%) stddev-sans-first:3.04 14:38:16 INFO - PROCESS | 3794 | Values: 162.0 168.0 161.0 160.0 164.0 169.0 166.0 165.0 164.0 162.0 14:38:16 INFO - PROCESS | 3794 | 14:38:16 INFO - PROCESS | 3794 | [#3] audio-fft Cycles:10 Average:94.10 Median:75.50 stddev:39.51 (52.3%) stddev-sans-first:41.36 14:38:16 INFO - PROCESS | 3794 | Values: 76.0 76.0 75.0 166.0 75.0 74.0 74.0 77.0 172.0 76.0 14:38:16 INFO - PROCESS | 3794 | 14:38:16 INFO - PROCESS | 3794 | [#4] audio-oscillator Cycles:10 Average:112.40 Median:92.00 stddev:34.02 (37.0%) stddev-sans-first:35.43 14:38:16 INFO - PROCESS | 3794 | Values: 94.0 92.0 186.0 92.0 92.0 93.0 148.0 92.0 92.0 143.0 14:38:16 INFO - PROCESS | 3794 | 14:38:16 INFO - PROCESS | 3794 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 14:38:16 INFO - PROCESS | 3794 | Values: 118.0 117.0 118.0 117.0 118.0 118.0 117.0 118.0 117.0 118.0 14:38:16 INFO - PROCESS | 3794 | 14:38:16 INFO - PROCESS | 3794 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 14:38:16 INFO - PROCESS | 3794 | Values: 146.0 147.0 146.0 147.0 147.0 147.0 147.0 146.0 147.0 146.0 14:38:16 INFO - PROCESS | 3794 | 14:38:16 INFO - PROCESS | 3794 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 14:38:16 INFO - PROCESS | 3794 | Values: 95.0 95.0 96.0 96.0 96.0 96.0 95.0 96.0 96.0 96.0 14:38:16 INFO - PROCESS | 3794 | 14:38:16 INFO - PROCESS | 3794 | [#8] json-parse-financial Cycles:10 Average:67.60 Median:62.00 stddev:18.18 (29.3%) stddev-sans-first:19.07 14:38:16 INFO - PROCESS | 3794 | Values: 60.0 62.0 67.0 60.0 63.0 62.0 62.0 119.0 61.0 60.0 14:38:16 INFO - PROCESS | 3794 | 14:38:16 INFO - PROCESS | 3794 | [#9] json-stringify-tinderbox Cycles:10 Average:59.10 Median:59.00 stddev:0.74 (1.3%) stddev-sans-first:0.78 14:38:16 INFO - PROCESS | 3794 | Values: 59.0 59.0 61.0 59.0 59.0 59.0 58.0 59.0 59.0 59.0 14:38:16 INFO - PROCESS | 3794 | 14:38:16 INFO - PROCESS | 3794 | [#10] stanford-crypto-aes Cycles:10 Average:80.80 Median:81.50 stddev:2.30 (2.8%) stddev-sans-first:2.13 14:38:16 INFO - PROCESS | 3794 | Values: 84.0 84.0 78.0 79.0 79.0 83.0 82.0 81.0 79.0 79.0 14:38:16 INFO - PROCESS | 3794 | 14:38:16 INFO - PROCESS | 3794 | [#11] stanford-crypto-ccm Cycles:10 Average:136.40 Median:130.00 stddev:24.93 (19.2%) stddev-sans-first:25.89 14:38:16 INFO - PROCESS | 3794 | Values: 122.0 126.0 131.0 124.0 127.0 136.0 126.0 137.0 206.0 129.0 14:38:16 INFO - PROCESS | 3794 | 14:38:16 INFO - PROCESS | 3794 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.20 Median:173.50 stddev:2.86 (1.6%) stddev-sans-first:3.00 14:38:16 INFO - PROCESS | 3794 | Values: 171.0 176.0 174.0 175.0 173.0 167.0 169.0 173.0 170.0 174.0 14:38:16 INFO - PROCESS | 3794 | 14:38:16 INFO - PROCESS | 3794 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.80 Median:65.00 stddev:4.24 (6.5%) stddev-sans-first:4.47 14:38:16 INFO - PROCESS | 3794 | Values: 67.0 65.0 67.0 65.0 62.0 77.0 64.0 63.0 64.0 64.0 14:38:16 INFO - PROCESS | 3794 | -------- Summary: end -------- 14:38:16 INFO - PROCESS | 3794 | 14:38:16 INFO - TEST-INFO | 3794: exit 0 14:38:17 INFO - TEST-OK | kraken | took 63521ms 14:38:17 INFO - SUITE-END | took 1178s 14:38:17 INFO - Completed test suite (00:19:38) 14:38:17 INFO - javascript benchmark 14:38:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3219.7585181111417, 3225.629052658945, 3256.674332566742, 3262.054004338741, 3263.4452143135663, 5467.398586155525, 5495.560355171587, 5527.309086364205, 5582.972085139569, 5583.609147359686, 5407.0, 5438.755256013479, 5449.264349312852, 5520.558355331574, 5557.083081291592, 4905.117078925792, 4943.209086546135, 5045.747712614373, 5099.566536844354, 5132.948670513303, 998.9736419680247, 4885.633577481685, 5006.349174607296, 5015.799368025275, 5017.573506251973, 5009.49905009498, 5011.696958790741, 5045.772940217699, 5047.671901326402, 5061.519155680205, 5048.697078175322, 5055.873603159914, 5061.342025536694, 5070.61970352225, 5085.821996230151, 4930.975345123287, 4955.628327875424, 4975.651704380694, 5006.249062640597, 5017.724025178613, 5424.83725488232, 5425.294711687495, 5435.1847222916485, 5453.645513041679, 5478.068728316196, 5739.598228124033, 5887.8528036799, 5895.73469193883, 5906.645601263938, 5931.4661680448535, 5906.881862362771, 5946.345901950782, 5971.552133589998, 5981.162637230791, 6020.879582408371, 5591.916121258185, 5633.211350410946, 5634.267545219136, 5636.2954630671165, 5639.407862174454, 5989.281286245591, 6070.119832624245, 6113.602615829956, 6148.047052706837, 6178.814635560941, 5665.745041473144, 5685.459881311269, 5688.260526131577, 5698.373178950312, 5712.914306285409, 5855.268091488564, 5862.618929769551, 5864.736086876101, 5865.88268234633, 5892.94107058924, 5851.795187168429, 5868.178455016301, 5912.497437717842, 5946.07835785454, 5970.58205925581, 5879.706014699248, 5879.794207202727, 5931.73307201177, 5938.2280303560265, 5951.940480595139, 4406.339049142654, 4446.510883802779, 4452.30989196675, 4506.459224893034, 4548.7043342183315, 3950.0322421007036, 3964.8414063437717, 3965.107850733562, 3999.2201520703184, 4002.659773919191, 5650.265465489542, 5678.971605141948, 5709.685967271756, 5725.198472213893, 5726.9713651431475, 5861.794837180678, 6025.8192254232445, 6040.486558642477, 6045.818625441244, 6054.545909056838, 5663.716814159276, 5686.630369026083, 5722.198892155102, 5725.627834190765, 5728.684922329312, 5079.8984020319385, 5133.768980395891, 5135.204043373283, 5155.149400348901, 5213.452587478336, 6046.5767396281835, 6125.20492926512, 6204.5967012144065, 6238.376162383816, 6247.562670613013, 5968.313643931004, 6098.250697042237, 6103.216452666926, 6106.7640410362355, 6137.478314343331, 6253.843653908689, 6279.215098112736, 6304.810855674337, 6309.779157729457, 6310.6213627182515, 5733.827985160452, 5852.531797456279, 5867.471927526543, 5965.194698715618, 5969.910451343147, 5966.791162309299, 5975.043992961106, 6009.038553831366, 6022.277326720821, 6086.72609732572, 5822.0, 5880.353161152356, 5887.911681324869, 5888.528917686661, 5903.0555111182, 5623.550115990793, 5742.827715168552, 5773.134029895549, 5803.535717142703, 5864.003119469615, 5684.232628595087, 5699.173619825019, 5720.570957178312, 5722.971385143214, 5726.370099288992, 5811.854703632443, 5848.853778655568, 5864.032434648235, 5874.236349274567, 5882.764689412375, 5595.860103497445, 5718.714064296852, 5730.5702072345575, 5767.106098554731, 5800.245968024298], "value": 5444.643757363077, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [594.3848117198701, 649.7011374767607, 656.2748163279579, 665.2283351312477, 688.8346796768777, 38147.04632384188, 38995.0, 43290.0, 43482.7825860871, 43505.129897402076, 43854.34218486725, 44151.77924110375, 44489.33266001005, 44565.99999999992, 44610.33084503735, 8645.74062778116, 8681.34889883258, 8691.217790398863, 8730.170633789812, 8767.386282960195, 8756.69351572695, 8862.86705699415, 8871.290296776242, 8877.112288771103, 8884.422512536665, 8881.822363552725, 8886.066962968893, 8916.643334266622, 8931.285497160245, 8936.508492032935, 8821.117888211193, 8908.153725396078, 8921.420107692978, 8926.687565935194, 8934.329925255632, 8863.11368863115, 8877.866831997526, 8939.418937769024, 8945.552722363856, 8953.776155596097, 35896.461553076726, 41411.58588414107, 41530.0, 41541.0, 41922.0, 3003.714647108521, 3066.034199227236, 3159.794613350125, 3189.617245930503, 3290.9506357404657, 30396.0, 31112.066638000895, 31291.374172516422, 31397.52903706446, 31473.842630786927, 4079.836806527765, 4143.56492568282, 4159.625633692952, 4202.0, 4258.488981322261, 301822.0, 302929.0, 303532.0, 304819.0, 305777.9999999978, 30899.69100309013, 31239.06282811474, 31248.0, 35291.4706279406, 35662.46506302407, 36761.26477470436, 36831.0, 37289.0, 37346.813265933495, 37363.0, 15116.848831511545, 15275.923620381827, 15340.846591534166, 15351.539453816404, 15385.384584616713, 13062.34688265583, 13070.738585228242, 13072.869271307165, 13145.079844410991, 13195.934020329836, 8504.617292221865, 8552.871706924401, 8612.526311052952, 8614.22471977525, 8624.094470080676, 3366.9326613468083, 3371.8819841305435, 3392.508086327469, 3394.9490757638655, 3435.8282085895607, 1040.4446886338058, 1063.1229235880276, 1064.771074219031, 1069.9572017119383, 1086.0334302470808, 30694.53958190629, 31448.52827207594, 31856.362872742415, 31952.0, 32243.35513289768, 1119.936060742298, 1132.4394424759632, 1133.019937753837, 1140.9087273018138, 1176.9823452648218, 16534.503964881074, 16894.915525422293, 17061.914690426718, 17086.0, 17308.740368894476, 452564.0, 453356.06541640527, 455376.0, 455605.0, 456603.0, 55799.16301255485, 57072.42927570671, 57075.714621426625, 57081.714591427604, 57343.42656573464, 1290.11627035481, 1401.4044031286662, 1416.405109853864, 1460.1020372470855, 1470.2722152534564, 30613.387732245676, 30712.0, 30771.384572308878, 30775.538366924065, 31136.68863311338, 50057.749711251214, 50129.248061278384, 50287.245691313925, 50581.0, 50600.74699626478, 397053.0, 398226.0, 401045.0, 401341.0, 403968.0, 27795.722042779315, 27840.164795056182, 27967.160985170478, 28287.29281767972, 28366.290842729097, 46750.449189473795, 46937.53062469468, 47620.0, 47801.28298075601, 48047.75976120237, 39429.802850985565, 39532.60467395289, 39780.801095994335, 40011.399829002, 40163.1967360657, 39906.60093399029, 40284.59715402809, 40605.796971014955, 41139.588604113575, 41528.58471415247, 37799.0, 40665.39001914914, 41453.17093658049, 42133.57866421297, 42254.366184506645, 33518.162045949044, 34007.48988765121, 34138.82930585331, 35438.82280588581, 35889.82055089708, 26087.869560652074, 26773.0, 27426.235688632198, 27439.862800685867, 27643.861780691772], "value": 18306.112694901785, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [404.9068714195733, 409.9418339189645, 415.43915713786384, 416.7645280416563, 431.8855503291628, 18201.81798182018, 18870.62258754824, 19807.0, 19896.50258743532, 19942.70085948712, 11948.342841143734, 12079.75840483192, 12240.265584064962, 12245.938770306158, 12375.814362784542, 5213.400458947222, 5319.893602127955, 5333.120035194188, 5343.091674415339, 5350.438203988583, 5177.178437751434, 5743.741531631086, 5763.567732420064, 5764.827055188351, 5799.449052340021, 5693.544516438675, 5695.77216911323, 5701.0308247598, 5711.2575365202465, 5717.256756621633, 5191.143461328877, 5299.54953828925, 5305.336832895888, 5313.787448502075, 5316.893662126736, 4960.975195124038, 5117.053345131126, 5137.48625137487, 5138.152204886189, 5158.123119069767, 20391.49021274465, 21690.674639880413, 22587.435314117116, 23009.0, 23150.0, 2328.1025963839415, 2360.386299562109, 2408.373822806083, 2506.661600683921, 2542.898284068635, 9377.296702747253, 10066.949665251701, 10089.0, 10100.949495252551, 10884.455254950535, 1801.6036471976145, 1833.578276996285, 1865.4590168851016, 1899.7815251246006, 1960.882347059181, 57226.0, 75373.0, 76464.61767691237, 82281.88590570448, 83285.58357208235, 9690.37012594179, 11050.281731687415, 11077.667669969915, 11139.387333696563, 11186.776264474665, 15551.688966220612, 15843.603909902115, 15890.920545397199, 15936.760948585781, 15960.76058859118, 7947.3244774194845, 8000.599970001476, 8022.558759268296, 8108.39187060961, 8130.756077317572, 7284.235155308722, 7448.776536703907, 7603.353714934182, 7642.04474440695, 7650.1202361728, 4707.29390591414, 4722.268048452495, 4731.266653668687, 4773.403324584427, 4834.419869615669, 1945.2863255758139, 1994.8803071815737, 2016.445477493701, 2054.250198677472, 2091.843111766593, 918.3984490158956, 939.145377706284, 1005.7485628592851, 1026.7627508851815, 1042.3381152967768, 17211.741823872653, 17834.46496605104, 17959.461216163538, 18076.909615451837, 18602.0, 914.3690853311194, 936.438137117724, 953.7949340891741, 976.4190306767462, 1020.9183265338755, 9946.154576861049, 9972.052654997764, 10178.389296642225, 10267.075963163352, 10409.271351005356, 451620.0, 452481.2127818085, 452678.0, 468526.0, 475382.0, 85088.57455712682, 89856.0, 91467.0, 92706.53646731858, 93343.0, 1049.8740151181908, 1062.8724553053682, 1103.7626910214342, 1113.504490501719, 1129.6667483092508, 16969.830301696824, 17198.742018869478, 17302.04838733882, 17320.0, 17357.47927562175, 39234.0, 40271.0, 40512.59487405088, 41018.79490602528, 41380.58619413888, 53862.730686346316, 55344.72327638336, 55403.0, 55547.72226139005, 56366.15450768324, 8443.788905277417, 8633.266172375419, 8729.214370706666, 8744.387892847439, 9089.636414543344, 9662.855057174289, 13380.130291531019, 13630.0, 13699.794503082263, 14025.649358766112, 11731.296122232694, 11951.820722689341, 11991.64025079249, 12113.212641178296, 12244.265344079384, 11856.0, 11896.881031189578, 11965.940170299442, 12227.510899563918, 12265.202761820454, 11532.94233528827, 11915.76168476643, 12108.878911210775, 12330.19853709506, 12439.440225190068, 8643.740687779376, 8765.211130998241, 8891.422057566237, 8935.659651052394, 9021.007689154056, 12300.938495307466, 12345.38273086324, 12429.0, 12431.751364972832, 12496.625101246977], "value": 9000.09927838077, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1542.2674229740874, 1606.196901549225, 1705.1303835044139, 1814.9183286752095, 1929.8745581537198, 7937.841243175148, 8520.957395213023, 8563.10087440819, 8991.685291014815, 8992.595333210013, 8540.316774658027, 8789.692360767358, 8852.734417967455, 8854.955725221382, 8876.423032502882, 2297.655351697242, 2367.6093444581625, 2371.027878569787, 2371.7391086980506, 2374.0385144016614, 2309.064828744353, 2349.4126468382906, 2378.2508509819436, 2380.4048987753063, 2394.2697477269426, 2328.790408863202, 2355.269866341431, 2370.502194539149, 2375.287413775869, 2376.0, 2254.2673631069806, 2266.286119872235, 2283.4177284792436, 2305.2853615379204, 2334.8132149428006, 2308.499475341025, 2322.941926451835, 2329.126577533425, 2333.404981729648, 2337.9181728639587, 8644.351673624504, 8666.133386661346, 8675.0, 8723.127687231226, 8741.25699315559, 5114.718690472023, 5176.352955880515, 5245.055889939809, 5259.421463638997, 5293.814716484943, 3329.317489914586, 3436.4501679731375, 3461.048211741766, 3487.5814902211896, 3501.089716673683, 1053.3627155570923, 1059.0838924330399, 1095.5453486803046, 2162.632352500063, 2193.3529608765452, 11391.0, 11709.297442153498, 11756.94121529387, 11807.11446641514, 12027.158098933078, 4562.019165879352, 4602.815887364535, 4608.078384323148, 4655.185342565105, 4755.476897541268, 9200.125988031126, 9232.446053236827, 9263.0, 9355.204807591432, 9357.625694972261, 5084.3644544431945, 5175.689458632419, 5187.481251874782, 5207.297014903015, 5223.869403264949, 4377.299632058855, 4805.879853003703, 4845.63657725672, 4894.657373983787, 4949.109160351171, 3888.786116763605, 3894.4742459768136, 4000.7799571023293, 4021.8994525136522, 4041.2321658884716, 1189.6193218170104, 1206.6983254186453, 1232.5994051933158, 1236.5486597392066, 1247.4324182496941, 836.7615229659518, 843.9957800210959, 850.7830503221638, 855.6235256487125, 872.4242000279785, 5371.57027437804, 5596.86007849807, 5777.913331300034, 5782.855428614318, 5910.143029260733, 444.8109553439775, 448.854122410218, 449.49207395642713, 459.2239115894195, 470.1419908666697, 3720.720945929066, 3749.1939233065023, 3752.962470375316, 3774.301754175486, 3791.545014598266, 10667.51996160159, 10955.287906286067, 11083.279586826831, 11130.276532025393, 11131.276467029616, 10206.336588121749, 10746.194035447374, 10750.677479675622, 10933.343999360064, 10952.0, 7971.083325417535, 8013.519188848688, 8058.476199047043, 8074.878876816852, 8147.144549822302, 5970.880582388241, 6004.939950600438, 6030.1256317832795, 6039.124326972652, 6169.444749972524, 9560.330776845554, 10020.448875311637, 10098.697039088838, 10194.796104078025, 10333.74165645865, 10181.185505159718, 10205.234607404325, 10352.585896564355, 10427.270091093551, 10498.947505262426, 7391.778246652609, 7396.0754905636795, 7436.59098749574, 7456.105267367733, 7487.812804679708, 8227.0, 8230.300424463987, 8241.752747417588, 8274.462159959583, 8286.212809783061, 7154.391876690332, 7354.043974283309, 7382.2617738225745, 7566.24337566239, 7630.465867389452, 7276.927230727837, 7354.154272258758, 7388.408927285912, 7436.144843343085, 7452.21751716062, 6856.965715171392, 6901.344372284625, 6924.549904256207, 6933.0, 6934.06390137325, 4628.699134556243, 4732.408448943882, 4766.1659209638865, 4766.6901651392545, 4783.425988881357, 4851.58761505276, 4907.043126590281, 4989.027139707868, 4996.675216110941, 5111.948880511147], "value": 4508.62500153332, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [334.7539558424559, 335.8606178435949, 337.886807919347, 340.58958954459877, 345.5732170769101, 5503.944960550399, 5563.636908957306, 5669.177969194469, 5701.0, 5731.856703582413, 5558.666480011202, 5598.636088654234, 5609.80365687201, 5625.606207565472, 5643.830685079454, 4171.207470580595, 4378.8248470061235, 4409.456690158451, 4411.095725376306, 4424.115176964604, 4198.727082739628, 4298.742075475466, 4302.849400270991, 4305.461817272841, 4322.805473753689, 4246.40550322955, 4289.506706728719, 4295.9785201073955, 4304.203722311367, 4305.483341998949, 4301.612854843048, 4304.203722311367, 4316.158349121891, 4329.177456283296, 4331.718438301532, 3561.2343346180437, 3748.3815170496837, 3762.830672619739, 3766.6421689939684, 3768.7361884668085, 5348.171033489815, 5359.705216213107, 5360.249565060894, 5378.892422151535, 5397.8380648580605, 4900.191468407708, 4931.742405686563, 4954.479779623124, 4958.429780575244, 4985.700857948535, 5667.546596272329, 5755.30936287644, 5769.221155144044, 5779.306483222041, 5788.797392091299, 4137.91724165518, 4147.398627199039, 4158.521769996459, 4165.083681590046, 4170.603792639695, 5905.0, 6129.233845769279, 6131.325554189036, 6159.35326790685, 6202.658853763041, 4123.505179378494, 4127.422160897477, 4159.542450330461, 4173.288951529858, 4174.666026717855, 4208.537060923296, 4215.59951804578, 4218.409422680827, 4234.132002939452, 4238.919075635693, 4879.438864530624, 4879.902401951941, 4883.4628190898975, 4922.433920099163, 4942.5304596063315, 5814.389489103668, 5900.409959004065, 5904.468597826216, 5907.970460147758, 5940.46535811779, 1474.992625036868, 1486.145466356849, 1490.4499320706343, 1496.1247670113105, 1497.2214448486725, 908.8046070094962, 929.0894922975386, 942.58997336159, 947.8388673925311, 952.3999680536626, 5092.236164575269, 5599.860003499945, 5669.40471250521, 5717.913596416667, 5773.653580785166, 6037.607555508878, 6082.635041897412, 6094.939050609526, 6100.23747031621, 6104.389561043949, 5544.473275038865, 5678.801241956512, 5697.230873832063, 5724.942750572441, 5741.19623252745, 3227.580414546141, 3250.3499300140065, 3251.9349613007607, 3265.6407795142513, 3270.6238782540313, 6248.4688801452385, 6266.968665156736, 6291.213598300213, 6306.779262725782, 6355.332690067568, 5881.3530511643685, 6271.247450305901, 6286.434220920048, 6302.621842689453, 6341.446345645347, 6375.458086062644, 6382.170317858741, 6391.1371964785085, 6400.615963042233, 6420.582662126947, 5965.254343207099, 6087.299960504599, 6128.601640893327, 6129.946467933292, 6132.17215675878, 6035.547333949883, 6045.183900173421, 6083.330833608211, 6095.664738439428, 6096.695165241631, 6090.451859332681, 6379.681015949277, 6394.232692076795, 6406.1031455597185, 6419.55063145594, 4319.308910574293, 4349.434573505424, 4358.368036634607, 4379.912401751883, 4385.166818304512, 6150.323464419, 6183.84540386476, 6216.906746398718, 6230.345813689679, 6243.656598887105, 5712.657525481592, 5965.28416590012, 5975.25309336333, 5983.910241346296, 6002.069679199731, 5915.674637894957, 5975.954208013493, 6006.687425341188, 6017.87964240704, 6039.849003774941, 5701.572382071278, 5801.680907550125, 5808.273965754281, 5834.620749651429, 5871.588988770916, 5948.791792287249, 5951.226340575698, 5979.970100149471, 6028.849278768066, 6039.094135879654, 5785.247917770663, 5916.378780228014, 5937.5249980000635, 5940.198073260054, 5966.284045914518], "value": 4477.521833507494, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [690.0803436480787, 696.9128858892635, 728.1517032656955, 758.2190343945734, 764.2548515197683, 11749.588764393247, 12578.874211257884, 12614.621561353151, 12625.810612840814, 12640.810387844189, 12079.818802717966, 12145.75708485832, 12209.877901221007, 12229.143959922809, 12255.0, 670.5473805181507, 797.9680812767482, 810.5177419435456, 813.0771574263224, 833.679033572076, 816.1145157504086, 817.1828171828172, 819.213554987213, 821.5153059694779, 826.4834478450969, 877.784942689042, 884.7920738626418, 884.8451520983803, 885.7741275974618, 887.9422837515573, 868.097178933908, 870.2081106193365, 875.5403413208053, 876.4653561327617, 878.4334104502624, 633.6768248193408, 636.7325723196269, 637.2130418932614, 638.798778384812, 641.5669423139409, 12049.879501204963, 12157.209781364272, 12216.389180541026, 12226.816597751042, 12239.632811015596, 12272.509099636003, 12525.123241373107, 12620.68448288791, 12709.74580508394, 12949.741005179843, 9326.766830829216, 9637.277204209713, 9654.71035868925, 9890.15933645641, 9910.306278560503, 3646.2707458508403, 3655.3785856404475, 3663.084228942764, 3691.409374500094, 3755.887323380303, 52290.7385463074, 53931.0, 54249.45750542523, 54268.0, 54657.45342546563, 9845.901540984498, 9896.653617123366, 10050.949745251228, 10271.897281027244, 10685.62600309001, 18750.1562429691, 18904.52738681544, 18924.0, 18974.14616342268, 19044.333448329242, 7175.569465832067, 7239.0, 7267.745628902963, 7317.451191160684, 7353.080864891888, 4289.442372491556, 4289.549597292302, 4408.647308215335, 4415.161119387306, 4469.932951005738, 3272.2473831018997, 3275.606927168755, 3374.662533746655, 3382.5771778527683, 3397.048826328632, 700.2087640965779, 707.4375871182423, 709.3155105323387, 710.2613282186571, 715.8675645005586, 608.5587948737218, 652.663878102768, 657.3393739291981, 663.6283681138577, 680.1430197950618, 8878.73363799087, 9246.0, 9364.484953327632, 9389.859152112724, 9392.90607093934, 668.8628831089615, 672.6334147889412, 682.331315310998, 688.1810645332039, 690.8083555866091, 4491.30384790358, 4526.026904215543, 4543.636509079266, 4742.193827049341, 4907.1167189905445, 66174.0, 66256.33743662502, 67546.0, 68432.6578367105, 69583.65208173927, 55395.0, 56154.0, 58609.70695146497, 60145.398546014854, 60769.39230607726, 50930.23604645933, 52131.73934130381, 53148.46851531512, 53588.73205633947, 53764.46235537673, 8781.780455488664, 8959.148880856308, 9010.098990100938, 9065.90934090677, 9136.223421009288, 33524.32951340911, 33895.66104338925, 34005.65994340025, 34274.48588271228, 34774.0, 41377.793111034254, 41771.7911410441, 46539.37112201057, 47406.0, 48247.0, 10588.682339529827, 10698.62554810578, 10888.0, 10917.454127293762, 11050.226484146355, 11924.701882453008, 12253.509859605516, 12520.060995425198, 12654.177478463871, 13022.869771302545, 11001.834972475259, 12144.574939877415, 12337.136400451882, 12660.683482913, 12937.611871643865, 11954.282743035446, 12595.74808503843, 12813.871861281641, 12888.291143987171, 12951.093423460266, 10983.121350292116, 11338.94330528375, 11471.56605424322, 11548.307101573933, 11788.233764805604, 9540.427574345562, 9584.37701549397, 9701.0, 10363.32638378503, 10566.947165264124, 9984.700458986243, 10130.949345253226, 10263.538140783832, 10511.211659125443, 10550.683479495627], "value": 6515.958107427289, "unit": "score"}], "name": "dromaeo_css", "value": 7003.558737340812, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 115.0, 104.0, 110.0, 111.0, 113.0, 106.0, 111.0, 113.0, 114.0], "value": 110.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 125.0, 164.0, 204.0, 125.0, 157.0, 155.0, 130.0, 186.0, 130.0], "value": 152.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 168.0, 161.0, 160.0, 164.0, 169.0, 166.0, 165.0, 164.0, 162.0], "value": 164.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 166.0, 75.0, 74.0, 74.0, 77.0, 172.0, 76.0], "value": 94.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 92.0, 186.0, 92.0, 92.0, 93.0, 148.0, 92.0, 92.0, 143.0], "value": 112.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 118.0, 117.0, 118.0, 118.0, 117.0, 118.0, 117.0, 118.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 147.0, 147.0, 147.0, 147.0, 146.0, 147.0, 146.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 62.0, 67.0, 60.0, 63.0, 62.0, 62.0, 119.0, 61.0, 60.0], "value": 67.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 61.0, 59.0, 59.0, 59.0, 58.0, 59.0, 59.0, 59.0], "value": 59.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 78.0, 79.0, 79.0, 83.0, 82.0, 81.0, 79.0, 79.0], "value": 80.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 126.0, 131.0, 124.0, 127.0, 136.0, 126.0, 137.0, 206.0, 129.0], "value": 136.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 176.0, 174.0, 175.0, 173.0, 167.0, 169.0, 173.0, 170.0, 174.0], "value": 172.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 65.0, 67.0, 65.0, 62.0, 77.0, 64.0, 63.0, 64.0, 64.0], "value": 65.8, "unit": "score"}], "name": "kraken", "value": 1576.1, "alertThreshold": 2.0}]} 14:38:17 INFO - Return code: 0 14:38:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 14:38:17 ERROR - # TBPL SUCCESS # 14:38:17 INFO - Running post-action listener: _resource_record_post_action 14:38:17 INFO - ##### 14:38:17 INFO - ##### Finished run-tests step (success) 14:38:17 INFO - ##### 14:38:17 INFO - Running post-run listener: _resource_record_post_run 14:38:18 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 7675904; Write bytes: 356061184; Read time: 2896; Write time: 847984 14:38:18 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 15372288; Read time: 0; Write time: 58792 14:38:18 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 5939200; Write bytes: 340688896; Read time: 2820; Write time: 789192 14:38:18 INFO - Running post-run listener: _upload_blobber_files 14:38:18 INFO - Blob upload gear active. 14:38:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:38:18 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 14:38:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:38:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:38:18 INFO - (blobuploader) - INFO - Open directory for files ... 14:38:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:38:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:38:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:38:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:38:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:38:19 INFO - (blobuploader) - INFO - Done attempting. 14:38:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:38:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:38:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:38:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:38:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:38:20 INFO - (blobuploader) - INFO - Done attempting. 14:38:20 INFO - (blobuploader) - INFO - Iteration through files over. 14:38:20 INFO - Return code: 0 14:38:20 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:38:20 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:38:20 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c68937ae8658db636fdb6d476730450c42fb7e31a0e623015d93197696a67e9b39e413ad9e6754497bcabc27e617aeb376e7959b81a2e19c5cf13912f778e6a8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/29f0554a587431350afbcdd651eb44d932cc450874278ddbb0fa1dd328d32b5e35651c73c52ff894e1722eb2cd3840486946a67da3c1281f4acf74ccab7e07cb"} 14:38:20 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:38:20 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:38:20 INFO - Contents: 14:38:20 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c68937ae8658db636fdb6d476730450c42fb7e31a0e623015d93197696a67e9b39e413ad9e6754497bcabc27e617aeb376e7959b81a2e19c5cf13912f778e6a8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/29f0554a587431350afbcdd651eb44d932cc450874278ddbb0fa1dd328d32b5e35651c73c52ff894e1722eb2cd3840486946a67da3c1281f4acf74ccab7e07cb"} 14:38:20 INFO - Running post-run listener: copy_logs_to_upload_dir 14:38:20 INFO - Copying logs to upload dir... 14:38:20 INFO - mkdir: /builds/slave/test/build/upload/logs 14:38:20 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.087085 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2016-05-11 14:38:20.605877) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-11 14:38:20.608976) ========= 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=df17445c3590ff7897617a0e00000225-1463001443.698483-1944011536 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c68937ae8658db636fdb6d476730450c42fb7e31a0e623015d93197696a67e9b39e413ad9e6754497bcabc27e617aeb376e7959b81a2e19c5cf13912f778e6a8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/29f0554a587431350afbcdd651eb44d932cc450874278ddbb0fa1dd328d32b5e35651c73c52ff894e1722eb2cd3840486946a67da3c1281f4acf74ccab7e07cb"} 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.011238 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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c68937ae8658db636fdb6d476730450c42fb7e31a0e623015d93197696a67e9b39e413ad9e6754497bcabc27e617aeb376e7959b81a2e19c5cf13912f778e6a8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/29f0554a587431350afbcdd651eb44d932cc450874278ddbb0fa1dd328d32b5e35651c73c52ff894e1722eb2cd3840486946a67da3c1281f4acf74ccab7e07cb"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-11 14:38:20.634024) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 14:38:20.634380) ========= 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=df17445c3590ff7897617a0e00000225-1463001443.698483-1944011536 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004445 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 14:38:20.717820) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-11 14:38:20.718145) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-11 14:38:20.718479) ========= ========= Total master_lag: 0.16 =========