builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-002 starttime: 1463176449.23 results: success (0) buildid: 20160513141635 builduid: ad73b1041e544987aec70d10bb2a87f1 revision: c4a209a8e2a8483f71182ecfa6044b830fd85362 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-13 14:54:09.235055) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-13 14:54:09.236103) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-13 14:54:09.236776) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-13 14:54:09.254116) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 14:54:09.254812) ========= 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=a0d2d2de893abaa8702a9954000001a7-1463176446.751826-2092259595 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-13 14:54:09-- 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% 45.4M=0s 2016-05-13 14:54:10 (45.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.129005 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 14:54:09.402161) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 14:54:09.402911) ========= 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=a0d2d2de893abaa8702a9954000001a7-1463176446.751826-2092259595 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014715 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 14:54:09.458146) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 14:54:09.458995) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev c4a209a8e2a8483f71182ecfa6044b830fd85362 --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 c4a209a8e2a8483f71182ecfa6044b830fd85362 --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=a0d2d2de893abaa8702a9954000001a7-1463176446.751826-2092259595 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-13 14:54:10,217 truncating revision to first 12 chars 2016-05-13 14:54:10,217 Setting DEBUG logging. 2016-05-13 14:54:10,217 attempt 1/10 2016-05-13 14:54:10,217 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/c4a209a8e2a8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-13 14:54:10,478 unpacking tar archive at: fx-team-c4a209a8e2a8/testing/mozharness/ program finished with exit code 0 elapsedTime=0.561636 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 14:54:10.035617) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-13 14:54:10.035978) ========= script_repo_revision: c4a209a8e2a8483f71182ecfa6044b830fd85362 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-13 14:54:10.036443) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-13 14:54:10.036761) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-13 14:54:10.047929) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-05-13 14:54:10.048404) ========= /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=a0d2d2de893abaa8702a9954000001a7-1463176446.751826-2092259595 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:54:10 INFO - MultiFileLogger online at 20160513 14:54:10 in /builds/slave/test 14:54:10 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:54:10 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:54:10 INFO - {'append_to_log': False, 14:54:10 INFO - 'base_work_dir': '/builds/slave/test', 14:54:10 INFO - 'blob_upload_branch': 'Fx-Team', 14:54:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:54:10 INFO - 'branch': 'Fx-Team', 14:54:10 INFO - 'buildbot_json_path': 'buildprops.json', 14:54:10 INFO - 'config_files': ('talos/linux_config.py',), 14:54:10 INFO - 'default_actions': ('clobber', 14:54:10 INFO - 'read-buildbot-config', 14:54:10 INFO - 'download-and-extract', 14:54:10 INFO - 'populate-webroot', 14:54:10 INFO - 'create-virtualenv', 14:54:10 INFO - 'install', 14:54:10 INFO - 'run-tests'), 14:54:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:54:10 INFO - 'download_minidump_stackwalk': True, 14:54:10 INFO - 'download_symbols': 'ondemand', 14:54:10 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:54:10 INFO - 'tooltool.py': '/tools/tooltool.py', 14:54:10 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:54:10 INFO - '/tools/misc-python/virtualenv.py')}, 14:54:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:54:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:54:10 INFO - 'installer_path': 'installer.exe', 14:54:10 INFO - 'log_level': 'info', 14:54:10 INFO - 'log_name': 'talos', 14:54:10 INFO - 'log_to_console': True, 14:54:10 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:54:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:54:10 INFO - 'opt_config_files': (), 14:54:10 INFO - 'pip_index': False, 14:54:10 INFO - 'sps_profile': False, 14:54:10 INFO - 'sps_profile_interval': 0, 14:54:10 INFO - 'suite': 'dromaeojs-e10s', 14:54:10 INFO - 'system_bits': '32', 14:54:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:54:10 INFO - 'title': 'talos-linux64-ix-002', 14:54:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:54:10 INFO - 'use_talos_json': True, 14:54:10 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:54:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:54:10 INFO - 'work_dir': 'build'} 14:54:10 INFO - ##### 14:54:10 INFO - ##### Running clobber step. 14:54:10 INFO - ##### 14:54:10 INFO - Running pre-action listener: _resource_record_pre_action 14:54:10 INFO - Running main action method: clobber 14:54:10 INFO - rmtree: /builds/slave/test/build 14:54:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:54:11 INFO - Running post-action listener: _resource_record_post_action 14:54:11 INFO - ##### 14:54:11 INFO - ##### Finished clobber step (success) 14:54:11 INFO - ##### 14:54:11 INFO - ##### 14:54:11 INFO - ##### Running read-buildbot-config step. 14:54:11 INFO - ##### 14:54:11 INFO - Running pre-action listener: _resource_record_pre_action 14:54:11 INFO - Running main action method: read_buildbot_config 14:54:11 INFO - Using buildbot properties: 14:54:11 INFO - { 14:54:11 INFO - "project": "", 14:54:11 INFO - "product": "firefox", 14:54:11 INFO - "script_repo_revision": "production", 14:54:11 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 14:54:11 INFO - "repository": "", 14:54:11 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 14:54:11 INFO - "buildid": "20160513141635", 14:54:11 INFO - "stage_platform": "linux64-pgo", 14:54:11 INFO - "basedir": "/builds/slave/test", 14:54:11 INFO - "buildnumber": 741, 14:54:11 INFO - "platform": "ubuntu64_hw", 14:54:11 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 14:54:11 INFO - "slavebuilddir": "test", 14:54:11 INFO - "branch": "fx-team", 14:54:11 INFO - "revision": "c4a209a8e2a8483f71182ecfa6044b830fd85362", 14:54:11 INFO - "slavename": "talos-linux64-ix-002", 14:54:11 INFO - "builduid": "ad73b1041e544987aec70d10bb2a87f1", 14:54:11 INFO - "repo_path": "integration/fx-team" 14:54:11 INFO - } 14:54:11 INFO - Found installer url http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1463164213/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 14:54:11 INFO - Found a test packages url http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1463164213/firefox-49.0a1.en-US.linux-x86_64.test_packages.json. 14:54:11 INFO - Running post-action listener: _resource_record_post_action 14:54:11 INFO - ##### 14:54:11 INFO - ##### Finished read-buildbot-config step (success) 14:54:11 INFO - ##### 14:54:11 INFO - ##### 14:54:11 INFO - ##### Running download-and-extract step. 14:54:11 INFO - ##### 14:54:11 INFO - Running pre-action listener: _resource_record_pre_action 14:54:11 INFO - Running main action method: download_and_extract 14:54:11 INFO - mkdir: /builds/slave/test/build/tests 14:54: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:54:11 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1463164213/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 14:54:11 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1463164213/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:54:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1463164213/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:54:11 INFO - Downloaded 1361 bytes. 14:54:11 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 14:54:11 INFO - Using the following test package requirements: 14:54:11 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 14:54:11 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:54:11 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:54:11 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:54:11 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:54:11 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:54:11 INFO - u'jsshell-linux-x86_64.zip'], 14:54:11 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:54:11 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:54:11 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 14:54:11 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:54:11 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:54:11 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:54:11 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:54:11 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:54:11 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:54:11 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:54:11 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:54:11 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:54: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:54:11 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1463164213/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:54:11 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1463164213/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:54:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1463164213/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:54:11 INFO - Downloaded 23909523 bytes. 14:54:11 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:54:11 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:54:13 INFO - Return code: 0 14:54:13 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:54:13 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:54:13 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1463164213/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:54:13 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1463164213/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:54:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1463164213/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:54:13 INFO - Downloaded 23909523 bytes. 14:54:13 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:54:13 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:54:15 INFO - Return code: 0 14:54:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:54:15 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1463164213/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 14:54:15 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1463164213/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:54:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1463164213/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:54:15 INFO - Downloaded 10840239 bytes. 14:54:15 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:54:15 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:54:15 INFO - Return code: 0 14:54:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:54:15 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1463164213/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:54:15 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1463164213/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:54:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1463164213/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:54:16 INFO - Downloaded 58399498 bytes. 14:54:16 INFO - Setting buildbot property build_url to http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1463164213/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:54:16 INFO - mkdir: /builds/slave/test/properties 14:54:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:54:16 INFO - Writing to file /builds/slave/test/properties/build_url 14:54:16 INFO - Contents: 14:54:16 INFO - build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1463164213/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:54:16 INFO - Running post-action listener: _resource_record_post_action 14:54:16 INFO - Running post-action listener: set_extra_try_arguments 14:54:16 INFO - ##### 14:54:16 INFO - ##### Finished download-and-extract step (success) 14:54:16 INFO - ##### 14:54:16 INFO - ##### 14:54:16 INFO - ##### Running populate-webroot step. 14:54:16 INFO - ##### 14:54:16 INFO - Running pre-action listener: _resource_record_pre_action 14:54:16 INFO - Running main action method: populate_webroot 14:54:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:54:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:54:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:54:16 INFO - '--tppagecycles', 14:54:16 INFO - '7'], 14:54:16 INFO - 'tests': ['tsvgm']}}, 14:54:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:54:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:54:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:54:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:54:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:54:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:54:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:54:16 INFO - 'talos_options': ['--disable-e10s'], 14:54:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:54:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:54:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:54:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:54:16 INFO - 'talos_options': ['--disable-e10s'], 14:54:16 INFO - 'tests': ['damp', 'tps']}, 14:54:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:54:16 INFO - 'tests': ['damp', 'tps']}, 14:54:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:54:16 INFO - 'tests': ['dromaeo_dom']}, 14:54:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:54:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:54:16 INFO - 'tests': ['a11yr', 14:54:16 INFO - 'ts_paint', 14:54:16 INFO - 'tpaint', 14:54:16 INFO - 'sessionrestore', 14:54:16 INFO - 'sessionrestore_no_auto_restore', 14:54:16 INFO - 'tabpaint']}, 14:54:16 INFO - 'other-e10s': {'tests': ['a11yr', 14:54:16 INFO - 'ts_paint', 14:54:16 INFO - 'tpaint', 14:54:16 INFO - 'sessionrestore', 14:54:16 INFO - 'sessionrestore_no_auto_restore', 14:54:16 INFO - 'tabpaint']}, 14:54:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:54:16 INFO - 'ts_paint', 14:54:16 INFO - 'tpaint', 14:54:16 INFO - 'sessionrestore', 14:54:16 INFO - 'sessionrestore_no_auto_restore', 14:54:16 INFO - 'tabpaint']}, 14:54:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:54:16 INFO - 'ts_paint', 14:54:16 INFO - 'tpaint', 14:54:16 INFO - 'sessionrestore', 14:54:16 INFO - 'sessionrestore_no_auto_restore', 14:54:16 INFO - 'tabpaint']}, 14:54:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:54:16 INFO - 'tests': ['a11yr', 14:54:16 INFO - 'ts_paint', 14:54:16 INFO - 'tpaint', 14:54:16 INFO - 'sessionrestore', 14:54:16 INFO - 'sessionrestore_no_auto_restore', 14:54:16 INFO - 'tabpaint']}, 14:54:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:54:16 INFO - 'tests': ['a11yr', 14:54:16 INFO - 'ts_paint', 14:54:16 INFO - 'tpaint', 14:54:16 INFO - 'sessionrestore', 14:54:16 INFO - 'sessionrestore_no_auto_restore', 14:54:16 INFO - 'tabpaint']}, 14:54:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:54:16 INFO - 'tests': ['tsvgx', 14:54:16 INFO - 'tsvgr_opacity', 14:54:16 INFO - 'tart', 14:54:16 INFO - 'tscrollx', 14:54:16 INFO - 'cart']}, 14:54:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:54:16 INFO - 'tsvgr_opacity', 14:54:16 INFO - 'tart', 14:54:16 INFO - 'tscrollx', 14:54:16 INFO - 'cart']}, 14:54:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:54:16 INFO - 'talos_options': ['--disable-e10s'], 14:54:16 INFO - 'tests': ['tp5o']}, 14:54:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:54:16 INFO - 'tests': ['tp5o']}, 14:54:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:54:16 INFO - 'talos_options': ['--disable-e10s', 14:54:16 INFO - '--xperf_path', 14:54:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:54:16 INFO - 'tests': ['tp5n']}, 14:54:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:54:16 INFO - 'talos_options': ['--xperf_path', 14:54:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:54:16 INFO - 'tests': ['tp5n']}}, 14:54:16 INFO - 'talos.zip': {'path': '', 14:54:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:54:16 INFO - Running post-action listener: _resource_record_post_action 14:54:16 INFO - ##### 14:54:16 INFO - ##### Finished populate-webroot step (success) 14:54:16 INFO - ##### 14:54:16 INFO - ##### 14:54:16 INFO - ##### Running create-virtualenv step. 14:54:16 INFO - ##### 14:54:16 INFO - Running pre-action listener: _resource_record_pre_action 14:54:16 INFO - Running main action method: create_virtualenv 14:54:16 INFO - Creating virtualenv /builds/slave/test/build/venv 14:54:16 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:54:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:54:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:54:16 INFO - Using real prefix '/usr' 14:54:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:54:17 INFO - Installing distribute.............................................................................................................................................................................................done. 14:54:19 INFO - Installing pip.................done. 14:54:19 INFO - Return code: 0 14:54:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:54:19 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:54:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:54:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54:19 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:54:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:54:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54:19 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 0x7fd36ae70f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2af4770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b839c0>, '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 0x2b848c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b84d50>, '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': 'a0d2d2de893abaa8702a9954000001a7-1463176446.751826-2092259595', '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:54:19 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:54:19 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:54:19 INFO - Using env: {'DISPLAY': ':0', 14:54:19 INFO - 'HOME': '/home/cltbld', 14:54:19 INFO - 'LANG': 'en_US.UTF-8', 14:54:19 INFO - 'LANGUAGE': 'en_US:en', 14:54:19 INFO - 'LOGNAME': 'cltbld', 14:54:19 INFO - 'MAIL': '/var/mail/cltbld', 14:54:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:54:19 INFO - 'MOZ_NO_REMOTE': '1', 14:54:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:54:19 INFO - 'NO_EM_RESTART': '1', 14:54:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:54:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:54:19 INFO - 'PWD': '/builds/slave/test', 14:54:19 INFO - 'SHELL': '/bin/bash', 14:54:19 INFO - 'SHLVL': '1', 14:54:19 INFO - 'TERM': 'linux', 14:54:19 INFO - 'TMOUT': '86400', 14:54:19 INFO - 'USER': 'cltbld', 14:54:19 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1463176446.751826-2092259595', 14:54:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:54:19 INFO - '_': '/tools/buildbot/bin/python'} 14:54:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:54:19 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:54:19 INFO - Cleaning up... 14:54:19 INFO - Return code: 0 14:54:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:54:19 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:54:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:54:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54:19 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:54:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:54:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54:19 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>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd36ae70f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2af4770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b839c0>, '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 0x2b848c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b84d50>, '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': 'a0d2d2de893abaa8702a9954000001a7-1463176446.751826-2092259595', '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:54:19 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>=3.1.1'] in /builds/slave/test/build 14:54:19 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>=3.1.1 14:54:19 INFO - Using env: {'DISPLAY': ':0', 14:54:19 INFO - 'HOME': '/home/cltbld', 14:54:19 INFO - 'LANG': 'en_US.UTF-8', 14:54:19 INFO - 'LANGUAGE': 'en_US:en', 14:54:19 INFO - 'LOGNAME': 'cltbld', 14:54:19 INFO - 'MAIL': '/var/mail/cltbld', 14:54:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:54:19 INFO - 'MOZ_NO_REMOTE': '1', 14:54:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:54:19 INFO - 'NO_EM_RESTART': '1', 14:54:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:54:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:54:19 INFO - 'PWD': '/builds/slave/test', 14:54:19 INFO - 'SHELL': '/bin/bash', 14:54:19 INFO - 'SHLVL': '1', 14:54:19 INFO - 'TERM': 'linux', 14:54:19 INFO - 'TMOUT': '86400', 14:54:19 INFO - 'USER': 'cltbld', 14:54:19 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1463176446.751826-2092259595', 14:54:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:54:19 INFO - '_': '/tools/buildbot/bin/python'} 14:54:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:54:19 INFO - Downloading/unpacking psutil>=3.1.1 14:54:19 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:54:19 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:54:19 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:54:19 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:54:19 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:54:19 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:54:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:54:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:54:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:54:21 INFO - Installing collected packages: psutil 14:54:21 INFO - Running setup.py install for psutil 14:54:21 INFO - building 'psutil._psutil_linux' extension 14:54:21 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:54:21 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:54:21 INFO - building 'psutil._psutil_posix' extension 14:54:21 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:54:22 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:54:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:54:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:54:22 INFO - Successfully installed psutil 14:54:22 INFO - Cleaning up... 14:54:22 INFO - Return code: 0 14:54:22 INFO - Installing mozsystemmonitor==0.1 into virtualenv /builds/slave/test/build/venv 14:54:22 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:54:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:54:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54:22 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:54:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:54:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54:22 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.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd36ae70f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2af4770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b839c0>, '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 0x2b848c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b84d50>, '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': 'a0d2d2de893abaa8702a9954000001a7-1463176446.751826-2092259595', '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:54:22 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.1'] in /builds/slave/test/build 14:54:22 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.1 14:54:22 INFO - Using env: {'DISPLAY': ':0', 14:54:22 INFO - 'HOME': '/home/cltbld', 14:54:22 INFO - 'LANG': 'en_US.UTF-8', 14:54:22 INFO - 'LANGUAGE': 'en_US:en', 14:54:22 INFO - 'LOGNAME': 'cltbld', 14:54:22 INFO - 'MAIL': '/var/mail/cltbld', 14:54:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:54:22 INFO - 'MOZ_NO_REMOTE': '1', 14:54:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:54:22 INFO - 'NO_EM_RESTART': '1', 14:54:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:54:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:54:22 INFO - 'PWD': '/builds/slave/test', 14:54:22 INFO - 'SHELL': '/bin/bash', 14:54:22 INFO - 'SHLVL': '1', 14:54:22 INFO - 'TERM': 'linux', 14:54:22 INFO - 'TMOUT': '86400', 14:54:22 INFO - 'USER': 'cltbld', 14:54:22 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1463176446.751826-2092259595', 14:54:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:54:22 INFO - '_': '/tools/buildbot/bin/python'} 14:54:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:54:22 INFO - Downloading/unpacking mozsystemmonitor==0.1 14:54:22 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:54:22 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:54:22 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:54:22 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:54:22 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:54:22 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:54:24 INFO - Downloading mozsystemmonitor-0.1.tar.gz 14:54:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:54:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.1) 14:54:24 INFO - Installing collected packages: mozsystemmonitor 14:54:24 INFO - Running setup.py install for mozsystemmonitor 14:54:24 INFO - Successfully installed mozsystemmonitor 14:54:24 INFO - Cleaning up... 14:54:24 INFO - Return code: 0 14:54:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:54:24 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:54:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:54:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54:24 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:54:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:54:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54:24 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 0x7fd36ae70f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2af4770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b839c0>, '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 0x2b848c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b84d50>, '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': 'a0d2d2de893abaa8702a9954000001a7-1463176446.751826-2092259595', '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:54:24 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:54:24 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:54:24 INFO - Using env: {'DISPLAY': ':0', 14:54:24 INFO - 'HOME': '/home/cltbld', 14:54:24 INFO - 'LANG': 'en_US.UTF-8', 14:54:24 INFO - 'LANGUAGE': 'en_US:en', 14:54:24 INFO - 'LOGNAME': 'cltbld', 14:54:24 INFO - 'MAIL': '/var/mail/cltbld', 14:54:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:54:24 INFO - 'MOZ_NO_REMOTE': '1', 14:54:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:54:24 INFO - 'NO_EM_RESTART': '1', 14:54:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:54:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:54:24 INFO - 'PWD': '/builds/slave/test', 14:54:24 INFO - 'SHELL': '/bin/bash', 14:54:24 INFO - 'SHLVL': '1', 14:54:24 INFO - 'TERM': 'linux', 14:54:24 INFO - 'TMOUT': '86400', 14:54:24 INFO - 'USER': 'cltbld', 14:54:24 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1463176446.751826-2092259595', 14:54:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:54:24 INFO - '_': '/tools/buildbot/bin/python'} 14:54:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:54:24 INFO - Downloading/unpacking blobuploader==1.2.4 14:54:24 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:54:24 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:54:24 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:54:24 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:54:24 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:54:24 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:54:26 INFO - Downloading blobuploader-1.2.4.tar.gz 14:54:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:54:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:54:26 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:54:26 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:54:26 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:54:26 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:54:26 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:54:26 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:54:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:54:27 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:54:27 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:54:27 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:54:27 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:54:27 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:54:27 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:54:27 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:54:27 INFO - Downloading docopt-0.6.1.tar.gz 14:54:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:54:27 INFO - Installing collected packages: blobuploader, requests, docopt 14:54:27 INFO - Running setup.py install for blobuploader 14:54:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:54:27 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:54:27 INFO - Running setup.py install for requests 14:54:27 INFO - Running setup.py install for docopt 14:54:27 INFO - Successfully installed blobuploader requests docopt 14:54:27 INFO - Cleaning up... 14:54:28 INFO - Return code: 0 14:54:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:54:28 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:54:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:54:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54:28 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:54:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:54:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54:28 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 0x7fd36ae70f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2af4770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b839c0>, '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 0x2b848c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b84d50>, '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': 'a0d2d2de893abaa8702a9954000001a7-1463176446.751826-2092259595', '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:54:28 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:54:28 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:54:28 INFO - Using env: {'DISPLAY': ':0', 14:54:28 INFO - 'HOME': '/home/cltbld', 14:54:28 INFO - 'LANG': 'en_US.UTF-8', 14:54:28 INFO - 'LANGUAGE': 'en_US:en', 14:54:28 INFO - 'LOGNAME': 'cltbld', 14:54:28 INFO - 'MAIL': '/var/mail/cltbld', 14:54:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:54:28 INFO - 'MOZ_NO_REMOTE': '1', 14:54:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:54:28 INFO - 'NO_EM_RESTART': '1', 14:54:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:54:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:54:28 INFO - 'PWD': '/builds/slave/test', 14:54:28 INFO - 'SHELL': '/bin/bash', 14:54:28 INFO - 'SHLVL': '1', 14:54:28 INFO - 'TERM': 'linux', 14:54:28 INFO - 'TMOUT': '86400', 14:54:28 INFO - 'USER': 'cltbld', 14:54:28 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1463176446.751826-2092259595', 14:54:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:54:28 INFO - '_': '/tools/buildbot/bin/python'} 14:54:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:54:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:54:28 INFO - Running setup.py (path:/tmp/pip-oPVayh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:54:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:54:28 INFO - Running setup.py (path:/tmp/pip-IVHUrL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:54:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:54:28 INFO - Running setup.py (path:/tmp/pip-rl56j6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:54:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:54:28 INFO - Running setup.py (path:/tmp/pip-Yo9GBP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:54:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:54:28 INFO - Running setup.py (path:/tmp/pip-8ILgVK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:54:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:54:28 INFO - Running setup.py (path:/tmp/pip-r6JiLn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:54:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:54:28 INFO - Running setup.py (path:/tmp/pip-STQUd2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:54:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:54:28 INFO - Running setup.py (path:/tmp/pip-6tbcIW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:54:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:54:28 INFO - Running setup.py (path:/tmp/pip-19ZzIv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:54:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:54:28 INFO - Running setup.py (path:/tmp/pip-YA5sO8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:54:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:54:28 INFO - Running setup.py (path:/tmp/pip-_dJisS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:54:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:54:29 INFO - Running setup.py (path:/tmp/pip-RnLUpK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:54:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:54:29 INFO - Running setup.py (path:/tmp/pip-j9sCEX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:54:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:54:29 INFO - Running setup.py (path:/tmp/pip-Bpcixn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:54:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:54:29 INFO - Running setup.py (path:/tmp/pip-pOteqF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:54:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:54:29 INFO - Running setup.py (path:/tmp/pip-RWm9NS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:54:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:54:29 INFO - Running setup.py (path:/tmp/pip-x1GF9b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:54:29 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:54:29 INFO - Running setup.py install for manifestparser 14:54:29 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:54:29 INFO - Running setup.py install for mozcrash 14:54:29 INFO - Running setup.py install for mozdebug 14:54:29 INFO - Running setup.py install for mozdevice 14:54:29 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:54:29 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:54:29 INFO - Running setup.py install for mozfile 14:54:30 INFO - Running setup.py install for mozhttpd 14:54:30 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:54:30 INFO - Running setup.py install for mozinfo 14:54:30 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:54:30 INFO - Running setup.py install for mozInstall 14:54:30 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:54:30 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:54:30 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:54:30 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:54:30 INFO - Running setup.py install for mozleak 14:54:30 INFO - Running setup.py install for mozlog 14:54:30 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:54:30 INFO - Running setup.py install for moznetwork 14:54:30 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:54:30 INFO - Running setup.py install for mozprocess 14:54:30 INFO - Running setup.py install for mozprofile 14:54:30 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:54:30 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:54:30 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:54:30 INFO - Running setup.py install for mozrunner 14:54:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:54:30 INFO - Running setup.py install for mozscreenshot 14:54:31 INFO - Running setup.py install for moztest 14:54:31 INFO - Running setup.py install for mozversion 14:54:31 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:54:31 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:54:31 INFO - Cleaning up... 14:54:31 INFO - Return code: 0 14:54:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:54: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:54:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:54:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54: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:54:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:54:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54:31 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 0x7fd36ae70f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2af4770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b839c0>, '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 0x2b848c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b84d50>, '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': 'a0d2d2de893abaa8702a9954000001a7-1463176446.751826-2092259595', '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:54:31 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:54:31 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:54:31 INFO - Using env: {'DISPLAY': ':0', 14:54:31 INFO - 'HOME': '/home/cltbld', 14:54:31 INFO - 'LANG': 'en_US.UTF-8', 14:54:31 INFO - 'LANGUAGE': 'en_US:en', 14:54:31 INFO - 'LOGNAME': 'cltbld', 14:54:31 INFO - 'MAIL': '/var/mail/cltbld', 14:54:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:54:31 INFO - 'MOZ_NO_REMOTE': '1', 14:54:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:54:31 INFO - 'NO_EM_RESTART': '1', 14:54:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:54:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:54:31 INFO - 'PWD': '/builds/slave/test', 14:54:31 INFO - 'SHELL': '/bin/bash', 14:54:31 INFO - 'SHLVL': '1', 14:54:31 INFO - 'TERM': 'linux', 14:54:31 INFO - 'TMOUT': '86400', 14:54:31 INFO - 'USER': 'cltbld', 14:54:31 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1463176446.751826-2092259595', 14:54:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:54:31 INFO - '_': '/tools/buildbot/bin/python'} 14:54:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:54:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:54:31 INFO - Running setup.py (path:/tmp/pip-sIyp4n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:54:31 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:54:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:54:31 INFO - Running setup.py (path:/tmp/pip-NEEfWu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:54:31 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:54:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:54:31 INFO - Running setup.py (path:/tmp/pip-9R_6dl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:54:31 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:54:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:54:31 INFO - Running setup.py (path:/tmp/pip-iN2vVM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:54:31 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:54:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:54:31 INFO - Running setup.py (path:/tmp/pip-Uf5tqu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:54:31 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:54:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:54:31 INFO - Running setup.py (path:/tmp/pip-NVV_Li-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:54:31 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:54:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:54:31 INFO - Running setup.py (path:/tmp/pip-f9Psr7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:54:32 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:54:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:54:32 INFO - Running setup.py (path:/tmp/pip-yXm2cQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:54:32 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:54:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:54:32 INFO - Running setup.py (path:/tmp/pip-iEEcS1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:54:32 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:54:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:54:32 INFO - Running setup.py (path:/tmp/pip-r2GbYS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:54:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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:54:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:54:32 INFO - Running setup.py (path:/tmp/pip-AviYlo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:54:32 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:54:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:54:32 INFO - Running setup.py (path:/tmp/pip-fvioUA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:54:32 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:54:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:54:32 INFO - Running setup.py (path:/tmp/pip-UFYhIB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:54:32 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:54:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:54:32 INFO - Running setup.py (path:/tmp/pip-vrENgA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:54:32 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:54:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:54:32 INFO - Running setup.py (path:/tmp/pip-xritdI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:54:32 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:54:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:54:32 INFO - Running setup.py (path:/tmp/pip-r2abH2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:54:32 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:54:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:54:32 INFO - Running setup.py (path:/tmp/pip-qEbPPT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:54:32 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:54:32 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:54:32 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:54:32 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:54:32 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:54:32 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:54:32 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:54:32 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:54:32 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:54:32 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:54:32 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:54:32 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:54:32 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:54:34 INFO - Downloading blessings-1.6.tar.gz 14:54:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:54:34 INFO - Installing collected packages: blessings 14:54:34 INFO - Running setup.py install for blessings 14:54:34 INFO - Successfully installed blessings 14:54:34 INFO - Cleaning up... 14:54:34 INFO - Return code: 0 14:54:34 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:54:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:54:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:54:35 INFO - Reading from file tmpfile_stdout 14:54:35 INFO - Current package versions: 14:54:35 INFO - argparse == 1.2.1 14:54:35 INFO - blessings == 1.6 14:54:35 INFO - blobuploader == 1.2.4 14:54:35 INFO - docopt == 0.6.1 14:54:35 INFO - manifestparser == 1.1 14:54:35 INFO - mozInstall == 1.12 14:54:35 INFO - mozcrash == 0.17 14:54:35 INFO - mozdebug == 0.1 14:54:35 INFO - mozdevice == 0.48 14:54:35 INFO - mozfile == 1.2 14:54:35 INFO - mozhttpd == 0.7 14:54:35 INFO - mozinfo == 0.9 14:54:35 INFO - mozleak == 0.1 14:54:35 INFO - mozlog == 3.2 14:54:35 INFO - moznetwork == 0.27 14:54:35 INFO - mozprocess == 0.22 14:54:35 INFO - mozprofile == 0.28 14:54:35 INFO - mozrunner == 6.11 14:54:35 INFO - mozscreenshot == 0.1 14:54:35 INFO - mozsystemmonitor == 0.1 14:54:35 INFO - moztest == 0.7 14:54:35 INFO - mozversion == 1.4 14:54:35 INFO - psutil == 3.1.1 14:54:35 INFO - requests == 1.2.3 14:54:35 INFO - wsgiref == 0.1.2 14:54:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:54: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:54:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:54:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54: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:54:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:54:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54:35 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 0x7fd36ae70f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2af4770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b839c0>, '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 0x2b848c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b84d50>, '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': 'a0d2d2de893abaa8702a9954000001a7-1463176446.751826-2092259595', '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:54:35 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:54:35 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:54:35 INFO - Using env: {'DISPLAY': ':0', 14:54:35 INFO - 'HOME': '/home/cltbld', 14:54:35 INFO - 'LANG': 'en_US.UTF-8', 14:54:35 INFO - 'LANGUAGE': 'en_US:en', 14:54:35 INFO - 'LOGNAME': 'cltbld', 14:54:35 INFO - 'MAIL': '/var/mail/cltbld', 14:54:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:54:35 INFO - 'MOZ_NO_REMOTE': '1', 14:54:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:54:35 INFO - 'NO_EM_RESTART': '1', 14:54:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:54:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:54:35 INFO - 'PWD': '/builds/slave/test', 14:54:35 INFO - 'SHELL': '/bin/bash', 14:54:35 INFO - 'SHLVL': '1', 14:54:35 INFO - 'TERM': 'linux', 14:54:35 INFO - 'TMOUT': '86400', 14:54:35 INFO - 'USER': 'cltbld', 14:54:35 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1463176446.751826-2092259595', 14:54:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:54:35 INFO - '_': '/tools/buildbot/bin/python'} 14:54:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:54:35 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:54:35 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:54:35 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:54:35 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:54:35 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:54:35 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:54:35 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:54:35 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:54:35 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:54:35 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:54:35 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:54:35 INFO - Cleaning up... 14:54:35 INFO - Return code: 0 14:54:35 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:54: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:54:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:54:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54: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:54:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:54:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54:35 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 0x7fd36ae70f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2af4770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b839c0>, '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 0x2b848c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b84d50>, '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': 'a0d2d2de893abaa8702a9954000001a7-1463176446.751826-2092259595', '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:54:35 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:54:35 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:54:35 INFO - Using env: {'DISPLAY': ':0', 14:54:35 INFO - 'HOME': '/home/cltbld', 14:54:35 INFO - 'LANG': 'en_US.UTF-8', 14:54:35 INFO - 'LANGUAGE': 'en_US:en', 14:54:35 INFO - 'LOGNAME': 'cltbld', 14:54:35 INFO - 'MAIL': '/var/mail/cltbld', 14:54:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:54:35 INFO - 'MOZ_NO_REMOTE': '1', 14:54:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:54:35 INFO - 'NO_EM_RESTART': '1', 14:54:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:54:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:54:35 INFO - 'PWD': '/builds/slave/test', 14:54:35 INFO - 'SHELL': '/bin/bash', 14:54:35 INFO - 'SHLVL': '1', 14:54:35 INFO - 'TERM': 'linux', 14:54:35 INFO - 'TMOUT': '86400', 14:54:35 INFO - 'USER': 'cltbld', 14:54:35 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1463176446.751826-2092259595', 14:54:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:54:35 INFO - '_': '/tools/buildbot/bin/python'} 14:54:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:54:35 INFO - Downloading/unpacking jsonschema 14:54:35 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:54:35 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:54:35 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:54:35 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:54:35 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:54:35 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:54:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:54:37 INFO - Downloading/unpacking functools32 (from jsonschema) 14:54:37 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:54:37 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:54:37 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:54:37 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:54:37 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:54:37 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:54:37 INFO - Downloading functools32-3.2.3-2.tar.gz 14:54:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:54:37 INFO - warning: no files found matching '*.txt' 14:54:37 INFO - no previously-included directories found matching 'build' 14:54:37 INFO - no previously-included directories found matching 'dist' 14:54:37 INFO - no previously-included directories found matching '.git*' 14:54:37 INFO - Installing collected packages: jsonschema, functools32 14:54:37 INFO - Running setup.py install for functools32 14:54:37 INFO - warning: no files found matching '*.txt' 14:54:37 INFO - no previously-included directories found matching 'build' 14:54:37 INFO - no previously-included directories found matching 'dist' 14:54:37 INFO - no previously-included directories found matching '.git*' 14:54:37 INFO - Successfully installed jsonschema functools32 14:54:37 INFO - Cleaning up... 14:54:37 INFO - Return code: 0 14:54:37 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:54:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:54:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:54:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:54:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:54:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54:37 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 0x7fd36ae70f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2af4770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b839c0>, '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 0x2b848c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b84d50>, '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': 'a0d2d2de893abaa8702a9954000001a7-1463176446.751826-2092259595', '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:54:37 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:54:37 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:54:37 INFO - Using env: {'DISPLAY': ':0', 14:54:37 INFO - 'HOME': '/home/cltbld', 14:54:37 INFO - 'LANG': 'en_US.UTF-8', 14:54:37 INFO - 'LANGUAGE': 'en_US:en', 14:54:37 INFO - 'LOGNAME': 'cltbld', 14:54:37 INFO - 'MAIL': '/var/mail/cltbld', 14:54:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:54:37 INFO - 'MOZ_NO_REMOTE': '1', 14:54:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:54:37 INFO - 'NO_EM_RESTART': '1', 14:54:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:54:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:54:37 INFO - 'PWD': '/builds/slave/test', 14:54:37 INFO - 'SHELL': '/bin/bash', 14:54:37 INFO - 'SHLVL': '1', 14:54:37 INFO - 'TERM': 'linux', 14:54:37 INFO - 'TMOUT': '86400', 14:54:37 INFO - 'USER': 'cltbld', 14:54:37 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1463176446.751826-2092259595', 14:54:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:54:37 INFO - '_': '/tools/buildbot/bin/python'} 14:54:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:54:38 INFO - Downloading/unpacking flake8 14:54:38 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:54:38 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:54:38 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:54:38 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:54:38 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:54:38 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:54:39 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:54:39 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:54:39 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:54:39 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:54:39 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:54:39 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:54:39 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:54:39 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:54:40 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:54:40 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:54:40 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:54:40 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:54:40 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:54:40 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:54:40 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:54:40 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:54:40 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:54:40 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:54:40 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:54:40 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:54:40 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:54:40 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:54:40 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:54:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:54:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:54:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:54:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:54:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:54:40 INFO - no previously-included directories found matching 'docs/_build' 14:54:40 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:54:40 INFO - Running setup.py install for pep8 14:54:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:54:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:54:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:54:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:54:40 INFO - no previously-included directories found matching 'docs/_build' 14:54:40 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:54:40 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:54:40 INFO - Cleaning up... 14:54:40 INFO - Return code: 0 14:54:40 INFO - Running post-action listener: _resource_record_post_action 14:54:40 INFO - Running post-action listener: _start_resource_monitoring 14:54:40 INFO - Starting resource monitoring. 14:54:40 INFO - ##### 14:54:40 INFO - ##### Finished create-virtualenv step (success) 14:54:40 INFO - ##### 14:54:40 INFO - ##### 14:54:40 INFO - ##### Running install step. 14:54:40 INFO - ##### 14:54:40 INFO - Running pre-action listener: _resource_record_pre_action 14:54:40 INFO - Running main action method: install 14:54:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:54:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:54:41 INFO - Reading from file tmpfile_stdout 14:54:41 INFO - Detecting whether we're running mozinstall >=1.0... 14:54:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:54:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:54:41 INFO - Reading from file tmpfile_stdout 14:54:41 INFO - Output received: 14:54:41 INFO - Usage: mozinstall [options] installer 14:54:41 INFO - Options: 14:54:41 INFO - -h, --help show this help message and exit 14:54:41 INFO - -d DEST, --destination=DEST 14:54:41 INFO - Directory to install application into. [default: 14:54:41 INFO - "/builds/slave/test"] 14:54:41 INFO - --app=APP Application being installed. [default: firefox] 14:54:41 INFO - mkdir: /builds/slave/test/build/application 14:54:41 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:54:41 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:54:57 INFO - Reading from file tmpfile_stdout 14:54:57 INFO - Output received: 14:54:57 INFO - /builds/slave/test/build/application/firefox/firefox 14:54:57 INFO - Running post-action listener: _resource_record_post_action 14:54:57 INFO - ##### 14:54:57 INFO - ##### Finished install step (success) 14:54:57 INFO - ##### 14:54:57 INFO - ##### 14:54:57 INFO - ##### Running run-tests step. 14:54:57 INFO - ##### 14:54:57 INFO - Running pre-action listener: _resource_record_pre_action 14:54:57 INFO - Running main action method: run_tests 14:54:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:54:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:54:57 INFO - Python 2.7.3 14:54:57 INFO - Return code: 0 14:54:57 INFO - grabbing minidump binary from tooltool 14:54:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:54:57 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 0x2b839c0>, '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 0x2b848c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b84d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:54:57 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:54:57 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:54:57 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:54:57 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:54:57 INFO - Return code: 0 14:54:57 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:54:57 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:54:57 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:54:57 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:54:57 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:54:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:54:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:54:58 INFO - Return code: 0 14:54:58 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', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1463164213/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--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:54:58 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 http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1463164213/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-002 --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:54:58 INFO - Using env: {'DISPLAY': ':0', 14:54:58 INFO - 'HOME': '/home/cltbld', 14:54:58 INFO - 'LANG': 'en_US.UTF-8', 14:54:58 INFO - 'LANGUAGE': 'en_US:en', 14:54:58 INFO - 'LOGNAME': 'cltbld', 14:54:58 INFO - 'MAIL': '/var/mail/cltbld', 14:54:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:54:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:54:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:54:58 INFO - 'MOZ_NO_REMOTE': '1', 14:54:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:54:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:54:58 INFO - 'NO_EM_RESTART': '1', 14:54:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:54:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:54:58 INFO - 'PWD': '/builds/slave/test', 14:54:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:54:58 INFO - 'SHELL': '/bin/bash', 14:54:58 INFO - 'SHLVL': '1', 14:54:58 INFO - 'TERM': 'linux', 14:54:58 INFO - 'TMOUT': '86400', 14:54:58 INFO - 'USER': 'cltbld', 14:54:58 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1463176446.751826-2092259595', 14:54:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:54:58 INFO - '_': '/tools/buildbot/bin/python'} 14:54:58 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', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1463164213/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--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:54:59 INFO - mozversion application_buildid: 20160513113013 14:54:59 INFO - mozversion application_changeset: c4a209a8e2a8483f71182ecfa6044b830fd85362 14:54:59 INFO - mozversion application_display_name: Nightly 14:54:59 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:54:59 INFO - mozversion application_name: Firefox 14:54:59 INFO - mozversion application_remotingname: firefox 14:54:59 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:54:59 INFO - mozversion application_vendor: Mozilla 14:54:59 INFO - mozversion application_version: 49.0a1 14:54:59 INFO - mozversion platform_buildid: 20160513113013 14:54:59 INFO - mozversion platform_changeset: c4a209a8e2a8483f71182ecfa6044b830fd85362 14:54:59 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:54:59 INFO - mozversion platform_version: 49.0a1 14:54:59 INFO - using testdate: 1463176499 14:54:59 INFO - actual date: 1463176499 14:54:59 INFO - starting webserver on 'localhost:34218' 14:54:59 INFO - SUITE-START | Running 2 tests 14:54:59 INFO - TEST-START | dromaeo_css 14:54:59 INFO - operating with platform_type : linux_ 14:54:59 INFO - Initialising browser for dromaeo_css test... 14:54:59 INFO - TEST-INFO | started process 29106 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8mUxZP/profile http://localhost:34218/getInfo.html) 14:55:02 INFO - PROCESS | 29106 | 14:55:02 INFO - PROCESS | 29106 | (process:29174): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 14:55:03 INFO - PROCESS | 29106 | __metrics Screen width/height:1600/1200 14:55:03 INFO - PROCESS | 29106 | colorDepth:24 14:55:03 INFO - PROCESS | 29106 | Browser inner width/height: 1024/697 14:55:03 INFO - PROCESS | 29106 | __metrics 14:55:04 ERROR - PROCESS | 29106 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 14:55:05 INFO - TEST-INFO | 29106: exit 0 14:55:05 INFO - Browser initialized. 14:55:05 INFO - Running cycle 1/1 for dromaeo_css test... 14:55:05 INFO - TEST-INFO | started process 29225 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8mUxZP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:55:06 INFO - PROCESS | 29225 | 14:55:06 INFO - PROCESS | 29225 | (process:29285): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 14:55:16 INFO - PROCESS | 29225 | RSS: Main: 163811328 14:55:16 INFO - PROCESS | 29225 | 14:56:06 INFO - PROCESS | 29225 | 1463176566519 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:58:14 INFO - PROCESS | 29225 | Cycle 1(1): loaded http://localhost:34218/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34218/tests/dromaeo/cssquery-ext.html) 14:58:15 INFO - PROCESS | 29225 | RSS: Main: 167215104 14:58:15 INFO - PROCESS | 29225 | 15:01:17 INFO - PROCESS | 29225 | Cycle 1(1): loaded http://localhost:34218/tests/dromaeo/cssquery-ext.html (next: http://localhost:34218/tests/dromaeo/cssquery-jquery.html) 15:01:17 INFO - PROCESS | 29225 | RSS: Main: 167620608 15:01:17 INFO - PROCESS | 29225 | 15:04:19 INFO - PROCESS | 29225 | Cycle 1(1): loaded http://localhost:34218/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34218/tests/dromaeo/cssquery-mootools.html) 15:04:20 INFO - PROCESS | 29225 | RSS: Main: 168165376 15:04:20 INFO - PROCESS | 29225 | 15:07:22 INFO - PROCESS | 29225 | Cycle 1(1): loaded http://localhost:34218/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34218/tests/dromaeo/cssquery-prototype.html) 15:07:22 INFO - PROCESS | 29225 | RSS: Main: 165748736 15:07:22 INFO - PROCESS | 29225 | 15:10:25 INFO - PROCESS | 29225 | Cycle 1(1): loaded http://localhost:34218/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34218/tests/dromaeo/cssquery-yui.html) 15:10:25 INFO - PROCESS | 29225 | RSS: Main: 166633472 15:10:25 INFO - PROCESS | 29225 | 15:13:28 INFO - PROCESS | 29225 | Cycle 1(1): loaded http://localhost:34218/tests/dromaeo/cssquery-yui.html (next: http://localhost:34218/tests/dromaeo/cssquery-dojo.html) 15:13:28 INFO - PROCESS | 29225 | RSS: Main: 169357312 15:13:28 INFO - PROCESS | 29225 | 15:13:28 INFO - PROCESS | 29225 | __start_tp_report 15:13:28 INFO - PROCESS | 29225 | _x_x_mozilla_page_load 15:13:28 INFO - PROCESS | 29225 | _x_x_mozilla_page_load_details 15:13:28 INFO - PROCESS | 29225 | |i|pagename|runs| 15:13:28 INFO - PROCESS | 29225 | |0;dojo.html;3188.2826364068087;3219.1952011997;3246.009966960077;3256.9674303256975;3277.6066871975368;5481.780728770849;5491.752871120794;5607.214989901417;5657.519110875581;5659.8585035374135;5532.059549876521;5554.527865131458;5555.416681248471;5597.7201139942945;5616.859578510539;4987.102321582114;5013;5117.872053198681;5162.070827251093;5202.907389448221;918.1131913042163;4934.25986102084;5027.974860125712;5073.441921388644;5205.505476979681;5034.42104158021;5047.49525047496;5061.949380506185;5080.41575218849;5093.6943783372935;5090.898182036375;5095.949040509585;5100.413452452978;5101.591872650216;5156.9742151289;4944.307796908436;5024.472430394829;5060.848174554732;5091.745412729349;5094.235864620299;5463.508284254396;5496.532794712454;5543.861403464905;5585.58108141891;5631.014572449805;6041.939580604182;6045.486133678643;6050.606710563799;6055.364186760415;6074.453299203093;5877.500412464946;5886.823395298148;5903.321118071391;6082.2093127893095;6112.63324200545;5543.972280138573;5546.972265138689;5547.611667183299;5549.667019978814;5574.86062848428;5993.400659934059;6032.487238584682;6049.485793707496;6064.878702425926;6069.666168360694;5711.885762284731;5805.071188609802;5870.383609721003;5914.290285165807;5950.285965684146;6039.78860739872;6040.244969378828;6076.149339092531;6076.240469941257;6083.361247068994;6012.579119461683;6021.096835474714;6037.305709843336;6040.456358927718;6045.093236014633;5810.157527158538;5891.911621325684;5939.970300148558;5961.612495187799;6038.516918646497;4511.639068874482;4517.299818528133;4538.04701012791;4541.296099104644;4589.426321709786;3931.4495970564144;4026.7181297309494;4044.0496483326397;4060.6548443382053;4090.652294554996;5558.666480011212;5628.521575666115;5717.285339332583;5755;5759.596828221985;5922.615030023035;5969.970150149308;6005.369436209223;6021.608595441282;6035.30593981689;5567.220589117527;5748.798792042258;5749.770009199585;5752.424757524214;5755.079187330007;5051.393832740095;5065.062963351792;5076.695398276115;5083.61872859537;5113.565346945476;6113.908291375633;6138.539609529304;6159.4456498914415;6172.783952561639;6185.103160041769;5852.678102704393;5947.732352044082;5960.701964901824;6018.909716354171;6025.758969641165;6112.837854638657;6239.563230573816;6245.250569931637;6251.031090181029;6253.843653908507;5960.910586341295;5970.104484327386;5973.731182096729;5985.102234664835;6020.367861374668;5923.141144533933;5975.760969561343;6040.395960403925;6077.4226448487325;6077.453029227391;5932.4957378621575;5933.110033495011;5936.732847021981;5938.881222375615;5992.8501787453915;5862.706864656835;5924.4667979882015;5925.140854576149;5927.496162826208;5927.851803704942;5633.0987042073075;5686.658800471985;5720.942790572041;5734.54123670097;5797.913031304618;5867.853303667272;5927.644341339534;5934.525237981037;5936.643801371932;5947.672877991752;5775.33583637887;5777.133429985536;5802.82591522255;5814.825555233349;5820.621659592113 15:13:28 INFO - PROCESS | 29225 | |1;ext.html;601.5518438763122;646.0632083478955;648.4488185042711;660.8711301296249;664.6776313487958;31785.841070794642;45814.312785308204;47105.057898842046;47116.29325560111;47135;45142.322865157046;45465.77267113668;45515.54484455154;45528.3170752439;45570.77214613922;8894.155055269739;8971.237444817198;8997.235235005033;9029;9033.141851524095;8818.514981676006;8922.375433719642;8929.598168082452;8934.329925255599;8947.552622368888;8916.509591972439;8940.597673104694;8948.284137269004;8979.595918183697;9000.189982901538;8886.20024197822;8917.42036767608;8918.152775486318;8937.374383793138;8969.416987895765;8793;8812.1187881212;8831.690890818854;8836.55817209137;8866.113388661146;41207.58792412067;41389.1722165558;41403.58596414027;41460.792696036326;41607.58392416098;3856.633619806114;4021.8391264349393;4312.417823593806;4408.58118478744;4410.0077482566485;31262;32061.198470038435;32127.678723212703;32235;33346.1663458413;4323.200207961506;4332.523422423531;4360.454943132108;4407.338899165119;4417.620520301972;364266.1786691076;365498;365714;365819;365938;58134.70932645394;59013;59058.40941590615;59088.40911590915;59271;36190.45714314287;36782.26435471329;37095.814520927765;38687.806560967576;38722;17321.653566928842;17396.652066958843;17534.82465175332;17566.736498952527;17587.73618395725;13770.104943178862;13780.724385512434;13848.723025539633;13864.861351386558;13870.237136957363;19817.306394276133;19861.900690496743;19890.70163947542;19922.605417620918;20103.899480502798;7594.392448604099;7629.351505122127;7707.730229441942;7799.142094369615;7806.804829879298;1001.5493028137367;1108.6286094158386;1139.8575178102737;1159.565163063851;1268.492602958824;33080.338393232;33304.33391332208;33481.99554013384;33704.49443258353;33737.662623373944;1164.615676826645;1202.8857258560597;1242.7514497100435;1260.848698156227;1284.6852521132196;17383.826161738474;17508.12459377026;17529.7370539442;17639.559011024572;17647.38234161824;557789;558054;563331;563629;564908;59646.70176649089;59865.102023469684;60235.69882150561;60391.39608603946;60515;1429.535400994681;1439.4458133618423;1448.1890141520782;1450.753371926775;1458.9781153282709;31705;31935.840320799176;32256;32577.511337329484;32736.83631581827;52115;52366;52935.20597190968;52948.735256323474;52999;471576;473065;473843;478134;479429;28579.714202857704;28723.138305850858;29131;29196.124116276547;29219.85390073036;49673.75163124306;49959.75020124876;49988.75005624948;50556;51092.48907511026;40786;41759.536648692076;41772;41898.37152442655;43065.78467107644;41899.37150942799;42050.57949420466;42355.576444235165;42539.7873010633;42598.57401425946;36542;41146.794266029676;41370.1725965485;42117.78941105275;42764.78617606892;35587;37028;37481.4377784328;37609.4358584616;37785.24429511449;29028.419431611674;29084.27289317784;29361;29406.852965735034;29462.558061628664 15:13:28 INFO - PROCESS | 29225 | |2;jquery.html;387.86424751337034;391.11998004489897;400.9899752506189;409.7357204603029;421.1639894808804;15756.684866302667;18056.548586285335;19300.903495482504;19447.902760486195;19660.803391966077;18933.62132757344;19245.133968971393;19382.709259361087;19492.51268718283;19606.803931960676;5372.301600791891;5575;5674.063779476382;5677.687727175004;5752.5110365618975;5670.829875103754;5723.599348045638;5824.941750582482;6533.673316334188;6544.541882068257;6400.583962042476;6400.615963042209;6425.389587989133;6456.128422662928;6460.93539064608;5880.55895807814;5882.735276912549;5899.115132730103;5899.616524925866;6199.938000620004;5519.144532597454;5654.9151762723595;5669.26299581056;5705.372409035002;5737.713114344266;12780.233186008869;13084.411201495956;13091.214527128403;13136.737265254642;13144.60566183016;2236.944076398087;2259.830512711553;2289.599320118989;2307.665388518672;2411.722651895037;10157.644482443153;10220.795584088277;10245.872953975057;10249.538770755335;10440.530176142092;1978.2581531925528;1983.761948566167;2049.825764809993;2065.5042789730505;2076.2110398048794;52276.738616307055;64416;89558.55220723855;90064.09935900688;90465.54767226188;10592.735181620521;10872.945635271773;10894.891051089546;11004.449777511092;11170.609028683957;12569.434375453127;14230.501932432315;15190.46833360827;15580.610484737972;15617.60955976087;8041.959790201012;8078.35373170145;8321.708740194184;8345.707900223462;8413.621387037598;7772.067351917806;7775.028121484815;7775.92224077752;7927.8810817837775;7976.481528700616;4622.560856718606;4667.416572928384;4671.766411679402;4756.524347565285;4769.833055843029;1943.319838056669;1976.170008596393;1981.3758666020158;1982.415187519685;1984.295575070829;474.4792938631677;486.40415491023214;1037.899826184247;1039.3400190878847;1047.2407504559133;11055.613053543088;11568.190226684219;11715.941420292844;11747.236429632047;11952;484.6486297434402;489.168413696717;489.46892621505356;497.2665318655027;501.7190373390913;6269.310375858652;6486.156799616019;6503.934960650333;6526.477881769542;6537.1501704778075;511808;514498;518260;531130;532363;99462;100503;100526;103694.48152759188;104468;481.22762965439966;486.2948724349636;488.35780948053196;488.6970078551321;490.94108706955393;10592.682219533426;10648.307859989076;10901.890981090404;10984.395858227874;11004.944975275072;38604.2279154421;40391;41505.1698966025;42684.5731542693;43403;50782.238266425295;52201.47798521966;54351;54449;56016;8428.367872409472;8726.258268047033;8732.91267087321;8844.380893337404;9113.997460279497;9187.724368268962;12043.518259269882;12865.614031579067;12892.419841106985;12960.351982400654;7437.702491900263;10842.891571084503;11355.48900299472;11450.770984580095;11457.677273590565;6450.677466126769;7783.637863373774;10925.781484370109;10931.617393391192;11110.055645270242;11428.657140285804;11532.769344612892;11579.305241685526;11641.230898220381;11764.82352764692;8612.65549378018;8752.956235218782;8814.162654547808;9010.63957441695;9080;8620.353473489638;10053.246006549683;10551.050405463546;10609.575616975235;10767.730806729895 15:13:28 INFO - PROCESS | 29225 | |3;mootools.html;1556.7120082784681;1588.6663800601873;1773.67187070392;1884.095634095635;1885.9811401885977;8414.495130292187;9082.727518174448;9108.635654573818;9723.17353024993;9723.416595004286;9165.312601554877;9395.859062114074;9466.857997130048;9496.240300775939;9561.378510396837;2445.3397582652674;2474.987625061872;2485.229578830559;2493.2769496845895;2500.9749902500926;2441.108995216742;2495.238952119603;2496.6005439129744;2500.57490226661;2505.523950449418;2411.7588241175918;2415.661807346964;2427.8421902576274;2436.817238707104;2438.926832195037;2426.1387207541334;2430.769076937697;2431.0154387473103;2468.7531246875346;2469.0987789456717;2382.5949588569983;2385.7017872765905;2387.2599494156866;2396.700412448444;2419.2742177346727;9455.29085318597;9523.666671666528;9546.379485333431;9550.761230969212;9579.760505987337;5679.4036626154075;5855.092460668603;5855.707214639251;5856.853578660525;5868.4424979626865;3473.94789078164;3474.2530355973586;3601.5858176309534;3619.9095022624647;3624.003399065252;1094.1848322999338;1117.3463523838484;1130.3161587239683;1130.3444002478625;1137.527925910746;13436;13577.796333054914;13600.999999999902;13638;13672.863271367258;4992.026554821848;4992.825251116194;5109.38687357512;5170.40540337866;5220.425753167148;11205.215634905479;11305.547778088785;11321.660350189508;11349.432528373549;11358.375289359165;5654.97172514143;5757.280339957505;5758.337791153987;5768.682722450221;5850.0932355484965;4692.648051396159;5064.82273120439;5150.0472412603785;5154.433012368637;5300.072487314705;4333.978330108329;4335.934960975588;4434.689571729948;4461.531539188403;4583.656225783013;1370.2395170680368;1393.7142885708406;1414.8655877691604;1423.323921137472;1426.408040663134;894.9731508054768;1014.6448742939912;1025.4308858583559;1034.5292891734393;1053.083817079146;6077.817665470043;6163.106349579376;6285.088662143963;6351.714172862232;6424.453921416639;465.8509277031385;475.2064053031446;475.36301356182884;478.4927976345085;489.54227797009196;4229.2175947449205;4261.936070958876;4269.914601707948;4321.827126914888;4354.869353919387;11726.355050472306;11930.164888457724;12112.878871211175;12135.87864121365;12136.635900922987;11530;11893.702657433634;11966;12020.038396928225;12022.579209727792;8649.308055355683;8722.86915696265;8772.254358379609;8823.69117080899;8825.646974120964;5937.524998000236;5988.461038506555;6048.758049678139;6070.484008859296;6070.848228794315;10812.891871081189;11023.61417350389;11085.889141108808;11086.501107450023;11192.496337664661;11017.283876548;11151.052160566118;11177.608783692533;11282.548698052315;11315.377654228767;7624.351930085783;8132.471389359673;8352.33181345503;8508.829823403374;8578.571071446528;9257;9292.814143716952;9342.673006444742;9344.626214951597;9381.390209636353;8034.397420193626;8350.373721970755;8355.791105222417;8491.702790402307;8566;8162.347012239125;8182.099969003524;8182.7545173644885;8263.545504997282;8327.708530201415;7109.146902371748;7244;7303.853922921406;7313.232110628307;7463.92536074654;5435.483629055233;5468.808591699271;5532.529734972572;5604.8038318658655;5667.716614169358;5393.757280922289;5479.808206712746;5575.609707320448;5610.495055444866;5696.287964004499 15:13:28 INFO - PROCESS | 29225 | |4;prototype.html;320.4424301715015;332.247459504223;333.19034745568257;342.1770641606935;342.56323187935385;5494.5054945055035;5553.916986187695;5662.725886675491;5720.342160651527;5800.941990580093;5584.5811564132755;5618.719064046802;5619.80330688426;5623.915641265385;5658;4418.5802348776815;4420.425344705184;4428.180786554498;4449.5995360417555;4456.621187199092;4193.748375097489;4408.16244913467;4414.470263568376;4466.575675310856;4468.575485328888;4316.740995540277;4337.761423121727;4366.214081465335;4375.606195442409;4387.924958385184;4361.60745532902;4384.188925048844;4385.934210986838;4409.184300904343;4421.624161946238;3740.8503659853573;3809.647575110851;3846.499955005859;3856.82644281008;3863.092173339263;5392.433794451605;5407.83776486706;5419.21166015214;5429.837104886859;5463.781448742086;4961.9751901240625;4972.776225069844;4981.327520784684;4995.375578052744;5010.423801262865;5786.768529258825;5906.8818623627285;5938.7030648467835;5939.703014849283;5964.343922168558;4182.749035057906;4230.598093181143;4239.851605193803;4247.214265360918;4253.447051883266;6040.550267935708;6078.088286756978;6082.9695851520455;6090.817275481742;6092.147099406043;4172.144710334434;4256.61690447855;4270.081932384553;4270.530241673413;4285.228658841376;4314.331278651814;4332.913341733148;4339.869803905888;4339.891502712458;4357.8256869724855;4963.478834722375;4973.154563724103;4976.825811096594;4988.426330971912;5010.799568017312;5688.658680479184;5919.141724449931;5949.9107513387335;5998.910016349758;6031;1483.703259348113;1490.3814916809404;1495.132822962679;1507.796447479598;1507.92660092373;914.9862752058724;945.9716208513755;948.9419297483256;953.5851904421598;958.6740508227097;5133.563647089964;5152.407473140637;5164.870878228075;5174.586033117342;5184.37787465499;5405.891882162414;5441.401445840955;5452.236686863842;5505.944940550543;5536.843998920657;4967.875803104951;5129.948700512947;5169.172932330809;5172.8965420691375;5209.317201641158;2885.2786803299177;2957.719016693454;2969.4410434522047;2971.9554206686917;2972.420378026264;5499.642523236057;5553.305836770403;5578.847950907724;5679.318481782213;5686.5735069869925;5248.110680155141;5462.852800911853;5490.862728431741;5491.203775452537;5561.972190139023;5421.783128674888;5481.698506582176;5524.723763811793;5566.443355664401;5581.3302403711;5313.973430132824;5330.387005494418;5511.58663100261;5512.889742205213;5519.862003449946;5373.838784836461;5405.486478784509;5427.701476418835;5461.15352120422;5472.835814925558;5573.331200255995;5631.831045068655;5650.576206784425;6015.669138197266;6194.845128871634;4234.724742891703;4237.8304867804945;4246.532881382984;4285.657147428261;4294.806733696929;6135.202423684892;6148.9692551536955;6156.815295541141;6184.753004672583;6206.658633775186;5731.398203188605;5882.205902203148;5905.232319798399;5921.733521991435;5972.611780234444;5869.354371019099;5896.764129434775;5901.203337549376;5920.934231838311;5963.70181490915;5650.29371328584;5811.651300921958;5828.446297601721;5839.182514447895;5865.824025279248;5883.794067207627;5943.821685349447;5963.373845746134;5967.433093856077;5998.4601385875485;5863.2670916135485;5868.853278668067;5878.353381127987;5928.851778705394;5936.465718085393 15:13:28 INFO - PROCESS | 29225 | |5;yui.html;831.5883637599389;846.3863698818355;885.8439736144333;886.9201771840533;896.1934259166745;14325.78511322331;15385.769213461794;15581.532554023397;15634.061956282616;15645.295961681722;14244.21656808875;14379.78430323546;14445.133292002487;14449.711005779878;14515.346809393577;866.3285953386129;867.4968518259426;869.6825658634616;874.7725591346232;881.5856547422701;860.2386887604483;863.5552690364467;865.6796985115516;867.9522626255554;871.4335681806845;918.4443411735904;920.1994264989469;920.2913756407562;923.9445633261993;924.1036194890945;919.995400022999;920.3143657974852;920.5351297594739;920.9631614735436;921.3182245138617;662.2251965200678;665.0356982375527;666.5334266013762;667.1760375935716;667.3926726678748;13700.93149534256;13739.862601373958;13779.931100344535;13789.310534473236;13838.584842454742;12618.621441356774;12623.495060197582;12697.746045079046;12701.301428421433;12723.300218487979;11070.833937490863;11177.105831533458;11286.209965302432;11461.36962467064;11471.311721296666;3797.3354662933875;3840.8847734568008;3883.728139030269;3889.8249578769023;3892.8442862285474;55560;56615.71692141513;56832.14751778726;56877;56992.14511782327;9701.708948731408;9805.950970245103;9817.803643927224;9865.506724663737;9920;17208.225629846438;17245.65508689844;17247.396341128253;17361.91319043422;17379.304827807;8117.512949223065;8377.581120943929;8457.407981441364;8803.295736341077;8830.86753698695;4625;4756.857294281177;4767.189577771787;4871.537203965689;4960.975195124001;3566.28674265148;3649.8905032849057;3703.0372103252807;3710.591834898159;3717.683996860243;643.520577170002;652.1717418877998;657.2310396835618;663.1660736114292;666.9899951500731;791.5409062743595;803.2409373142324;806.7781360126012;812.7439856445201;841.7264389073575;9708.563114659857;10162.949185254174;10186.337888037255;10337.173026157889;10461.110805581611;695.3776370148688;745.2249660353281;774.3895477267235;793.2226418110284;803.5620586780102;4653.302004699254;4657.231556793091;4746.359241502353;4747.976260118678;4755.500672429414;65547.34452655508;66501.33498665049;66738;67764;67842.3215767836;47743.522564773906;51557.74221128871;57699;57952.13071803926;59556.40443595508;49148.262776058385;53759.73120134374;53860.192097118575;54819;54912;8408.789780255298;8567.186117318844;8598.441101328393;9469.810603788024;9703.466309353053;36401.817990909876;37070;37166.07084822793;37208.44187337138;37383.81308093442;49148.75425622849;50755.49244507508;51443.228351574006;51722;51801.7409912948;11401.828972565583;11461.369624670722;11559.248648837798;11588;12112.333821639895;8361.163883611833;10097.293189476666;12888.355582220664;13519.792556620083;13692.65768355799;12241.571544996239;12332.32172230536;12444;12963.740725185633;12966.805497917727;12130.393480325773;12193.451294691937;12577.622671319876;12967.416466258852;13030.478780849038;12585.622431327074;12644.30456324911;12951.740965180832;13023.348832558144;13088.803667944798;10276.22928280367;10530.05229529346;10666.46667666629;11001.779964400826;11061.72345691332;9944.45305508175;10067.395956242648;10405.687829365132;10433.165346772392;10824.458777061272 15:13:28 INFO - PROCESS | 29225 | __end_tp_report 15:13:28 INFO - PROCESS | 29225 | __start_cc_report 15:13:28 INFO - PROCESS | 29225 | _x_x_mozilla_cycle_collect,345 15:13:28 INFO - PROCESS | 29225 | __end_cc_report 15:13:28 INFO - PROCESS | 29225 | __startTimestamp1463177608449__endTimestamp 15:13:28 INFO - PROCESS | 29225 | 15:13:28 INFO - PROCESS | 29225 | ------- Summary: start ------- 15:13:28 INFO - PROCESS | 29225 | Number of tests: 6 15:13:28 INFO - PROCESS | 29225 | 15:13:28 INFO - PROCESS | 29225 | [#0] dojo.html Cycles:165 Average:5534.58 Median:5802.83 stddev:738.89 (12.7%) stddev-sans-first:717.87 15:13:28 INFO - PROCESS | 29225 | Values: 3188.3 3219.2 3246.0 3257.0 3277.6 5481.8 5491.8 5607.2 5657.5 5659.9 5532.1 5554.5 5555.4 5597.7 5616.9 4987.1 5013.0 5117.9 5162.1 5202.9 918.1 4934.3 5028.0 5073.4 5205.5 5034.4 5047.5 5061.9 5080.4 5093.7 5090.9 5095.9 5100.4 5101.6 5157.0 4944.3 5024.5 5060.8 5091.7 5094.2 5463.5 5496.5 5543.9 5585.6 5631.0 6041.9 6045.5 6050.6 6055.4 6074.5 5877.5 5886.8 5903.3 6082.2 6112.6 5544.0 5547.0 5547.6 5549.7 5574.9 5993.4 6032.5 6049.5 6064.9 6069.7 5711.9 5805.1 5870.4 5914.3 5950.3 6039.8 6040.2 6076.1 6076.2 6083.4 6012.6 6021.1 6037.3 6040.5 6045.1 5810.2 5891.9 5940.0 5961.6 6038.5 4511.6 4517.3 4538.0 4541.3 4589.4 3931.4 4026.7 4044.0 4060.7 4090.7 5558.7 5628.5 5717.3 5755.0 5759.6 5922.6 5970.0 6005.4 6021.6 6035.3 5567.2 5748.8 5749.8 5752.4 5755.1 5051.4 5065.1 5076.7 5083.6 5113.6 6113.9 6138.5 6159.4 6172.8 6185.1 5852.7 5947.7 5960.7 6018.9 6025.8 6112.8 6239.6 6245.3 6251.0 6253.8 5960.9 5970.1 5973.7 5985.1 6020.4 5923.1 5975.8 6040.4 6077.4 6077.5 5932.5 5933.1 5936.7 5938.9 5992.9 5862.7 5924.5 5925.1 5927.5 5927.9 5633.1 5686.7 5720.9 5734.5 5797.9 5867.9 5927.6 5934.5 5936.6 5947.7 5775.3 5777.1 5802.8 5814.8 5820.6 15:13:28 INFO - PROCESS | 29225 | 15:13:28 INFO - PROCESS | 29225 | [#1] ext.html Cycles:180 Average:62350.14 Median:41974.98 stddev:125902.43 (299.9%) stddev-sans-first:126170.26 15:13:28 INFO - PROCESS | 29225 | Values: 601.6 646.1 648.4 660.9 664.7 31785.8 45814.3 47105.1 47116.3 47135.0 45142.3 45465.8 45515.5 45528.3 45570.8 8894.2 8971.2 8997.2 9029.0 9033.1 8818.5 8922.4 8929.6 8934.3 8947.6 8916.5 8940.6 8948.3 8979.6 9000.2 8886.2 8917.4 8918.2 8937.4 8969.4 8793.0 8812.1 8831.7 8836.6 8866.1 41207.6 41389.2 41403.6 41460.8 41607.6 3856.6 4021.8 4312.4 4408.6 4410.0 31262.0 32061.2 32127.7 32235.0 33346.2 4323.2 4332.5 4360.5 4407.3 4417.6 364266.2 365498.0 365714.0 365819.0 365938.0 58134.7 59013.0 59058.4 59088.4 59271.0 36190.5 36782.3 37095.8 38687.8 38722.0 17321.7 17396.7 17534.8 17566.7 17587.7 13770.1 13780.7 13848.7 13864.9 13870.2 19817.3 19861.9 19890.7 19922.6 20103.9 7594.4 7629.4 7707.7 7799.1 7806.8 1001.5 1108.6 1139.9 1159.6 1268.5 33080.3 33304.3 33482.0 33704.5 33737.7 1164.6 1202.9 1242.8 1260.8 1284.7 17383.8 17508.1 17529.7 17639.6 17647.4 557789.0 558054.0 563331.0 563629.0 564908.0 59646.7 59865.1 60235.7 60391.4 60515.0 1429.5 1439.4 1448.2 1450.8 1459.0 31705.0 31935.8 32256.0 32577.5 32736.8 52115.0 52366.0 52935.2 52948.7 52999.0 471576.0 473065.0 473843.0 478134.0 479429.0 28579.7 28723.1 29131.0 29196.1 29219.9 49673.8 49959.8 49988.8 50556.0 51092.5 40786.0 41759.5 41772.0 41898.4 43065.8 41899.4 42050.6 42355.6 42539.8 42598.6 36542.0 41146.8 41370.2 42117.8 42764.8 35587.0 37028.0 37481.4 37609.4 37785.2 29028.4 29084.3 29361.0 29406.9 29462.6 15:13:28 INFO - PROCESS | 29225 | 15:13:28 INFO - PROCESS | 29225 | [#2] jquery.html Cycles:180 Average:28927.08 Median:43043.79 stddev:86183.92 (200.2%) stddev-sans-first:86399.04 15:13:28 INFO - PROCESS | 29225 | Values: 387.9 391.1 401.0 409.7 421.2 15756.7 18056.5 19300.9 19447.9 19660.8 18933.6 19245.1 19382.7 19492.5 19606.8 5372.3 5575.0 5674.1 5677.7 5752.5 5670.8 5723.6 5824.9 6533.7 6544.5 6400.6 6400.6 6425.4 6456.1 6460.9 5880.6 5882.7 5899.1 5899.6 6199.9 5519.1 5654.9 5669.3 5705.4 5737.7 12780.2 13084.4 13091.2 13136.7 13144.6 2236.9 2259.8 2289.6 2307.7 2411.7 10157.6 10220.8 10245.9 10249.5 10440.5 1978.3 1983.8 2049.8 2065.5 2076.2 52276.7 64416.0 89558.6 90064.1 90465.5 10592.7 10872.9 10894.9 11004.4 11170.6 12569.4 14230.5 15190.5 15580.6 15617.6 8042.0 8078.4 8321.7 8345.7 8413.6 7772.1 7775.0 7775.9 7927.9 7976.5 4622.6 4667.4 4671.8 4756.5 4769.8 1943.3 1976.2 1981.4 1982.4 1984.3 474.5 486.4 1037.9 1039.3 1047.2 11055.6 11568.2 11715.9 11747.2 11952.0 484.6 489.2 489.5 497.3 501.7 6269.3 6486.2 6503.9 6526.5 6537.2 511808.0 514498.0 518260.0 531130.0 532363.0 99462.0 100503.0 100526.0 103694.5 104468.0 481.2 486.3 488.4 488.7 490.9 10592.7 10648.3 10901.9 10984.4 11004.9 38604.2 40391.0 41505.2 42684.6 43403.0 50782.2 52201.5 54351.0 54449.0 56016.0 8428.4 8726.3 8732.9 8844.4 9114.0 9187.7 12043.5 12865.6 12892.4 12960.4 7437.7 10842.9 11355.5 11450.8 11457.7 6450.7 7783.6 10925.8 10931.6 11110.1 11428.7 11532.8 11579.3 11641.2 11764.8 8612.7 8753.0 8814.2 9010.6 9080.0 8620.4 10053.2 10551.1 10609.6 10767.7 15:13:28 INFO - PROCESS | 29225 | 15:13:28 INFO - PROCESS | 29225 | [#3] mootools.html Cycles:180 Average:6243.10 Median:2583.93 stddev:3634.44 (140.7%) stddev-sans-first:3627.58 15:13:28 INFO - PROCESS | 29225 | Values: 1556.7 1588.7 1773.7 1884.1 1886.0 8414.5 9082.7 9108.6 9723.2 9723.4 9165.3 9395.9 9466.9 9496.2 9561.4 2445.3 2475.0 2485.2 2493.3 2501.0 2441.1 2495.2 2496.6 2500.6 2505.5 2411.8 2415.7 2427.8 2436.8 2438.9 2426.1 2430.8 2431.0 2468.8 2469.1 2382.6 2385.7 2387.3 2396.7 2419.3 9455.3 9523.7 9546.4 9550.8 9579.8 5679.4 5855.1 5855.7 5856.9 5868.4 3473.9 3474.3 3601.6 3619.9 3624.0 1094.2 1117.3 1130.3 1130.3 1137.5 13436.0 13577.8 13601.0 13638.0 13672.9 4992.0 4992.8 5109.4 5170.4 5220.4 11205.2 11305.5 11321.7 11349.4 11358.4 5655.0 5757.3 5758.3 5768.7 5850.1 4692.6 5064.8 5150.0 5154.4 5300.1 4334.0 4335.9 4434.7 4461.5 4583.7 1370.2 1393.7 1414.9 1423.3 1426.4 895.0 1014.6 1025.4 1034.5 1053.1 6077.8 6163.1 6285.1 6351.7 6424.5 465.9 475.2 475.4 478.5 489.5 4229.2 4261.9 4269.9 4321.8 4354.9 11726.4 11930.2 12112.9 12135.9 12136.6 11530.0 11893.7 11966.0 12020.0 12022.6 8649.3 8722.9 8772.3 8823.7 8825.6 5937.5 5988.5 6048.8 6070.5 6070.8 10812.9 11023.6 11085.9 11086.5 11192.5 11017.3 11151.1 11177.6 11282.5 11315.4 7624.4 8132.5 8352.3 8508.8 8578.6 9257.0 9292.8 9342.7 9344.6 9381.4 8034.4 8350.4 8355.8 8491.7 8566.0 8162.3 8182.1 8182.8 8263.5 8327.7 7109.1 7244.0 7303.9 7313.2 7463.9 5435.5 5468.8 5532.5 5604.8 5667.7 5393.8 5479.8 5575.6 5610.5 5696.3 15:13:28 INFO - PROCESS | 29225 | 15:13:28 INFO - PROCESS | 29225 | [#4] prototype.html Cycles:180 Average:4815.90 Median:5428.77 stddev:1397.13 (25.7%) stddev-sans-first:1359.70 15:13:28 INFO - PROCESS | 29225 | Values: 320.4 332.2 333.2 342.2 342.6 5494.5 5553.9 5662.7 5720.3 5800.9 5584.6 5618.7 5619.8 5623.9 5658.0 4418.6 4420.4 4428.2 4449.6 4456.6 4193.7 4408.2 4414.5 4466.6 4468.6 4316.7 4337.8 4366.2 4375.6 4387.9 4361.6 4384.2 4385.9 4409.2 4421.6 3740.9 3809.6 3846.5 3856.8 3863.1 5392.4 5407.8 5419.2 5429.8 5463.8 4962.0 4972.8 4981.3 4995.4 5010.4 5786.8 5906.9 5938.7 5939.7 5964.3 4182.7 4230.6 4239.9 4247.2 4253.4 6040.6 6078.1 6083.0 6090.8 6092.1 4172.1 4256.6 4270.1 4270.5 4285.2 4314.3 4332.9 4339.9 4339.9 4357.8 4963.5 4973.2 4976.8 4988.4 5010.8 5688.7 5919.1 5949.9 5998.9 6031.0 1483.7 1490.4 1495.1 1507.8 1507.9 915.0 946.0 948.9 953.6 958.7 5133.6 5152.4 5164.9 5174.6 5184.4 5405.9 5441.4 5452.2 5505.9 5536.8 4967.9 5129.9 5169.2 5172.9 5209.3 2885.3 2957.7 2969.4 2972.0 2972.4 5499.6 5553.3 5578.8 5679.3 5686.6 5248.1 5462.9 5490.9 5491.2 5562.0 5421.8 5481.7 5524.7 5566.4 5581.3 5314.0 5330.4 5511.6 5512.9 5519.9 5373.8 5405.5 5427.7 5461.2 5472.8 5573.3 5631.8 5650.6 6015.7 6194.8 4234.7 4237.8 4246.5 4285.7 4294.8 6135.2 6149.0 6156.8 6184.8 6206.7 5731.4 5882.2 5905.2 5921.7 5972.6 5869.4 5896.8 5901.2 5920.9 5963.7 5650.3 5811.7 5828.4 5839.2 5865.8 5883.8 5943.8 5963.4 5967.4 5998.5 5863.3 5868.9 5878.4 5928.9 5936.5 15:13:28 INFO - PROCESS | 29225 | 15:13:28 INFO - PROCESS | 29225 | [#5] yui.html Cycles:180 Average:15240.91 Median:26307.53 stddev:18152.47 (69.0%) stddev-sans-first:18171.14 15:13:28 INFO - PROCESS | 29225 | Values: 831.6 846.4 885.8 886.9 896.2 14325.8 15385.8 15581.5 15634.1 15645.3 14244.2 14379.8 14445.1 14449.7 14515.3 866.3 867.5 869.7 874.8 881.6 860.2 863.6 865.7 868.0 871.4 918.4 920.2 920.3 923.9 924.1 920.0 920.3 920.5 921.0 921.3 662.2 665.0 666.5 667.2 667.4 13700.9 13739.9 13779.9 13789.3 13838.6 12618.6 12623.5 12697.7 12701.3 12723.3 11070.8 11177.1 11286.2 11461.4 11471.3 3797.3 3840.9 3883.7 3889.8 3892.8 55560.0 56615.7 56832.1 56877.0 56992.1 9701.7 9806.0 9817.8 9865.5 9920.0 17208.2 17245.7 17247.4 17361.9 17379.3 8117.5 8377.6 8457.4 8803.3 8830.9 4625.0 4756.9 4767.2 4871.5 4961.0 3566.3 3649.9 3703.0 3710.6 3717.7 643.5 652.2 657.2 663.2 667.0 791.5 803.2 806.8 812.7 841.7 9708.6 10162.9 10186.3 10337.2 10461.1 695.4 745.2 774.4 793.2 803.6 4653.3 4657.2 4746.4 4748.0 4755.5 65547.3 66501.3 66738.0 67764.0 67842.3 47743.5 51557.7 57699.0 57952.1 59556.4 49148.3 53759.7 53860.2 54819.0 54912.0 8408.8 8567.2 8598.4 9469.8 9703.5 36401.8 37070.0 37166.1 37208.4 37383.8 49148.8 50755.5 51443.2 51722.0 51801.7 11401.8 11461.4 11559.2 11588.0 12112.3 8361.2 10097.3 12888.4 13519.8 13692.7 12241.6 12332.3 12444.0 12963.7 12966.8 12130.4 12193.5 12577.6 12967.4 13030.5 12585.6 12644.3 12951.7 13023.3 13088.8 10276.2 10530.1 10666.5 11001.8 11061.7 9944.5 10067.4 10405.7 10433.2 10824.5 15:13:28 INFO - PROCESS | 29225 | -------- Summary: end -------- 15:13:28 INFO - PROCESS | 29225 | 15:13:29 INFO - TEST-INFO | 29225: exit 0 15:13:29 INFO - TEST-OK | dromaeo_css | took 1110092ms 15:13:29 INFO - TEST-START | kraken 15:13:29 INFO - operating with platform_type : linux_ 15:13:29 INFO - Initialising browser for kraken test... 15:13:29 INFO - TEST-INFO | started process 29455 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpomxJTW/profile http://localhost:34218/getInfo.html) 15:13:32 INFO - PROCESS | 29455 | 15:13:32 INFO - PROCESS | 29455 | (process:29522): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 15:13:33 INFO - PROCESS | 29455 | __metrics Screen width/height:1600/1200 15:13:33 INFO - PROCESS | 29455 | colorDepth:24 15:13:33 INFO - PROCESS | 29455 | Browser inner width/height: 1024/697 15:13:33 INFO - PROCESS | 29455 | __metrics 15:13:34 ERROR - PROCESS | 29455 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 15:13:35 INFO - TEST-INFO | 29455: exit 0 15:13:35 INFO - Browser initialized. 15:13:35 INFO - Running cycle 1/1 for kraken test... 15:13:35 INFO - TEST-INFO | started process 29573 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpomxJTW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:13:36 INFO - PROCESS | 29573 | 15:13:36 INFO - PROCESS | 29573 | (process:29635): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 15:13:46 INFO - PROCESS | 29573 | RSS: Main: 163659776 15:13:46 INFO - PROCESS | 29573 | 15:13:49 INFO - PROCESS | 29573 | Cycle 1(1): loaded http://localhost:34218/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34218/tests/kraken/driver.html?testName=audio-beat-detection) 15:13:50 INFO - PROCESS | 29573 | RSS: Main: 168468480 15:13:50 INFO - PROCESS | 29573 | 15:13:53 INFO - PROCESS | 29573 | Cycle 1(1): loaded http://localhost:34218/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34218/tests/kraken/driver.html?testName=audio-dft) 15:13:53 INFO - PROCESS | 29573 | RSS: Main: 168460288 15:13:53 INFO - PROCESS | 29573 | 15:13:56 INFO - PROCESS | 29573 | Cycle 1(1): loaded http://localhost:34218/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34218/tests/kraken/driver.html?testName=audio-fft) 15:13:57 INFO - PROCESS | 29573 | RSS: Main: 162992128 15:13:57 INFO - PROCESS | 29573 | 15:13:59 INFO - PROCESS | 29573 | Cycle 1(1): loaded http://localhost:34218/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34218/tests/kraken/driver.html?testName=audio-oscillator) 15:14:00 INFO - PROCESS | 29573 | RSS: Main: 163446784 15:14:00 INFO - PROCESS | 29573 | 15:14:02 INFO - PROCESS | 29573 | Cycle 1(1): loaded http://localhost:34218/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34218/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:14:02 INFO - PROCESS | 29573 | RSS: Main: 163680256 15:14:02 INFO - PROCESS | 29573 | 15:14:06 INFO - PROCESS | 29573 | Cycle 1(1): loaded http://localhost:34218/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34218/tests/kraken/driver.html?testName=imaging-darkroom) 15:14:06 INFO - PROCESS | 29573 | RSS: Main: 164098048 15:14:06 INFO - PROCESS | 29573 | 15:14:10 INFO - PROCESS | 29573 | Cycle 1(1): loaded http://localhost:34218/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34218/tests/kraken/driver.html?testName=imaging-desaturate) 15:14:10 INFO - PROCESS | 29573 | RSS: Main: 162496512 15:14:10 INFO - PROCESS | 29573 | 15:14:13 INFO - PROCESS | 29573 | Cycle 1(1): loaded http://localhost:34218/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34218/tests/kraken/driver.html?testName=json-parse-financial) 15:14:14 INFO - PROCESS | 29573 | RSS: Main: 163282944 15:14:14 INFO - PROCESS | 29573 | 15:14:16 INFO - PROCESS | 29573 | Cycle 1(1): loaded http://localhost:34218/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34218/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:14:16 INFO - PROCESS | 29573 | RSS: Main: 163450880 15:14:16 INFO - PROCESS | 29573 | 15:14:18 INFO - PROCESS | 29573 | Cycle 1(1): loaded http://localhost:34218/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34218/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:14:19 INFO - PROCESS | 29573 | RSS: Main: 163926016 15:14:19 INFO - PROCESS | 29573 | 15:14:21 INFO - PROCESS | 29573 | Cycle 1(1): loaded http://localhost:34218/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34218/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:14:22 INFO - PROCESS | 29573 | RSS: Main: 164425728 15:14:22 INFO - PROCESS | 29573 | 15:14:24 INFO - PROCESS | 29573 | Cycle 1(1): loaded http://localhost:34218/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34218/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:14:25 INFO - PROCESS | 29573 | RSS: Main: 164564992 15:14:25 INFO - PROCESS | 29573 | 15:14:28 INFO - PROCESS | 29573 | Cycle 1(1): loaded http://localhost:34218/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34218/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:14:28 INFO - PROCESS | 29573 | RSS: Main: 164405248 15:14:28 INFO - PROCESS | 29573 | 15:14:30 INFO - PROCESS | 29573 | Cycle 1(1): loaded http://localhost:34218/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34218/tests/kraken/driver.html?testName=ai-astar) 15:14:30 INFO - PROCESS | 29573 | RSS: Main: 165625856 15:14:30 INFO - PROCESS | 29573 | 15:14:30 INFO - PROCESS | 29573 | __start_tp_report 15:14:30 INFO - PROCESS | 29573 | _x_x_mozilla_page_load 15:14:30 INFO - PROCESS | 29573 | _x_x_mozilla_page_load_details 15:14:30 INFO - PROCESS | 29573 | |i|pagename|runs| 15:14:30 INFO - PROCESS | 29573 | |0;ai-astar;108;110;103;109;110;111;103;110;110;110 15:14:30 INFO - PROCESS | 29573 | |1;audio-beat-detection;152;124;157;206;125;151;157;132;192;125 15:14:30 INFO - PROCESS | 29573 | |2;audio-dft;163;163;162;162;164;169;169;164;162;167 15:14:30 INFO - PROCESS | 29573 | |3;audio-fft;75;76;75;160;75;75;73;75;171;75 15:14:30 INFO - PROCESS | 29573 | |4;audio-oscillator;90;92;171;98;93;91;153;97;91;155 15:14:30 INFO - PROCESS | 29573 | |5;imaging-gaussian-blur;117;117;117;118;117;117;118;118;118;119 15:14:30 INFO - PROCESS | 29573 | |6;imaging-darkroom;147;147;148;147;147;147;147;146;146;147 15:14:30 INFO - PROCESS | 29573 | |7;imaging-desaturate;96;96;95;96;95;95;96;95;95;95 15:14:30 INFO - PROCESS | 29573 | |8;json-parse-financial;54;55;55;55;55;56;57;107;53;56 15:14:30 INFO - PROCESS | 29573 | |9;json-stringify-tinderbox;58;59;59;58;58;58;58;58;59;63 15:14:30 INFO - PROCESS | 29573 | |10;stanford-crypto-aes;79;78;86;83;79;78;85;78;80;79 15:14:30 INFO - PROCESS | 29573 | |11;stanford-crypto-ccm;120;125;122;143;122;122;119;120;184;124 15:14:30 INFO - PROCESS | 29573 | |12;stanford-crypto-pbkdf2;166;161;159;159;160;159;160;160;165;161 15:14:30 INFO - PROCESS | 29573 | |13;stanford-crypto-sha256-iterative;63;67;66;66;61;62;62;61;61;63 15:14:30 INFO - PROCESS | 29573 | __end_tp_report 15:14:30 INFO - PROCESS | 29573 | __start_cc_report 15:14:30 INFO - PROCESS | 29573 | _x_x_mozilla_cycle_collect,841 15:14:30 INFO - PROCESS | 29573 | __end_cc_report 15:14:30 INFO - PROCESS | 29573 | __startTimestamp1463177670635__endTimestamp 15:14:30 INFO - PROCESS | 29573 | 15:14:30 INFO - PROCESS | 29573 | ------- Summary: start ------- 15:14:30 INFO - PROCESS | 29573 | Number of tests: 14 15:14:30 INFO - PROCESS | 29573 | 15:14:30 INFO - PROCESS | 29573 | [#0] ai-astar Cycles:10 Average:108.40 Median:110.00 stddev:2.95 (2.7%) stddev-sans-first:3.13 15:14:30 INFO - PROCESS | 29573 | Values: 108.0 110.0 103.0 109.0 110.0 111.0 103.0 110.0 110.0 110.0 15:14:30 INFO - PROCESS | 29573 | 15:14:30 INFO - PROCESS | 29573 | [#1] audio-beat-detection Cycles:10 Average:152.10 Median:154.50 stddev:28.30 (18.3%) stddev-sans-first:30.02 15:14:30 INFO - PROCESS | 29573 | Values: 152.0 124.0 157.0 206.0 125.0 151.0 157.0 132.0 192.0 125.0 15:14:30 INFO - PROCESS | 29573 | 15:14:30 INFO - PROCESS | 29573 | [#2] audio-dft Cycles:10 Average:164.50 Median:164.00 stddev:2.80 (1.7%) stddev-sans-first:2.92 15:14:30 INFO - PROCESS | 29573 | Values: 163.0 163.0 162.0 162.0 164.0 169.0 169.0 164.0 162.0 167.0 15:14:30 INFO - PROCESS | 29573 | 15:14:30 INFO - PROCESS | 29573 | [#3] audio-fft Cycles:10 Average:93.00 Median:75.00 stddev:38.31 (51.1%) stddev-sans-first:40.07 15:14:30 INFO - PROCESS | 29573 | Values: 75.0 76.0 75.0 160.0 75.0 75.0 73.0 75.0 171.0 75.0 15:14:30 INFO - PROCESS | 29573 | 15:14:30 INFO - PROCESS | 29573 | [#4] audio-oscillator Cycles:10 Average:113.10 Median:91.50 stddev:32.57 (35.6%) stddev-sans-first:33.46 15:14:30 INFO - PROCESS | 29573 | Values: 90.0 92.0 171.0 98.0 93.0 91.0 153.0 97.0 91.0 155.0 15:14:30 INFO - PROCESS | 29573 | 15:14:30 INFO - PROCESS | 29573 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.70 (0.6%) stddev-sans-first:0.71 15:14:30 INFO - PROCESS | 29573 | Values: 117.0 117.0 117.0 118.0 117.0 117.0 118.0 118.0 118.0 119.0 15:14:30 INFO - PROCESS | 29573 | 15:14:30 INFO - PROCESS | 29573 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 15:14:30 INFO - PROCESS | 29573 | Values: 147.0 147.0 148.0 147.0 147.0 147.0 147.0 146.0 146.0 147.0 15:14:30 INFO - PROCESS | 29573 | 15:14:30 INFO - PROCESS | 29573 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 15:14:30 INFO - PROCESS | 29573 | Values: 96.0 96.0 95.0 96.0 95.0 95.0 96.0 95.0 95.0 95.0 15:14:30 INFO - PROCESS | 29573 | 15:14:30 INFO - PROCESS | 29573 | [#8] json-parse-financial Cycles:10 Average:60.30 Median:55.00 stddev:16.45 (29.9%) stddev-sans-first:17.28 15:14:30 INFO - PROCESS | 29573 | Values: 54.0 55.0 55.0 55.0 55.0 56.0 57.0 107.0 53.0 56.0 15:14:30 INFO - PROCESS | 29573 | 15:14:30 INFO - PROCESS | 29573 | [#9] json-stringify-tinderbox Cycles:10 Average:58.80 Median:58.50 stddev:1.55 (2.6%) stddev-sans-first:1.62 15:14:30 INFO - PROCESS | 29573 | Values: 58.0 59.0 59.0 58.0 58.0 58.0 58.0 58.0 59.0 63.0 15:14:30 INFO - PROCESS | 29573 | 15:14:30 INFO - PROCESS | 29573 | [#10] stanford-crypto-aes Cycles:10 Average:80.50 Median:79.50 stddev:3.03 (3.8%) stddev-sans-first:3.16 15:14:30 INFO - PROCESS | 29573 | Values: 79.0 78.0 86.0 83.0 79.0 78.0 85.0 78.0 80.0 79.0 15:14:30 INFO - PROCESS | 29573 | 15:14:30 INFO - PROCESS | 29573 | [#11] stanford-crypto-ccm Cycles:10 Average:130.10 Median:123.00 stddev:20.16 (16.4%) stddev-sans-first:21.05 15:14:30 INFO - PROCESS | 29573 | Values: 120.0 125.0 122.0 143.0 122.0 122.0 119.0 120.0 184.0 124.0 15:14:30 INFO - PROCESS | 29573 | 15:14:30 INFO - PROCESS | 29573 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.00 Median:160.50 stddev:2.49 (1.6%) stddev-sans-first:1.88 15:14:30 INFO - PROCESS | 29573 | Values: 166.0 161.0 159.0 159.0 160.0 159.0 160.0 160.0 165.0 161.0 15:14:30 INFO - PROCESS | 29573 | 15:14:30 INFO - PROCESS | 29573 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.20 Median:63.00 stddev:2.30 (3.7%) stddev-sans-first:2.44 15:14:30 INFO - PROCESS | 29573 | Values: 63.0 67.0 66.0 66.0 61.0 62.0 62.0 61.0 61.0 63.0 15:14:30 INFO - PROCESS | 29573 | -------- Summary: end -------- 15:14:30 INFO - PROCESS | 29573 | 15:14:31 INFO - TEST-INFO | 29573: exit 0 15:14:31 INFO - TEST-OK | kraken | took 62399ms 15:14:31 INFO - SUITE-END | took 1172s 15:14:31 INFO - Completed test suite (00:19:32) 15:14:31 INFO - javascript benchmark 15:14:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7183.634859492746, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3188.2826364068087, 3219.1952011997, 3246.009966960077, 3256.9674303256975, 3277.6066871975368, 5481.780728770849, 5491.752871120794, 5607.214989901417, 5657.519110875581, 5659.8585035374135, 5532.059549876521, 5554.527865131458, 5555.416681248471, 5597.7201139942945, 5616.859578510539, 4987.102321582114, 5013.0, 5117.872053198681, 5162.070827251093, 5202.907389448221, 918.1131913042163, 4934.25986102084, 5027.974860125712, 5073.441921388644, 5205.505476979681, 5034.42104158021, 5047.49525047496, 5061.949380506185, 5080.41575218849, 5093.6943783372935, 5090.898182036375, 5095.949040509585, 5100.413452452978, 5101.591872650216, 5156.9742151289, 4944.307796908436, 5024.472430394829, 5060.848174554732, 5091.745412729349, 5094.235864620299, 5463.508284254396, 5496.532794712454, 5543.861403464905, 5585.58108141891, 5631.014572449805, 6041.939580604182, 6045.486133678643, 6050.606710563799, 6055.364186760415, 6074.453299203093, 5877.500412464946, 5886.823395298148, 5903.321118071391, 6082.2093127893095, 6112.63324200545, 5543.972280138573, 5546.972265138689, 5547.611667183299, 5549.667019978814, 5574.86062848428, 5993.400659934059, 6032.487238584682, 6049.485793707496, 6064.878702425926, 6069.666168360694, 5711.885762284731, 5805.071188609802, 5870.383609721003, 5914.290285165807, 5950.285965684146, 6039.78860739872, 6040.244969378828, 6076.149339092531, 6076.240469941257, 6083.361247068994, 6012.579119461683, 6021.096835474714, 6037.305709843336, 6040.456358927718, 6045.093236014633, 5810.157527158538, 5891.911621325684, 5939.970300148558, 5961.612495187799, 6038.516918646497, 4511.639068874482, 4517.299818528133, 4538.04701012791, 4541.296099104644, 4589.426321709786, 3931.4495970564144, 4026.7181297309494, 4044.0496483326397, 4060.6548443382053, 4090.652294554996, 5558.666480011212, 5628.521575666115, 5717.285339332583, 5755.0, 5759.596828221985, 5922.615030023035, 5969.970150149308, 6005.369436209223, 6021.608595441282, 6035.30593981689, 5567.220589117527, 5748.798792042258, 5749.770009199585, 5752.424757524214, 5755.079187330007, 5051.393832740095, 5065.062963351792, 5076.695398276115, 5083.61872859537, 5113.565346945476, 6113.908291375633, 6138.539609529304, 6159.4456498914415, 6172.783952561639, 6185.103160041769, 5852.678102704393, 5947.732352044082, 5960.701964901824, 6018.909716354171, 6025.758969641165, 6112.837854638657, 6239.563230573816, 6245.250569931637, 6251.031090181029, 6253.843653908507, 5960.910586341295, 5970.104484327386, 5973.731182096729, 5985.102234664835, 6020.367861374668, 5923.141144533933, 5975.760969561343, 6040.395960403925, 6077.4226448487325, 6077.453029227391, 5932.4957378621575, 5933.110033495011, 5936.732847021981, 5938.881222375615, 5992.8501787453915, 5862.706864656835, 5924.4667979882015, 5925.140854576149, 5927.496162826208, 5927.851803704942, 5633.0987042073075, 5686.658800471985, 5720.942790572041, 5734.54123670097, 5797.913031304618, 5867.853303667272, 5927.644341339534, 5934.525237981037, 5936.643801371932, 5947.672877991752, 5775.33583637887, 5777.133429985536, 5802.82591522255, 5814.825555233349, 5820.621659592113], "value": 5485.401672347372, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [601.5518438763122, 646.0632083478955, 648.4488185042711, 660.8711301296249, 664.6776313487958, 31785.841070794642, 45814.312785308204, 47105.057898842046, 47116.29325560111, 47135.0, 45142.322865157046, 45465.77267113668, 45515.54484455154, 45528.3170752439, 45570.77214613922, 8894.155055269739, 8971.237444817198, 8997.235235005033, 9029.0, 9033.141851524095, 8818.514981676006, 8922.375433719642, 8929.598168082452, 8934.329925255599, 8947.552622368888, 8916.509591972439, 8940.597673104694, 8948.284137269004, 8979.595918183697, 9000.189982901538, 8886.20024197822, 8917.42036767608, 8918.152775486318, 8937.374383793138, 8969.416987895765, 8793.0, 8812.1187881212, 8831.690890818854, 8836.55817209137, 8866.113388661146, 41207.58792412067, 41389.1722165558, 41403.58596414027, 41460.792696036326, 41607.58392416098, 3856.633619806114, 4021.8391264349393, 4312.417823593806, 4408.58118478744, 4410.0077482566485, 31262.0, 32061.198470038435, 32127.678723212703, 32235.0, 33346.1663458413, 4323.200207961506, 4332.523422423531, 4360.454943132108, 4407.338899165119, 4417.620520301972, 364266.1786691076, 365498.0, 365714.0, 365819.0, 365938.0, 58134.70932645394, 59013.0, 59058.40941590615, 59088.40911590915, 59271.0, 36190.45714314287, 36782.26435471329, 37095.814520927765, 38687.806560967576, 38722.0, 17321.653566928842, 17396.652066958843, 17534.82465175332, 17566.736498952527, 17587.73618395725, 13770.104943178862, 13780.724385512434, 13848.723025539633, 13864.861351386558, 13870.237136957363, 19817.306394276133, 19861.900690496743, 19890.70163947542, 19922.605417620918, 20103.899480502798, 7594.392448604099, 7629.351505122127, 7707.730229441942, 7799.142094369615, 7806.804829879298, 1001.5493028137367, 1108.6286094158386, 1139.8575178102737, 1159.565163063851, 1268.492602958824, 33080.338393232, 33304.33391332208, 33481.99554013384, 33704.49443258353, 33737.662623373944, 1164.615676826645, 1202.8857258560597, 1242.7514497100435, 1260.848698156227, 1284.6852521132196, 17383.826161738474, 17508.12459377026, 17529.7370539442, 17639.559011024572, 17647.38234161824, 557789.0, 558054.0, 563331.0, 563629.0, 564908.0, 59646.70176649089, 59865.102023469684, 60235.69882150561, 60391.39608603946, 60515.0, 1429.535400994681, 1439.4458133618423, 1448.1890141520782, 1450.753371926775, 1458.9781153282709, 31705.0, 31935.840320799176, 32256.0, 32577.511337329484, 32736.83631581827, 52115.0, 52366.0, 52935.20597190968, 52948.735256323474, 52999.0, 471576.0, 473065.0, 473843.0, 478134.0, 479429.0, 28579.714202857704, 28723.138305850858, 29131.0, 29196.124116276547, 29219.85390073036, 49673.75163124306, 49959.75020124876, 49988.75005624948, 50556.0, 51092.48907511026, 40786.0, 41759.536648692076, 41772.0, 41898.37152442655, 43065.78467107644, 41899.37150942799, 42050.57949420466, 42355.576444235165, 42539.7873010633, 42598.57401425946, 36542.0, 41146.794266029676, 41370.1725965485, 42117.78941105275, 42764.78617606892, 35587.0, 37028.0, 37481.4377784328, 37609.4358584616, 37785.24429511449, 29028.419431611674, 29084.27289317784, 29361.0, 29406.852965735034, 29462.558061628664], "value": 20593.210537454554, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [387.86424751337034, 391.11998004489897, 400.9899752506189, 409.7357204603029, 421.1639894808804, 15756.684866302667, 18056.548586285335, 19300.903495482504, 19447.902760486195, 19660.803391966077, 18933.62132757344, 19245.133968971393, 19382.709259361087, 19492.51268718283, 19606.803931960676, 5372.301600791891, 5575.0, 5674.063779476382, 5677.687727175004, 5752.5110365618975, 5670.829875103754, 5723.599348045638, 5824.941750582482, 6533.673316334188, 6544.541882068257, 6400.583962042476, 6400.615963042209, 6425.389587989133, 6456.128422662928, 6460.93539064608, 5880.55895807814, 5882.735276912549, 5899.115132730103, 5899.616524925866, 6199.938000620004, 5519.144532597454, 5654.9151762723595, 5669.26299581056, 5705.372409035002, 5737.713114344266, 12780.233186008869, 13084.411201495956, 13091.214527128403, 13136.737265254642, 13144.60566183016, 2236.944076398087, 2259.830512711553, 2289.599320118989, 2307.665388518672, 2411.722651895037, 10157.644482443153, 10220.795584088277, 10245.872953975057, 10249.538770755335, 10440.530176142092, 1978.2581531925528, 1983.761948566167, 2049.825764809993, 2065.5042789730505, 2076.2110398048794, 52276.738616307055, 64416.0, 89558.55220723855, 90064.09935900688, 90465.54767226188, 10592.735181620521, 10872.945635271773, 10894.891051089546, 11004.449777511092, 11170.609028683957, 12569.434375453127, 14230.501932432315, 15190.46833360827, 15580.610484737972, 15617.60955976087, 8041.959790201012, 8078.35373170145, 8321.708740194184, 8345.707900223462, 8413.621387037598, 7772.067351917806, 7775.028121484815, 7775.92224077752, 7927.8810817837775, 7976.481528700616, 4622.560856718606, 4667.416572928384, 4671.766411679402, 4756.524347565285, 4769.833055843029, 1943.319838056669, 1976.170008596393, 1981.3758666020158, 1982.415187519685, 1984.295575070829, 474.4792938631677, 486.40415491023214, 1037.899826184247, 1039.3400190878847, 1047.2407504559133, 11055.613053543088, 11568.190226684219, 11715.941420292844, 11747.236429632047, 11952.0, 484.6486297434402, 489.168413696717, 489.46892621505356, 497.2665318655027, 501.7190373390913, 6269.310375858652, 6486.156799616019, 6503.934960650333, 6526.477881769542, 6537.1501704778075, 511808.0, 514498.0, 518260.0, 531130.0, 532363.0, 99462.0, 100503.0, 100526.0, 103694.48152759188, 104468.0, 481.22762965439966, 486.2948724349636, 488.35780948053196, 488.6970078551321, 490.94108706955393, 10592.682219533426, 10648.307859989076, 10901.890981090404, 10984.395858227874, 11004.944975275072, 38604.2279154421, 40391.0, 41505.1698966025, 42684.5731542693, 43403.0, 50782.238266425295, 52201.47798521966, 54351.0, 54449.0, 56016.0, 8428.367872409472, 8726.258268047033, 8732.91267087321, 8844.380893337404, 9113.997460279497, 9187.724368268962, 12043.518259269882, 12865.614031579067, 12892.419841106985, 12960.351982400654, 7437.702491900263, 10842.891571084503, 11355.48900299472, 11450.770984580095, 11457.677273590565, 6450.677466126769, 7783.637863373774, 10925.781484370109, 10931.617393391192, 11110.055645270242, 11428.657140285804, 11532.769344612892, 11579.305241685526, 11641.230898220381, 11764.82352764692, 8612.65549378018, 8752.956235218782, 8814.162654547808, 9010.63957441695, 9080.0, 8620.353473489638, 10053.246006549683, 10551.050405463546, 10609.575616975235, 10767.730806729895], "value": 8253.527600076968, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1556.7120082784681, 1588.6663800601873, 1773.67187070392, 1884.095634095635, 1885.9811401885977, 8414.495130292187, 9082.727518174448, 9108.635654573818, 9723.17353024993, 9723.416595004286, 9165.312601554877, 9395.859062114074, 9466.857997130048, 9496.240300775939, 9561.378510396837, 2445.3397582652674, 2474.987625061872, 2485.229578830559, 2493.2769496845895, 2500.9749902500926, 2441.108995216742, 2495.238952119603, 2496.6005439129744, 2500.57490226661, 2505.523950449418, 2411.7588241175918, 2415.661807346964, 2427.8421902576274, 2436.817238707104, 2438.926832195037, 2426.1387207541334, 2430.769076937697, 2431.0154387473103, 2468.7531246875346, 2469.0987789456717, 2382.5949588569983, 2385.7017872765905, 2387.2599494156866, 2396.700412448444, 2419.2742177346727, 9455.29085318597, 9523.666671666528, 9546.379485333431, 9550.761230969212, 9579.760505987337, 5679.4036626154075, 5855.092460668603, 5855.707214639251, 5856.853578660525, 5868.4424979626865, 3473.94789078164, 3474.2530355973586, 3601.5858176309534, 3619.9095022624647, 3624.003399065252, 1094.1848322999338, 1117.3463523838484, 1130.3161587239683, 1130.3444002478625, 1137.527925910746, 13436.0, 13577.796333054914, 13600.999999999902, 13638.0, 13672.863271367258, 4992.026554821848, 4992.825251116194, 5109.38687357512, 5170.40540337866, 5220.425753167148, 11205.215634905479, 11305.547778088785, 11321.660350189508, 11349.432528373549, 11358.375289359165, 5654.97172514143, 5757.280339957505, 5758.337791153987, 5768.682722450221, 5850.0932355484965, 4692.648051396159, 5064.82273120439, 5150.0472412603785, 5154.433012368637, 5300.072487314705, 4333.978330108329, 4335.934960975588, 4434.689571729948, 4461.531539188403, 4583.656225783013, 1370.2395170680368, 1393.7142885708406, 1414.8655877691604, 1423.323921137472, 1426.408040663134, 894.9731508054768, 1014.6448742939912, 1025.4308858583559, 1034.5292891734393, 1053.083817079146, 6077.817665470043, 6163.106349579376, 6285.088662143963, 6351.714172862232, 6424.453921416639, 465.8509277031385, 475.2064053031446, 475.36301356182884, 478.4927976345085, 489.54227797009196, 4229.2175947449205, 4261.936070958876, 4269.914601707948, 4321.827126914888, 4354.869353919387, 11726.355050472306, 11930.164888457724, 12112.878871211175, 12135.87864121365, 12136.635900922987, 11530.0, 11893.702657433634, 11966.0, 12020.038396928225, 12022.579209727792, 8649.308055355683, 8722.86915696265, 8772.254358379609, 8823.69117080899, 8825.646974120964, 5937.524998000236, 5988.461038506555, 6048.758049678139, 6070.484008859296, 6070.848228794315, 10812.891871081189, 11023.61417350389, 11085.889141108808, 11086.501107450023, 11192.496337664661, 11017.283876548, 11151.052160566118, 11177.608783692533, 11282.548698052315, 11315.377654228767, 7624.351930085783, 8132.471389359673, 8352.33181345503, 8508.829823403374, 8578.571071446528, 9257.0, 9292.814143716952, 9342.673006444742, 9344.626214951597, 9381.390209636353, 8034.397420193626, 8350.373721970755, 8355.791105222417, 8491.702790402307, 8566.0, 8162.347012239125, 8182.099969003524, 8182.7545173644885, 8263.545504997282, 8327.708530201415, 7109.146902371748, 7244.0, 7303.853922921406, 7313.232110628307, 7463.92536074654, 5435.483629055233, 5468.808591699271, 5532.529734972572, 5604.8038318658655, 5667.716614169358, 5393.757280922289, 5479.808206712746, 5575.609707320448, 5610.495055444866, 5696.287964004499], "value": 4876.736669634115, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [320.4424301715015, 332.247459504223, 333.19034745568257, 342.1770641606935, 342.56323187935385, 5494.5054945055035, 5553.916986187695, 5662.725886675491, 5720.342160651527, 5800.941990580093, 5584.5811564132755, 5618.719064046802, 5619.80330688426, 5623.915641265385, 5658.0, 4418.5802348776815, 4420.425344705184, 4428.180786554498, 4449.5995360417555, 4456.621187199092, 4193.748375097489, 4408.16244913467, 4414.470263568376, 4466.575675310856, 4468.575485328888, 4316.740995540277, 4337.761423121727, 4366.214081465335, 4375.606195442409, 4387.924958385184, 4361.60745532902, 4384.188925048844, 4385.934210986838, 4409.184300904343, 4421.624161946238, 3740.8503659853573, 3809.647575110851, 3846.499955005859, 3856.82644281008, 3863.092173339263, 5392.433794451605, 5407.83776486706, 5419.21166015214, 5429.837104886859, 5463.781448742086, 4961.9751901240625, 4972.776225069844, 4981.327520784684, 4995.375578052744, 5010.423801262865, 5786.768529258825, 5906.8818623627285, 5938.7030648467835, 5939.703014849283, 5964.343922168558, 4182.749035057906, 4230.598093181143, 4239.851605193803, 4247.214265360918, 4253.447051883266, 6040.550267935708, 6078.088286756978, 6082.9695851520455, 6090.817275481742, 6092.147099406043, 4172.144710334434, 4256.61690447855, 4270.081932384553, 4270.530241673413, 4285.228658841376, 4314.331278651814, 4332.913341733148, 4339.869803905888, 4339.891502712458, 4357.8256869724855, 4963.478834722375, 4973.154563724103, 4976.825811096594, 4988.426330971912, 5010.799568017312, 5688.658680479184, 5919.141724449931, 5949.9107513387335, 5998.910016349758, 6031.0, 1483.703259348113, 1490.3814916809404, 1495.132822962679, 1507.796447479598, 1507.92660092373, 914.9862752058724, 945.9716208513755, 948.9419297483256, 953.5851904421598, 958.6740508227097, 5133.563647089964, 5152.407473140637, 5164.870878228075, 5174.586033117342, 5184.37787465499, 5405.891882162414, 5441.401445840955, 5452.236686863842, 5505.944940550543, 5536.843998920657, 4967.875803104951, 5129.948700512947, 5169.172932330809, 5172.8965420691375, 5209.317201641158, 2885.2786803299177, 2957.719016693454, 2969.4410434522047, 2971.9554206686917, 2972.420378026264, 5499.642523236057, 5553.305836770403, 5578.847950907724, 5679.318481782213, 5686.5735069869925, 5248.110680155141, 5462.852800911853, 5490.862728431741, 5491.203775452537, 5561.972190139023, 5421.783128674888, 5481.698506582176, 5524.723763811793, 5566.443355664401, 5581.3302403711, 5313.973430132824, 5330.387005494418, 5511.58663100261, 5512.889742205213, 5519.862003449946, 5373.838784836461, 5405.486478784509, 5427.701476418835, 5461.15352120422, 5472.835814925558, 5573.331200255995, 5631.831045068655, 5650.576206784425, 6015.669138197266, 6194.845128871634, 4234.724742891703, 4237.8304867804945, 4246.532881382984, 4285.657147428261, 4294.806733696929, 6135.202423684892, 6148.9692551536955, 6156.815295541141, 6184.753004672583, 6206.658633775186, 5731.398203188605, 5882.205902203148, 5905.232319798399, 5921.733521991435, 5972.611780234444, 5869.354371019099, 5896.764129434775, 5901.203337549376, 5920.934231838311, 5963.70181490915, 5650.29371328584, 5811.651300921958, 5828.446297601721, 5839.182514447895, 5865.824025279248, 5883.794067207627, 5943.821685349447, 5963.373845746134, 5967.433093856077, 5998.4601385875485, 5863.2670916135485, 5868.853278668067, 5878.353381127987, 5928.851778705394, 5936.465718085393], "value": 4365.17244077179, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [831.5883637599389, 846.3863698818355, 885.8439736144333, 886.9201771840533, 896.1934259166745, 14325.78511322331, 15385.769213461794, 15581.532554023397, 15634.061956282616, 15645.295961681722, 14244.21656808875, 14379.78430323546, 14445.133292002487, 14449.711005779878, 14515.346809393577, 866.3285953386129, 867.4968518259426, 869.6825658634616, 874.7725591346232, 881.5856547422701, 860.2386887604483, 863.5552690364467, 865.6796985115516, 867.9522626255554, 871.4335681806845, 918.4443411735904, 920.1994264989469, 920.2913756407562, 923.9445633261993, 924.1036194890945, 919.995400022999, 920.3143657974852, 920.5351297594739, 920.9631614735436, 921.3182245138617, 662.2251965200678, 665.0356982375527, 666.5334266013762, 667.1760375935716, 667.3926726678748, 13700.93149534256, 13739.862601373958, 13779.931100344535, 13789.310534473236, 13838.584842454742, 12618.621441356774, 12623.495060197582, 12697.746045079046, 12701.301428421433, 12723.300218487979, 11070.833937490863, 11177.105831533458, 11286.209965302432, 11461.36962467064, 11471.311721296666, 3797.3354662933875, 3840.8847734568008, 3883.728139030269, 3889.8249578769023, 3892.8442862285474, 55560.0, 56615.71692141513, 56832.14751778726, 56877.0, 56992.14511782327, 9701.708948731408, 9805.950970245103, 9817.803643927224, 9865.506724663737, 9920.0, 17208.225629846438, 17245.65508689844, 17247.396341128253, 17361.91319043422, 17379.304827807, 8117.512949223065, 8377.581120943929, 8457.407981441364, 8803.295736341077, 8830.86753698695, 4625.0, 4756.857294281177, 4767.189577771787, 4871.537203965689, 4960.975195124001, 3566.28674265148, 3649.8905032849057, 3703.0372103252807, 3710.591834898159, 3717.683996860243, 643.520577170002, 652.1717418877998, 657.2310396835618, 663.1660736114292, 666.9899951500731, 791.5409062743595, 803.2409373142324, 806.7781360126012, 812.7439856445201, 841.7264389073575, 9708.563114659857, 10162.949185254174, 10186.337888037255, 10337.173026157889, 10461.110805581611, 695.3776370148688, 745.2249660353281, 774.3895477267235, 793.2226418110284, 803.5620586780102, 4653.302004699254, 4657.231556793091, 4746.359241502353, 4747.976260118678, 4755.500672429414, 65547.34452655508, 66501.33498665049, 66738.0, 67764.0, 67842.3215767836, 47743.522564773906, 51557.74221128871, 57699.0, 57952.13071803926, 59556.40443595508, 49148.262776058385, 53759.73120134374, 53860.192097118575, 54819.0, 54912.0, 8408.789780255298, 8567.186117318844, 8598.441101328393, 9469.810603788024, 9703.466309353053, 36401.817990909876, 37070.0, 37166.07084822793, 37208.44187337138, 37383.81308093442, 49148.75425622849, 50755.49244507508, 51443.228351574006, 51722.0, 51801.7409912948, 11401.828972565583, 11461.369624670722, 11559.248648837798, 11588.0, 12112.333821639895, 8361.163883611833, 10097.293189476666, 12888.355582220664, 13519.792556620083, 13692.65768355799, 12241.571544996239, 12332.32172230536, 12444.0, 12963.740725185633, 12966.805497917727, 12130.393480325773, 12193.451294691937, 12577.622671319876, 12967.416466258852, 13030.478780849038, 12585.622431327074, 12644.30456324911, 12951.740965180832, 13023.348832558144, 13088.803667944798, 10276.22928280367, 10530.05229529346, 10666.46667666629, 11001.779964400826, 11061.72345691332, 9944.45305508175, 10067.395956242648, 10405.687829365132, 10433.165346772392, 10824.458777061272], "value": 6923.429527244245, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1544.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 110.0, 103.0, 109.0, 110.0, 111.0, 103.0, 110.0, 110.0, 110.0], "value": 108.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 124.0, 157.0, 206.0, 125.0, 151.0, 157.0, 132.0, 192.0, 125.0], "value": 152.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 162.0, 162.0, 164.0, 169.0, 169.0, 164.0, 162.0, 167.0], "value": 164.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 160.0, 75.0, 75.0, 73.0, 75.0, 171.0, 75.0], "value": 93.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 92.0, 171.0, 98.0, 93.0, 91.0, 153.0, 97.0, 91.0, 155.0], "value": 113.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 118.0, 118.0, 118.0, 119.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 148.0, 147.0, 147.0, 147.0, 147.0, 146.0, 146.0, 147.0], "value": 146.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 95.0, 96.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 55.0, 55.0, 55.0, 56.0, 57.0, 107.0, 53.0, 56.0], "value": 60.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 59.0, 58.0, 58.0, 58.0, 58.0, 58.0, 59.0, 63.0], "value": 58.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 86.0, 83.0, 79.0, 78.0, 85.0, 78.0, 80.0, 79.0], "value": 80.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 125.0, 122.0, 143.0, 122.0, 122.0, 119.0, 120.0, 184.0, 124.0], "value": 130.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 161.0, 159.0, 159.0, 160.0, 159.0, 160.0, 160.0, 165.0, 161.0], "value": 161.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 67.0, 66.0, 66.0, 61.0, 62.0, 62.0, 61.0, 61.0, 63.0], "value": 63.2, "unit": "score"}]}]} 15:14:31 INFO - Return code: 0 15:14:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 15:14:31 ERROR - # TBPL SUCCESS # 15:14:31 INFO - Running post-action listener: _resource_record_post_action 15:14:31 INFO - ##### 15:14:31 INFO - ##### Finished run-tests step (success) 15:14:31 INFO - ##### 15:14:31 INFO - Running post-run listener: _resource_record_post_run 15:14:32 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 541065216; Read time: 8; Write time: 523548 15:14:32 INFO - TinderboxPrint: CPU usage
13.5% 15:14:32 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 15:14:32 INFO - TinderboxPrint: I/O write bytes / time
541,065,216 / 523,548 15:14:32 INFO - TinderboxPrint: CPU idle
8,214.3 (86.5%) 15:14:32 INFO - TinderboxPrint: CPU user
1,223.7 (12.9%) 15:14:32 INFO - TinderboxPrint: Swap in / out
0 / 0 15:14:32 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 252051456; Read time: 0; Write time: 290036 15:14:32 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4096; Write bytes: 285081600; Read time: 8; Write time: 233008 15:14:32 INFO - Running post-run listener: _upload_blobber_files 15:14:32 INFO - Blob upload gear active. 15:14:32 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:14:32 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 15:14:32 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'] 15:14:32 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 15:14:33 INFO - (blobuploader) - INFO - Open directory for files ... 15:14:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:14:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:14:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:14:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:14:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:14:33 INFO - (blobuploader) - INFO - Done attempting. 15:14:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:14:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:14:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:14:40 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:14:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:14:40 INFO - (blobuploader) - INFO - Done attempting. 15:14:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:14:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:14:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:14:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:14:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:14:41 INFO - (blobuploader) - INFO - Done attempting. 15:14:41 INFO - (blobuploader) - INFO - Iteration through files over. 15:14:41 INFO - Return code: 0 15:14:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:14:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:14:41 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/697c6cc7396c764f5eb99305f27b0f304c2e2cf7c9bc0c2653b764f8f5c7756f6836f88fac50a2ae6e582bcca29ed6420ccd1f37b754abf64aaf467cebdd208a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ca183ec18bd98d4066957cbe3405768d8844b8b5e4dd48597e10078fa16e0ff63d0d6cd3ae86802035b1c786d7a948ca683451afd9ddf86a82cc1fe547685e13", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c6232f7d747409d5b3d0a62241edf8bb32df8eb0a7346de359ccec01cf3b47fff674bcce4404f8ab6391ab9f2a22c653ac3dd70a74d0aa7606967f512eb7a3bd"} 15:14:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:14:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:14:41 INFO - Contents: 15:14:41 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/697c6cc7396c764f5eb99305f27b0f304c2e2cf7c9bc0c2653b764f8f5c7756f6836f88fac50a2ae6e582bcca29ed6420ccd1f37b754abf64aaf467cebdd208a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ca183ec18bd98d4066957cbe3405768d8844b8b5e4dd48597e10078fa16e0ff63d0d6cd3ae86802035b1c786d7a948ca683451afd9ddf86a82cc1fe547685e13", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c6232f7d747409d5b3d0a62241edf8bb32df8eb0a7346de359ccec01cf3b47fff674bcce4404f8ab6391ab9f2a22c653ac3dd70a74d0aa7606967f512eb7a3bd"} 15:14:41 INFO - Running post-run listener: copy_logs_to_upload_dir 15:14:41 INFO - Copying logs to upload dir... 15:14:41 INFO - mkdir: /builds/slave/test/build/upload/logs 15:14:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1231.058360 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-05-13 15:14:41.127285) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-13 15:14:41.130637) ========= 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=a0d2d2de893abaa8702a9954000001a7-1463176446.751826-2092259595 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/697c6cc7396c764f5eb99305f27b0f304c2e2cf7c9bc0c2653b764f8f5c7756f6836f88fac50a2ae6e582bcca29ed6420ccd1f37b754abf64aaf467cebdd208a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ca183ec18bd98d4066957cbe3405768d8844b8b5e4dd48597e10078fa16e0ff63d0d6cd3ae86802035b1c786d7a948ca683451afd9ddf86a82cc1fe547685e13", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c6232f7d747409d5b3d0a62241edf8bb32df8eb0a7346de359ccec01cf3b47fff674bcce4404f8ab6391ab9f2a22c653ac3dd70a74d0aa7606967f512eb7a3bd"} build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1463164213/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011198 build_url: 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1463164213/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/697c6cc7396c764f5eb99305f27b0f304c2e2cf7c9bc0c2653b764f8f5c7756f6836f88fac50a2ae6e582bcca29ed6420ccd1f37b754abf64aaf467cebdd208a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ca183ec18bd98d4066957cbe3405768d8844b8b5e4dd48597e10078fa16e0ff63d0d6cd3ae86802035b1c786d7a948ca683451afd9ddf86a82cc1fe547685e13", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c6232f7d747409d5b3d0a62241edf8bb32df8eb0a7346de359ccec01cf3b47fff674bcce4404f8ab6391ab9f2a22c653ac3dd70a74d0aa7606967f512eb7a3bd"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-13 15:14:41.155297) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 15:14:41.155606) ========= 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=a0d2d2de893abaa8702a9954000001a7-1463176446.751826-2092259595 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004680 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 15:14:41.238691) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-13 15:14:41.239001) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-13 15:14:41.239282) ========= ========= Total master_lag: 0.19 =========