builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-021 starttime: 1463011445.11 results: success (0) buildid: 20160511143008 builduid: 63cdd00e3c7340c1a6e82d6f9b542549 revision: 6581bbe179b96e153cbc54335681cfc5c9195d62 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-11 17:04:05.112586) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-11 17:04:05.113123) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-11 17:04:05.113422) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-11 17:04:05.130504) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 17:04:05.130853) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=df17445c3590ff7897617a0e00000225-1463002841.227289-1948646140 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-11 17:04:05-- 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% 224M=0s 2016-05-11 17:04:05 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.118545 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 17:04:05.268147) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 17:04:05.268425) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=df17445c3590ff7897617a0e00000225-1463002841.227289-1948646140 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014773 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 17:04:05.319585) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 17:04:05.319913) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 6581bbe179b96e153cbc54335681cfc5c9195d62 --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 6581bbe179b96e153cbc54335681cfc5c9195d62 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=df17445c3590ff7897617a0e00000225-1463002841.227289-1948646140 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-11 17:04:05,485 truncating revision to first 12 chars 2016-05-11 17:04:05,486 Setting DEBUG logging. 2016-05-11 17:04:05,486 attempt 1/10 2016-05-11 17:04:05,486 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/6581bbe179b9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-11 17:04:05,978 unpacking tar archive at: fx-team-6581bbe179b9/testing/mozharness/ program finished with exit code 0 elapsedTime=0.814333 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 17:04:06.150565) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-11 17:04:06.150838) ========= script_repo_revision: 6581bbe179b96e153cbc54335681cfc5c9195d62 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-11 17:04:06.151205) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-11 17:04:06.151464) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-11 17:04:06.161164) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-05-11 17:04:06.161434) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=df17445c3590ff7897617a0e00000225-1463002841.227289-1948646140 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:04:06 INFO - MultiFileLogger online at 20160511 17:04:06 in /builds/slave/test 17:04:06 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 17:04:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:04:06 INFO - {'append_to_log': False, 17:04:06 INFO - 'base_work_dir': '/builds/slave/test', 17:04:06 INFO - 'blob_upload_branch': 'Fx-Team', 17:04:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:04:06 INFO - 'branch': 'Fx-Team', 17:04:06 INFO - 'buildbot_json_path': 'buildprops.json', 17:04:06 INFO - 'config_files': ('talos/linux_config.py',), 17:04:06 INFO - 'default_actions': ('clobber', 17:04:06 INFO - 'read-buildbot-config', 17:04:06 INFO - 'download-and-extract', 17:04:06 INFO - 'populate-webroot', 17:04:06 INFO - 'create-virtualenv', 17:04:06 INFO - 'install', 17:04:06 INFO - 'run-tests'), 17:04:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:04:06 INFO - 'download_minidump_stackwalk': True, 17:04:06 INFO - 'download_symbols': 'ondemand', 17:04:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:04:06 INFO - 'tooltool.py': '/tools/tooltool.py', 17:04:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:04:06 INFO - '/tools/misc-python/virtualenv.py')}, 17:04:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:04:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:04:06 INFO - 'installer_path': 'installer.exe', 17:04:06 INFO - 'log_level': 'info', 17:04:06 INFO - 'log_name': 'talos', 17:04:06 INFO - 'log_to_console': True, 17:04:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:04:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:04:06 INFO - 'opt_config_files': (), 17:04:06 INFO - 'pip_index': False, 17:04:06 INFO - 'sps_profile': False, 17:04:06 INFO - 'sps_profile_interval': 0, 17:04:06 INFO - 'suite': 'dromaeojs-e10s', 17:04:06 INFO - 'system_bits': '32', 17:04:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:04:06 INFO - 'title': 'talos-linux64-ix-021', 17:04:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:04:06 INFO - 'use_talos_json': True, 17:04:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:04:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:04:06 INFO - 'work_dir': 'build'} 17:04:06 INFO - ##### 17:04:06 INFO - ##### Running clobber step. 17:04:06 INFO - ##### 17:04:06 INFO - Running pre-action listener: _resource_record_pre_action 17:04:06 INFO - Running main action method: clobber 17:04:06 INFO - rmtree: /builds/slave/test/build 17:04:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:04:06 INFO - Running post-action listener: _resource_record_post_action 17:04:06 INFO - ##### 17:04:06 INFO - ##### Finished clobber step (success) 17:04:06 INFO - ##### 17:04:06 INFO - ##### 17:04:06 INFO - ##### Running read-buildbot-config step. 17:04:06 INFO - ##### 17:04:06 INFO - Running pre-action listener: _resource_record_pre_action 17:04:06 INFO - Running main action method: read_buildbot_config 17:04:06 INFO - Using buildbot properties: 17:04:06 INFO - { 17:04:06 INFO - "project": "", 17:04:06 INFO - "product": "firefox", 17:04:06 INFO - "script_repo_revision": "production", 17:04:06 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 17:04:06 INFO - "repository": "", 17:04:06 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 17:04:06 INFO - "buildid": "20160511143008", 17:04:06 INFO - "pgo_build": "True", 17:04:06 INFO - "basedir": "/builds/slave/test", 17:04:06 INFO - "buildnumber": 317, 17:04:06 INFO - "slavename": "talos-linux64-ix-021", 17:04:06 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 17:04:06 INFO - "platform": "ubuntu64_hw", 17:04:06 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 17:04:06 INFO - "branch": "fx-team", 17:04:06 INFO - "repo_path": "integration/fx-team", 17:04:06 INFO - "revision": "6581bbe179b96e153cbc54335681cfc5c9195d62", 17:04:06 INFO - "stage_platform": "linux64-pgo", 17:04:06 INFO - "builduid": "63cdd00e3c7340c1a6e82d6f9b542549", 17:04:06 INFO - "slavebuilddir": "test" 17:04:06 INFO - } 17:04:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/UFCJ5mh2SMawOCo7MluSyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 17:04:06 INFO - Running post-action listener: _resource_record_post_action 17:04:06 INFO - ##### 17:04:06 INFO - ##### Finished read-buildbot-config step (success) 17:04:06 INFO - ##### 17:04:06 INFO - ##### 17:04:06 INFO - ##### Running download-and-extract step. 17:04:06 INFO - ##### 17:04:06 INFO - Running pre-action listener: _resource_record_pre_action 17:04:06 INFO - Running main action method: download_and_extract 17:04:06 INFO - mkdir: /builds/slave/test/build/tests 17:04:06 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')]} 17:04:06 INFO - https://queue.taskcluster.net/v1/task/UFCJ5mh2SMawOCo7MluSyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 17:04:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UFCJ5mh2SMawOCo7MluSyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 17:04:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UFCJ5mh2SMawOCo7MluSyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 17:04:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UFCJ5mh2SMawOCo7MluSyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 17:04:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UFCJ5mh2SMawOCo7MluSyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 17:04:10 INFO - Downloaded 1361 bytes. 17:04:10 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 17:04:10 INFO - Using the following test package requirements: 17:04:10 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 17:04:10 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:04:10 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:04:10 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:04:10 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:04:10 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:04:10 INFO - u'jsshell-linux-x86_64.zip'], 17:04:10 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:04:10 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:04:10 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 17:04:10 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:04:10 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:04:10 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:04:10 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:04:10 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:04:10 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:04:10 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:04:10 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:04:10 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:04:10 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')]} 17:04:10 INFO - https://queue.taskcluster.net/v1/task/UFCJ5mh2SMawOCo7MluSyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:04:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UFCJ5mh2SMawOCo7MluSyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:04:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UFCJ5mh2SMawOCo7MluSyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:04:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UFCJ5mh2SMawOCo7MluSyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:04:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UFCJ5mh2SMawOCo7MluSyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:04:11 INFO - Downloaded 23903415 bytes. 17:04: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'] 17:04: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 17:04:12 INFO - Return code: 0 17:04:12 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 17:04:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:04:12 INFO - https://queue.taskcluster.net/v1/task/UFCJ5mh2SMawOCo7MluSyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:04:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UFCJ5mh2SMawOCo7MluSyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:04:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UFCJ5mh2SMawOCo7MluSyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:04:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UFCJ5mh2SMawOCo7MluSyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:04:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UFCJ5mh2SMawOCo7MluSyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:04:16 INFO - Downloaded 23903415 bytes. 17:04:16 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'] 17:04:16 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 17:04:18 INFO - Return code: 0 17:04:18 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')]} 17:04:18 INFO - https://queue.taskcluster.net/v1/task/UFCJ5mh2SMawOCo7MluSyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:04:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UFCJ5mh2SMawOCo7MluSyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 17:04:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UFCJ5mh2SMawOCo7MluSyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 17:04:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UFCJ5mh2SMawOCo7MluSyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 17:04:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UFCJ5mh2SMawOCo7MluSyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 17:04:19 INFO - Downloaded 10840152 bytes. 17:04:19 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'] 17:04:19 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 17:04:19 INFO - Return code: 0 17:04:20 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')]} 17:04:20 INFO - https://queue.taskcluster.net/v1/task/UFCJ5mh2SMawOCo7MluSyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:04:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UFCJ5mh2SMawOCo7MluSyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:04:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UFCJ5mh2SMawOCo7MluSyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:04:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UFCJ5mh2SMawOCo7MluSyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:04:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UFCJ5mh2SMawOCo7MluSyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 17:04:23 INFO - Downloaded 58332208 bytes. 17:04:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UFCJ5mh2SMawOCo7MluSyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:04:23 INFO - mkdir: /builds/slave/test/properties 17:04:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:04:23 INFO - Writing to file /builds/slave/test/properties/build_url 17:04:23 INFO - Contents: 17:04:23 INFO - build_url:https://queue.taskcluster.net/v1/task/UFCJ5mh2SMawOCo7MluSyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:04:24 INFO - Running post-action listener: _resource_record_post_action 17:04:24 INFO - Running post-action listener: set_extra_try_arguments 17:04:24 INFO - ##### 17:04:24 INFO - ##### Finished download-and-extract step (success) 17:04:24 INFO - ##### 17:04:24 INFO - ##### 17:04:24 INFO - ##### Running populate-webroot step. 17:04:24 INFO - ##### 17:04:24 INFO - Running pre-action listener: _resource_record_pre_action 17:04:24 INFO - Running main action method: populate_webroot 17:04:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:04:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:04:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:04:24 INFO - '--tppagecycles', 17:04:24 INFO - '7'], 17:04:24 INFO - 'tests': ['tsvgm']}}, 17:04:24 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:04:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:04:24 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:04:24 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:04:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:04:24 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:04:24 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:04:24 INFO - 'talos_options': ['--disable-e10s'], 17:04:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:04:24 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:04:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:04:24 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:04:24 INFO - 'talos_options': ['--disable-e10s'], 17:04:24 INFO - 'tests': ['damp', 'tps']}, 17:04:24 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:04:24 INFO - 'tests': ['damp', 'tps']}, 17:04:24 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:04:24 INFO - 'tests': ['dromaeo_dom']}, 17:04:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:04:24 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:04:24 INFO - 'tests': ['a11yr', 17:04:24 INFO - 'ts_paint', 17:04:24 INFO - 'tpaint', 17:04:24 INFO - 'sessionrestore', 17:04:24 INFO - 'sessionrestore_no_auto_restore', 17:04:24 INFO - 'tabpaint']}, 17:04:24 INFO - 'other-e10s': {'tests': ['a11yr', 17:04:24 INFO - 'ts_paint', 17:04:24 INFO - 'tpaint', 17:04:24 INFO - 'sessionrestore', 17:04:24 INFO - 'sessionrestore_no_auto_restore', 17:04:24 INFO - 'tabpaint']}, 17:04:24 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:04:24 INFO - 'ts_paint', 17:04:24 INFO - 'tpaint', 17:04:24 INFO - 'sessionrestore', 17:04:24 INFO - 'sessionrestore_no_auto_restore', 17:04:24 INFO - 'tabpaint']}, 17:04:24 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:04:24 INFO - 'ts_paint', 17:04:24 INFO - 'tpaint', 17:04:24 INFO - 'sessionrestore', 17:04:24 INFO - 'sessionrestore_no_auto_restore', 17:04:24 INFO - 'tabpaint']}, 17:04:24 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:04:24 INFO - 'tests': ['a11yr', 17:04:24 INFO - 'ts_paint', 17:04:24 INFO - 'tpaint', 17:04:24 INFO - 'sessionrestore', 17:04:24 INFO - 'sessionrestore_no_auto_restore', 17:04:24 INFO - 'tabpaint']}, 17:04:24 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:04:24 INFO - 'tests': ['a11yr', 17:04:24 INFO - 'ts_paint', 17:04:24 INFO - 'tpaint', 17:04:24 INFO - 'sessionrestore', 17:04:24 INFO - 'sessionrestore_no_auto_restore', 17:04:24 INFO - 'tabpaint']}, 17:04:24 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:04:24 INFO - 'tests': ['tsvgx', 17:04:24 INFO - 'tsvgr_opacity', 17:04:24 INFO - 'tart', 17:04:24 INFO - 'tscrollx', 17:04:24 INFO - 'cart']}, 17:04:24 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:04:24 INFO - 'tsvgr_opacity', 17:04:24 INFO - 'tart', 17:04:24 INFO - 'tscrollx', 17:04:24 INFO - 'cart']}, 17:04:24 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:04:24 INFO - 'talos_options': ['--disable-e10s'], 17:04:24 INFO - 'tests': ['tp5o']}, 17:04:24 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:04:24 INFO - 'tests': ['tp5o']}, 17:04:24 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:04:24 INFO - 'talos_options': ['--disable-e10s', 17:04:24 INFO - '--xperf_path', 17:04:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:04:24 INFO - 'tests': ['tp5n']}, 17:04:24 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:04:24 INFO - 'talos_options': ['--xperf_path', 17:04:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:04:24 INFO - 'tests': ['tp5n']}}, 17:04:24 INFO - 'talos.zip': {'path': '', 17:04:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:04:24 INFO - Running post-action listener: _resource_record_post_action 17:04:24 INFO - ##### 17:04:24 INFO - ##### Finished populate-webroot step (success) 17:04:24 INFO - ##### 17:04:24 INFO - ##### 17:04:24 INFO - ##### Running create-virtualenv step. 17:04:24 INFO - ##### 17:04:24 INFO - Running pre-action listener: _resource_record_pre_action 17:04:24 INFO - Running main action method: create_virtualenv 17:04:24 INFO - Creating virtualenv /builds/slave/test/build/venv 17:04:24 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 17:04:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:04:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:04:24 INFO - Using real prefix '/usr' 17:04:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:04:25 INFO - Installing distribute.............................................................................................................................................................................................done. 17:04:30 INFO - Installing pip.................done. 17:04:30 INFO - Return code: 0 17:04:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:04:30 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')]} 17:04:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:04:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:30 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')]} 17:04:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:04:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:30 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 0x7fcfbe5f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a99770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b289c0>, '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 0x2b298c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b29d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1463002841.227289-1948646140', '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 17:04:30 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 17:04:30 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 17:04:30 INFO - Using env: {'DISPLAY': ':0', 17:04:30 INFO - 'HOME': '/home/cltbld', 17:04:30 INFO - 'LANG': 'en_US.UTF-8', 17:04:30 INFO - 'LANGUAGE': 'en_US:en', 17:04:30 INFO - 'LOGNAME': 'cltbld', 17:04:30 INFO - 'MAIL': '/var/mail/cltbld', 17:04:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:04:30 INFO - 'MOZ_NO_REMOTE': '1', 17:04:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:04:30 INFO - 'NO_EM_RESTART': '1', 17:04:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:04:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:04:30 INFO - 'PWD': '/builds/slave/test', 17:04:30 INFO - 'SHELL': '/bin/bash', 17:04:30 INFO - 'SHLVL': '1', 17:04:30 INFO - 'TERM': 'linux', 17:04:30 INFO - 'TMOUT': '86400', 17:04:30 INFO - 'USER': 'cltbld', 17:04:30 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1463002841.227289-1948646140', 17:04:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:04:30 INFO - '_': '/tools/buildbot/bin/python'} 17:04:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:04:30 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 17:04:30 INFO - Cleaning up... 17:04:30 INFO - Return code: 0 17:04:30 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 17:04:30 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')]} 17:04:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:04:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:30 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')]} 17:04:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:04:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcfbe5f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a99770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b289c0>, '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 0x2b298c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b29d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1463002841.227289-1948646140', '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 17:04:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 17:04:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 17:04:30 INFO - Using env: {'DISPLAY': ':0', 17:04:30 INFO - 'HOME': '/home/cltbld', 17:04:30 INFO - 'LANG': 'en_US.UTF-8', 17:04:30 INFO - 'LANGUAGE': 'en_US:en', 17:04:30 INFO - 'LOGNAME': 'cltbld', 17:04:30 INFO - 'MAIL': '/var/mail/cltbld', 17:04:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:04:30 INFO - 'MOZ_NO_REMOTE': '1', 17:04:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:04:30 INFO - 'NO_EM_RESTART': '1', 17:04:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:04:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:04:30 INFO - 'PWD': '/builds/slave/test', 17:04:30 INFO - 'SHELL': '/bin/bash', 17:04:30 INFO - 'SHLVL': '1', 17:04:30 INFO - 'TERM': 'linux', 17:04:30 INFO - 'TMOUT': '86400', 17:04:30 INFO - 'USER': 'cltbld', 17:04:30 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1463002841.227289-1948646140', 17:04:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:04:30 INFO - '_': '/tools/buildbot/bin/python'} 17:04:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:04:30 INFO - Downloading/unpacking psutil>=0.7.1 17:04:30 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 17:04:30 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 17:04:30 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 17:04:30 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 17:04:30 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 17:04:30 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 17:04:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:04:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:04:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:04:32 INFO - Installing collected packages: psutil 17:04:32 INFO - Running setup.py install for psutil 17:04:33 INFO - building 'psutil._psutil_linux' extension 17:04:33 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 17:04:33 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 17:04:33 INFO - building 'psutil._psutil_posix' extension 17:04:33 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 17:04:33 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 17:04:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:04:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:04:33 INFO - Successfully installed psutil 17:04:33 INFO - Cleaning up... 17:04:33 INFO - Return code: 0 17:04:33 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 17:04:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:04:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:04:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:04:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:04:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcfbe5f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a99770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b289c0>, '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 0x2b298c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b29d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1463002841.227289-1948646140', '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 17:04:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 17:04:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 17:04:33 INFO - Using env: {'DISPLAY': ':0', 17:04:33 INFO - 'HOME': '/home/cltbld', 17:04:33 INFO - 'LANG': 'en_US.UTF-8', 17:04:33 INFO - 'LANGUAGE': 'en_US:en', 17:04:33 INFO - 'LOGNAME': 'cltbld', 17:04:33 INFO - 'MAIL': '/var/mail/cltbld', 17:04:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:04:33 INFO - 'MOZ_NO_REMOTE': '1', 17:04:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:04:33 INFO - 'NO_EM_RESTART': '1', 17:04:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:04:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:04:33 INFO - 'PWD': '/builds/slave/test', 17:04:33 INFO - 'SHELL': '/bin/bash', 17:04:33 INFO - 'SHLVL': '1', 17:04:33 INFO - 'TERM': 'linux', 17:04:33 INFO - 'TMOUT': '86400', 17:04:33 INFO - 'USER': 'cltbld', 17:04:33 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1463002841.227289-1948646140', 17:04:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:04:33 INFO - '_': '/tools/buildbot/bin/python'} 17:04:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:04:33 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:04:33 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 17:04:33 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 17:04:33 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 17:04:33 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 17:04:33 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 17:04:33 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 17:04:35 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:04:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:04:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 17:04:35 INFO - Installing collected packages: mozsystemmonitor 17:04:35 INFO - Running setup.py install for mozsystemmonitor 17:04:35 INFO - Successfully installed mozsystemmonitor 17:04:35 INFO - Cleaning up... 17:04:35 INFO - Return code: 0 17:04:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:04: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')]} 17:04:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:04:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04: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')]} 17:04:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:04:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04: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', '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 0x7fcfbe5f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a99770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b289c0>, '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 0x2b298c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b29d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1463002841.227289-1948646140', '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 17:04: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:04: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 blobuploader==1.2.4 17:04:35 INFO - Using env: {'DISPLAY': ':0', 17:04:35 INFO - 'HOME': '/home/cltbld', 17:04:35 INFO - 'LANG': 'en_US.UTF-8', 17:04:35 INFO - 'LANGUAGE': 'en_US:en', 17:04:35 INFO - 'LOGNAME': 'cltbld', 17:04:35 INFO - 'MAIL': '/var/mail/cltbld', 17:04:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:04:35 INFO - 'MOZ_NO_REMOTE': '1', 17:04:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:04:35 INFO - 'NO_EM_RESTART': '1', 17:04:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:04:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:04:35 INFO - 'PWD': '/builds/slave/test', 17:04:35 INFO - 'SHELL': '/bin/bash', 17:04:35 INFO - 'SHLVL': '1', 17:04:35 INFO - 'TERM': 'linux', 17:04:35 INFO - 'TMOUT': '86400', 17:04:35 INFO - 'USER': 'cltbld', 17:04:35 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1463002841.227289-1948646140', 17:04:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:04:35 INFO - '_': '/tools/buildbot/bin/python'} 17:04:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:04:36 INFO - Downloading/unpacking blobuploader==1.2.4 17:04:36 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 17:04:36 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 17:04:36 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 17:04:36 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 17:04:36 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 17:04:36 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 17:04:37 INFO - Downloading blobuploader-1.2.4.tar.gz 17:04:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:04:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:04: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 17:04: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 17:04: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 17:04: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 17:04: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 17:04: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 17:04:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:04:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:04: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 17:04: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 17:04: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 17:04: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 17:04: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 17:04: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 17:04:38 INFO - Downloading docopt-0.6.1.tar.gz 17:04:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:04:38 INFO - Installing collected packages: blobuploader, requests, docopt 17:04:38 INFO - Running setup.py install for blobuploader 17:04:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:04:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:04:38 INFO - Running setup.py install for requests 17:04:39 INFO - Running setup.py install for docopt 17:04:39 INFO - Successfully installed blobuploader requests docopt 17:04:39 INFO - Cleaning up... 17:04:39 INFO - Return code: 0 17:04:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:04:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:04:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:04:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:04:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:04:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:39 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 0x7fcfbe5f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a99770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b289c0>, '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 0x2b298c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b29d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1463002841.227289-1948646140', '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 17:04:39 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 17:04:39 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 17:04:39 INFO - Using env: {'DISPLAY': ':0', 17:04:39 INFO - 'HOME': '/home/cltbld', 17:04:39 INFO - 'LANG': 'en_US.UTF-8', 17:04:39 INFO - 'LANGUAGE': 'en_US:en', 17:04:39 INFO - 'LOGNAME': 'cltbld', 17:04:39 INFO - 'MAIL': '/var/mail/cltbld', 17:04:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:04:39 INFO - 'MOZ_NO_REMOTE': '1', 17:04:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:04:39 INFO - 'NO_EM_RESTART': '1', 17:04:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:04:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:04:39 INFO - 'PWD': '/builds/slave/test', 17:04:39 INFO - 'SHELL': '/bin/bash', 17:04:39 INFO - 'SHLVL': '1', 17:04:39 INFO - 'TERM': 'linux', 17:04:39 INFO - 'TMOUT': '86400', 17:04:39 INFO - 'USER': 'cltbld', 17:04:39 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1463002841.227289-1948646140', 17:04:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:04:39 INFO - '_': '/tools/buildbot/bin/python'} 17:04:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:04:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:04:39 INFO - Running setup.py (path:/tmp/pip-zEkNk4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:04:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:04:39 INFO - Running setup.py (path:/tmp/pip-BZhGJQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:04:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:04:39 INFO - Running setup.py (path:/tmp/pip-lrhaO1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:04:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:04:39 INFO - Running setup.py (path:/tmp/pip-uvQzjk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:04:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:04:39 INFO - Running setup.py (path:/tmp/pip-dZfkFM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:04:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:04:39 INFO - Running setup.py (path:/tmp/pip-qbURVI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:04:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:04:39 INFO - Running setup.py (path:/tmp/pip-SP3fkg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:04:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:04:39 INFO - Running setup.py (path:/tmp/pip-8Of2bZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:04:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:04:40 INFO - Running setup.py (path:/tmp/pip-_1FaPt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:04:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:04:40 INFO - Running setup.py (path:/tmp/pip-T16pqb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:04:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:04:40 INFO - Running setup.py (path:/tmp/pip-pUgSPV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:04:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:04:40 INFO - Running setup.py (path:/tmp/pip-3bvQ8Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:04:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:04:40 INFO - Running setup.py (path:/tmp/pip-eH7FuZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:04:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:04:40 INFO - Running setup.py (path:/tmp/pip-uZ6cgJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:04:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:04:40 INFO - Running setup.py (path:/tmp/pip-_wN9Vn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:04:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:04:40 INFO - Running setup.py (path:/tmp/pip-zx9dEd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:04:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:04:40 INFO - Running setup.py (path:/tmp/pip-vnaIRj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:04:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:04:40 INFO - Running setup.py install for manifestparser 17:04:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:04:40 INFO - Running setup.py install for mozcrash 17:04:40 INFO - Running setup.py install for mozdebug 17:04:40 INFO - Running setup.py install for mozdevice 17:04:41 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:04:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:04:41 INFO - Running setup.py install for mozfile 17:04:41 INFO - Running setup.py install for mozhttpd 17:04:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:04:41 INFO - Running setup.py install for mozinfo 17:04:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:04:41 INFO - Running setup.py install for mozInstall 17:04:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:04:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:04:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:04:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:04:41 INFO - Running setup.py install for mozleak 17:04:41 INFO - Running setup.py install for mozlog 17:04:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:04:41 INFO - Running setup.py install for moznetwork 17:04:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:04:41 INFO - Running setup.py install for mozprocess 17:04:41 INFO - Running setup.py install for mozprofile 17:04:41 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:04:41 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:04:41 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:04:42 INFO - Running setup.py install for mozrunner 17:04:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:04:42 INFO - Running setup.py install for mozscreenshot 17:04:42 INFO - Running setup.py install for moztest 17:04:42 INFO - Running setup.py install for mozversion 17:04:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:04:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:04:42 INFO - Cleaning up... 17:04:42 INFO - Return code: 0 17:04:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:04:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:04:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:04:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:04:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:04:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:42 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 0x7fcfbe5f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a99770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b289c0>, '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 0x2b298c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b29d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1463002841.227289-1948646140', '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 17:04:42 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 17:04:42 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 17:04:42 INFO - Using env: {'DISPLAY': ':0', 17:04:42 INFO - 'HOME': '/home/cltbld', 17:04:42 INFO - 'LANG': 'en_US.UTF-8', 17:04:42 INFO - 'LANGUAGE': 'en_US:en', 17:04:42 INFO - 'LOGNAME': 'cltbld', 17:04:42 INFO - 'MAIL': '/var/mail/cltbld', 17:04:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:04:42 INFO - 'MOZ_NO_REMOTE': '1', 17:04:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:04:42 INFO - 'NO_EM_RESTART': '1', 17:04:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:04:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:04:42 INFO - 'PWD': '/builds/slave/test', 17:04:42 INFO - 'SHELL': '/bin/bash', 17:04:42 INFO - 'SHLVL': '1', 17:04:42 INFO - 'TERM': 'linux', 17:04:42 INFO - 'TMOUT': '86400', 17:04:42 INFO - 'USER': 'cltbld', 17:04:42 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1463002841.227289-1948646140', 17:04:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:04:42 INFO - '_': '/tools/buildbot/bin/python'} 17:04:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:04:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:04:42 INFO - Running setup.py (path:/tmp/pip-hnMUdK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:04:42 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)) 17:04:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:04:42 INFO - Running setup.py (path:/tmp/pip-4Rebtg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:04:42 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)) 17:04:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:04:42 INFO - Running setup.py (path:/tmp/pip-H2g5XL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:04:42 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)) 17:04:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:04:42 INFO - Running setup.py (path:/tmp/pip-hvs72G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:04:42 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)) 17:04:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:04:42 INFO - Running setup.py (path:/tmp/pip-H3Rxnz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:04:43 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)) 17:04:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:04:43 INFO - Running setup.py (path:/tmp/pip-3Gy5VZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:04:43 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)) 17:04:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:04:43 INFO - Running setup.py (path:/tmp/pip-ThoxNm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:04:43 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)) 17:04:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:04:43 INFO - Running setup.py (path:/tmp/pip-pqQeVD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:04:43 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)) 17:04:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:04:43 INFO - Running setup.py (path:/tmp/pip-BhNmCu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:04:43 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)) 17:04:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:04:43 INFO - Running setup.py (path:/tmp/pip-XHAwqz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:04:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:04:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:04:43 INFO - Running setup.py (path:/tmp/pip-M8MCtB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:04:43 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)) 17:04:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:04:43 INFO - Running setup.py (path:/tmp/pip-s82PA3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:04:43 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)) 17:04:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:04:43 INFO - Running setup.py (path:/tmp/pip-p6v8nM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:04:43 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)) 17:04:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:04:43 INFO - Running setup.py (path:/tmp/pip-aHraFY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:04:43 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)) 17:04:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:04:43 INFO - Running setup.py (path:/tmp/pip-CEm3ju-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:04:43 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)) 17:04:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:04:43 INFO - Running setup.py (path:/tmp/pip-yF4jns-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:04:43 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)) 17:04:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:04:43 INFO - Running setup.py (path:/tmp/pip-vlNnoz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:04:43 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)) 17:04:43 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)) 17:04:43 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)) 17:04:43 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)) 17:04:43 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)) 17:04:43 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)) 17:04:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:04:43 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 17:04:43 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 17:04:43 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 17:04:43 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 17:04:43 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 17:04:43 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 17:04:45 INFO - Downloading blessings-1.6.tar.gz 17:04:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:04:45 INFO - Installing collected packages: blessings 17:04:45 INFO - Running setup.py install for blessings 17:04:45 INFO - Successfully installed blessings 17:04:45 INFO - Cleaning up... 17:04:46 INFO - Return code: 0 17:04:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:04:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:04:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:04:46 INFO - Reading from file tmpfile_stdout 17:04:46 INFO - Current package versions: 17:04:46 INFO - argparse == 1.2.1 17:04:46 INFO - blessings == 1.6 17:04:46 INFO - blobuploader == 1.2.4 17:04:46 INFO - docopt == 0.6.1 17:04:46 INFO - manifestparser == 1.1 17:04:46 INFO - mozInstall == 1.12 17:04:46 INFO - mozcrash == 0.17 17:04:46 INFO - mozdebug == 0.1 17:04:46 INFO - mozdevice == 0.48 17:04:46 INFO - mozfile == 1.2 17:04:46 INFO - mozhttpd == 0.7 17:04:46 INFO - mozinfo == 0.9 17:04:46 INFO - mozleak == 0.1 17:04:46 INFO - mozlog == 3.1 17:04:46 INFO - moznetwork == 0.27 17:04:46 INFO - mozprocess == 0.22 17:04:46 INFO - mozprofile == 0.28 17:04:46 INFO - mozrunner == 6.11 17:04:46 INFO - mozscreenshot == 0.1 17:04:46 INFO - mozsystemmonitor == 0.0 17:04:46 INFO - moztest == 0.7 17:04:46 INFO - mozversion == 1.4 17:04:46 INFO - psutil == 3.1.1 17:04:46 INFO - requests == 1.2.3 17:04:46 INFO - wsgiref == 0.1.2 17:04:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:04:46 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')]} 17:04:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:04:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:46 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')]} 17:04:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:04:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:46 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 0x7fcfbe5f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a99770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b289c0>, '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 0x2b298c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b29d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1463002841.227289-1948646140', '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 17:04:46 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 17:04:46 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 17:04:46 INFO - Using env: {'DISPLAY': ':0', 17:04:46 INFO - 'HOME': '/home/cltbld', 17:04:46 INFO - 'LANG': 'en_US.UTF-8', 17:04:46 INFO - 'LANGUAGE': 'en_US:en', 17:04:46 INFO - 'LOGNAME': 'cltbld', 17:04:46 INFO - 'MAIL': '/var/mail/cltbld', 17:04:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:04:46 INFO - 'MOZ_NO_REMOTE': '1', 17:04:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:04:46 INFO - 'NO_EM_RESTART': '1', 17:04:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:04:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:04:46 INFO - 'PWD': '/builds/slave/test', 17:04:46 INFO - 'SHELL': '/bin/bash', 17:04:46 INFO - 'SHLVL': '1', 17:04:46 INFO - 'TERM': 'linux', 17:04:46 INFO - 'TMOUT': '86400', 17:04:46 INFO - 'USER': 'cltbld', 17:04:46 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1463002841.227289-1948646140', 17:04:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:04:46 INFO - '_': '/tools/buildbot/bin/python'} 17:04:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:04:46 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)) 17:04:46 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)) 17:04:46 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)) 17:04:46 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)) 17:04:46 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)) 17:04:46 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)) 17:04:46 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)) 17:04:46 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)) 17:04:46 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)) 17:04:46 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)) 17:04:46 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)) 17:04:46 INFO - Cleaning up... 17:04:46 INFO - Return code: 0 17:04:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:04:46 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')]} 17:04:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:04:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:46 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')]} 17:04:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:04:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:46 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 0x7fcfbe5f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a99770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b289c0>, '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 0x2b298c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b29d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1463002841.227289-1948646140', '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 17:04:46 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 17:04:46 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 17:04:46 INFO - Using env: {'DISPLAY': ':0', 17:04:46 INFO - 'HOME': '/home/cltbld', 17:04:46 INFO - 'LANG': 'en_US.UTF-8', 17:04:46 INFO - 'LANGUAGE': 'en_US:en', 17:04:46 INFO - 'LOGNAME': 'cltbld', 17:04:46 INFO - 'MAIL': '/var/mail/cltbld', 17:04:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:04:46 INFO - 'MOZ_NO_REMOTE': '1', 17:04:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:04:46 INFO - 'NO_EM_RESTART': '1', 17:04:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:04:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:04:46 INFO - 'PWD': '/builds/slave/test', 17:04:46 INFO - 'SHELL': '/bin/bash', 17:04:46 INFO - 'SHLVL': '1', 17:04:46 INFO - 'TERM': 'linux', 17:04:46 INFO - 'TMOUT': '86400', 17:04:46 INFO - 'USER': 'cltbld', 17:04:46 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1463002841.227289-1948646140', 17:04:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:04:46 INFO - '_': '/tools/buildbot/bin/python'} 17:04:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:04:46 INFO - Downloading/unpacking jsonschema 17:04:46 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 17:04:46 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 17:04:46 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 17:04:46 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 17:04:46 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 17:04:46 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 17:04:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:04:48 INFO - Downloading/unpacking functools32 (from jsonschema) 17:04:48 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 17:04:48 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 17:04:48 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 17:04:48 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 17:04:48 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 17:04:48 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 17:04:48 INFO - Downloading functools32-3.2.3-2.tar.gz 17:04:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:04:48 INFO - warning: no files found matching '*.txt' 17:04:48 INFO - no previously-included directories found matching 'build' 17:04:48 INFO - no previously-included directories found matching 'dist' 17:04:48 INFO - no previously-included directories found matching '.git*' 17:04:48 INFO - Installing collected packages: jsonschema, functools32 17:04:48 INFO - Running setup.py install for functools32 17:04:48 INFO - warning: no files found matching '*.txt' 17:04:48 INFO - no previously-included directories found matching 'build' 17:04:48 INFO - no previously-included directories found matching 'dist' 17:04:48 INFO - no previously-included directories found matching '.git*' 17:04:49 INFO - Successfully installed jsonschema functools32 17:04:49 INFO - Cleaning up... 17:04:49 INFO - Return code: 0 17:04:49 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:04:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:04:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:04:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:04:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:04:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcfbe5f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a99770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b289c0>, '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 0x2b298c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b29d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1463002841.227289-1948646140', '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 17:04:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 17:04:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 17:04:49 INFO - Using env: {'DISPLAY': ':0', 17:04:49 INFO - 'HOME': '/home/cltbld', 17:04:49 INFO - 'LANG': 'en_US.UTF-8', 17:04:49 INFO - 'LANGUAGE': 'en_US:en', 17:04:49 INFO - 'LOGNAME': 'cltbld', 17:04:49 INFO - 'MAIL': '/var/mail/cltbld', 17:04:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:04:49 INFO - 'MOZ_NO_REMOTE': '1', 17:04:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:04:49 INFO - 'NO_EM_RESTART': '1', 17:04:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:04:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:04:49 INFO - 'PWD': '/builds/slave/test', 17:04:49 INFO - 'SHELL': '/bin/bash', 17:04:49 INFO - 'SHLVL': '1', 17:04:49 INFO - 'TERM': 'linux', 17:04:49 INFO - 'TMOUT': '86400', 17:04:49 INFO - 'USER': 'cltbld', 17:04:49 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1463002841.227289-1948646140', 17:04:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:04:49 INFO - '_': '/tools/buildbot/bin/python'} 17:04:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:04:49 INFO - Downloading/unpacking flake8 17:04:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:04:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:04:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:04:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:04:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:04:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:04:52 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:04:52 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:04:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:04:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:04:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:04:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:04:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:04:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:04:52 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:04:52 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:04:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:04:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:04:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:04:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:04:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:04:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:04:52 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:04:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:04:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:04:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:04:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:04:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:04:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:04:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:04:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:04:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:04:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:04:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:04:52 INFO - no previously-included directories found matching 'docs/_build' 17:04:52 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:04:52 INFO - Running setup.py install for pep8 17:04:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:04:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:04:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:04:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:04:53 INFO - no previously-included directories found matching 'docs/_build' 17:04:53 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:04:53 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:04:53 INFO - Cleaning up... 17:04:53 INFO - Return code: 0 17:04:53 INFO - Running post-action listener: _resource_record_post_action 17:04:53 INFO - Running post-action listener: _start_resource_monitoring 17:04:53 INFO - Starting resource monitoring. 17:04:53 INFO - ##### 17:04:53 INFO - ##### Finished create-virtualenv step (success) 17:04:53 INFO - ##### 17:04:53 INFO - ##### 17:04:53 INFO - ##### Running install step. 17:04:53 INFO - ##### 17:04:53 INFO - Running pre-action listener: _resource_record_pre_action 17:04:53 INFO - Running main action method: install 17:04:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:04:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:04:53 INFO - Reading from file tmpfile_stdout 17:04:53 INFO - Detecting whether we're running mozinstall >=1.0... 17:04:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:04:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:04:53 INFO - Reading from file tmpfile_stdout 17:04:53 INFO - Output received: 17:04:53 INFO - Usage: mozinstall [options] installer 17:04:53 INFO - Options: 17:04:53 INFO - -h, --help show this help message and exit 17:04:53 INFO - -d DEST, --destination=DEST 17:04:53 INFO - Directory to install application into. [default: 17:04:53 INFO - "/builds/slave/test"] 17:04:53 INFO - --app=APP Application being installed. [default: firefox] 17:04:53 INFO - mkdir: /builds/slave/test/build/application 17:04:53 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'] 17:04:53 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 17:05:10 INFO - Reading from file tmpfile_stdout 17:05:10 INFO - Output received: 17:05:10 INFO - /builds/slave/test/build/application/firefox/firefox 17:05:10 INFO - Running post-action listener: _resource_record_post_action 17:05:10 INFO - ##### 17:05:10 INFO - ##### Finished install step (success) 17:05:10 INFO - ##### 17:05:10 INFO - ##### 17:05:10 INFO - ##### Running run-tests step. 17:05:10 INFO - ##### 17:05:10 INFO - Running pre-action listener: _resource_record_pre_action 17:05:10 INFO - Running main action method: run_tests 17:05:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:05:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:05:10 INFO - Python 2.7.3 17:05:10 INFO - Return code: 0 17:05:10 INFO - grabbing minidump binary from tooltool 17:05:10 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')]} 17:05:10 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 0x2b289c0>, '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 0x2b298c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b29d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:05:10 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 17:05:10 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 17:05:10 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 17:05:10 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:05:10 INFO - Return code: 0 17:05:10 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:05:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:05:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:05:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:05:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:05:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:05:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:05:11 INFO - Return code: 0 17:05:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UFCJ5mh2SMawOCo7MluSyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 17:05:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/UFCJ5mh2SMawOCo7MluSyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-021 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 17:05:11 INFO - Using env: {'DISPLAY': ':0', 17:05:11 INFO - 'HOME': '/home/cltbld', 17:05:11 INFO - 'LANG': 'en_US.UTF-8', 17:05:11 INFO - 'LANGUAGE': 'en_US:en', 17:05:11 INFO - 'LOGNAME': 'cltbld', 17:05:11 INFO - 'MAIL': '/var/mail/cltbld', 17:05:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:05:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:05:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:05:11 INFO - 'MOZ_NO_REMOTE': '1', 17:05:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:05:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:05:11 INFO - 'NO_EM_RESTART': '1', 17:05:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:05:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:05:11 INFO - 'PWD': '/builds/slave/test', 17:05:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:05:11 INFO - 'SHELL': '/bin/bash', 17:05:11 INFO - 'SHLVL': '1', 17:05:11 INFO - 'TERM': 'linux', 17:05:11 INFO - 'TMOUT': '86400', 17:05:11 INFO - 'USER': 'cltbld', 17:05:11 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1463002841.227289-1948646140', 17:05:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:05:11 INFO - '_': '/tools/buildbot/bin/python'} 17:05:11 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UFCJ5mh2SMawOCo7MluSyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 17:05:11 INFO - mozversion application_buildid: 20160511143008 17:05:11 INFO - mozversion application_changeset: 6581bbe179b96e153cbc54335681cfc5c9195d62 17:05:11 INFO - mozversion application_display_name: Nightly 17:05:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:05:11 INFO - mozversion application_name: Firefox 17:05:11 INFO - mozversion application_remotingname: firefox 17:05:11 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:05:11 INFO - mozversion application_vendor: Mozilla 17:05:11 INFO - mozversion application_version: 49.0a1 17:05:11 INFO - mozversion platform_buildid: 20160511143008 17:05:11 INFO - mozversion platform_changeset: 6581bbe179b96e153cbc54335681cfc5c9195d62 17:05:11 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:05:11 INFO - mozversion platform_version: 49.0a1 17:05:11 INFO - using testdate: 1463011511 17:05:11 INFO - actual date: 1463011511 17:05:11 INFO - starting webserver on 'localhost:54355' 17:05:11 INFO - SUITE-START | Running 2 tests 17:05:11 INFO - TEST-START | dromaeo_css 17:05:11 INFO - operating with platform_type : linux_ 17:05:11 INFO - Initialising browser for dromaeo_css test... 17:05:11 INFO - TEST-INFO | started process 4438 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUUKsAK/profile http://localhost:54355/getInfo.html) 17:05:15 INFO - PROCESS | 4438 | 17:05:15 INFO - PROCESS | 4438 | (process:4506): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:05:16 INFO - PROCESS | 4438 | __metrics Screen width/height:1600/1200 17:05:16 INFO - PROCESS | 4438 | colorDepth:24 17:05:16 INFO - PROCESS | 4438 | Browser inner width/height: 1024/697 17:05:16 INFO - PROCESS | 4438 | __metrics 17:05:17 ERROR - PROCESS | 4438 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 17:05:18 INFO - TEST-INFO | 4438: exit 0 17:05:18 INFO - Browser initialized. 17:05:18 INFO - Running cycle 1/1 for dromaeo_css test... 17:05:18 INFO - TEST-INFO | started process 4557 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUUKsAK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:05:20 INFO - PROCESS | 4557 | 17:05:20 INFO - PROCESS | 4557 | (process:4618): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:05:30 INFO - PROCESS | 4557 | RSS: Main: 162979840 17:05:30 INFO - PROCESS | 4557 | 17:06:19 INFO - PROCESS | 4557 | 1463011579744 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] 17:08:27 INFO - PROCESS | 4557 | Cycle 1(1): loaded http://localhost:54355/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54355/tests/dromaeo/cssquery-ext.html) 17:08:28 INFO - PROCESS | 4557 | RSS: Main: 166772736 17:08:28 INFO - PROCESS | 4557 | 17:11:30 INFO - PROCESS | 4557 | Cycle 1(1): loaded http://localhost:54355/tests/dromaeo/cssquery-ext.html (next: http://localhost:54355/tests/dromaeo/cssquery-jquery.html) 17:11:31 INFO - PROCESS | 4557 | RSS: Main: 166031360 17:11:31 INFO - PROCESS | 4557 | 17:14:32 INFO - PROCESS | 4557 | Cycle 1(1): loaded http://localhost:54355/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54355/tests/dromaeo/cssquery-mootools.html) 17:14:33 INFO - PROCESS | 4557 | RSS: Main: 167366656 17:14:33 INFO - PROCESS | 4557 | 17:17:35 INFO - PROCESS | 4557 | Cycle 1(1): loaded http://localhost:54355/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54355/tests/dromaeo/cssquery-prototype.html) 17:17:35 INFO - PROCESS | 4557 | RSS: Main: 165306368 17:17:35 INFO - PROCESS | 4557 | 17:20:38 INFO - PROCESS | 4557 | Cycle 1(1): loaded http://localhost:54355/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54355/tests/dromaeo/cssquery-yui.html) 17:20:39 INFO - PROCESS | 4557 | RSS: Main: 166019072 17:20:39 INFO - PROCESS | 4557 | 17:23:41 INFO - PROCESS | 4557 | Cycle 1(1): loaded http://localhost:54355/tests/dromaeo/cssquery-yui.html (next: http://localhost:54355/tests/dromaeo/cssquery-dojo.html) 17:23:41 INFO - PROCESS | 4557 | RSS: Main: 168321024 17:23:41 INFO - PROCESS | 4557 | 17:23:41 INFO - PROCESS | 4557 | __start_tp_report 17:23:41 INFO - PROCESS | 4557 | _x_x_mozilla_page_load 17:23:41 INFO - PROCESS | 4557 | _x_x_mozilla_page_load_details 17:23:41 INFO - PROCESS | 4557 | |i|pagename|runs| 17:23:41 INFO - PROCESS | 4557 | |0;dojo.html;3187.7768556201063;3203.2792621660124;3209.5667084943557;3252.837358132093;3273.6889995450438;5375.086235339992;5403.486668766466;5432.592555558329;5447.945520544793;5523.613347065707;5367.35591728993;5469.808556700506;5515.503604675579;5553.639013464122;5598.020346439377;4958.256261560768;4989.57588604969;5093.770780314876;5140.357455318085;5183.974080129613;490.64371072752493;4866.051120031595;4999.225120106389;5035.169197082495;5082.339295891547;5036.697798132105;5073.086844368012;5076.949230507703;5092.159793634046;5101.591872650198;5097.108006098918;5113.667611605234;5117.078925793356;5121.8719532012;5133.794648214067;4876.244182151772;4972.477889821553;5016.949830501685;5041.571466425358;5071.41678706946;5425.186222066682;5481.835544933619;5494;5520.365158006841;5521.834344969658;5647.943520564783;6051.727672254759;6060.909086363708;6062.424069713415;6066.787662431793;5938.673372964486;5983.551233657493;5999.190109335227;6043.637381757108;6058.0610005449225;5611.0741727614895;5627.71861406928;5633.15502674598;5648.548116150698;5652.547796176296;5906;6102.237220347457;6178.104174894615;6197.690115494207;6217.191765070512;5848.444397782204;5862.736176872051;5877.23595932526;5879.970600146972;5907.3797251288;6018.8194354169445;6049.03215485529;6049.606775559574;6051.062085376773;6052.213212282375;5724.341700704389;5809.041508151107;5818.709064546756;5976.133460648181;6053.061775424816;5827.970860145672;5837.9124313135335;5844.064949608042;5846.649201047951;5848.2397288353095;4437.356583295404;4439.156560253606;4450.221211288012;4455.353973673799;4469.351943968171;3913.1977944521304;3966.801659916993;4001.3597824347967;4022.899427514277;4037.7375470594316;5503.862403439946;5639.125935480007;5693.17448969897;5722.656640601577;5753.079507278815;5999.250093738283;6025.126356678257;6026.54800889935;6026.6986650667295;6033;5568.276124103841;5604.775808967677;5634.070378387521;5672.319321681424;5773.364929857797;5075.923861142086;5104.106781313255;5115.8721031973755;5122.410922743858;5142.820001299937;5937.317208520989;6193.1329613854095;6202.131701561785;6207.162033125561;6217.844553886189;5900.586958912835;5924.7926322578505;5942.257217847769;5981.1327357532045;6031.396860313934;6119.082137679384;6128.785492507741;6130.877382452415;6170.81487555374;6181.9690901547;5649.096144616841;5848.883022339614;5907.202527658711;5925.525957923442;5943.58394912352;5993.041113421831;6094.350380525191;6105.877882442415;6109.033772226435;6116.5718399711595;5830.708464576839;5832.708364581838;5842.561807864342;5878.500327472213;5906.232189815297;5523.171524271392;5789.363170051375;5819.738111784895;5892.469677729025;5909.852253693692;5725.570582206435;5748.166515855094;5751.396103409249;5800.796972105956;5816.563757718272;5941;5953.880922381615;5958.136070269873;5961.2846458425265;5964.373740757158;5579.246801681721;5762.740676669644;5795.188673585617;5824.271966004249;5847.707614619167 17:23:41 INFO - PROCESS | 4557 | |1;ext.html;588.2764200033959;642.893922502787;660.735705717713;662.3641304347829;677.4241894389767;36988.630113698855;42872.785636071814;43238.351424728615;43281;43453;42560;42674.573254267445;42926;43010;43054.354184687174;8687.782805429868;8837.55812209387;8844.73465796024;8850.247728943015;8857.778555536132;8722.607482663263;8745.169208925143;8785.297176225919;8813.294936405073;8833.514156721378;8856.158664926821;8863.556822158866;8876.112388761137;8882.200601945824;8892.955535222347;8750.649974001033;8839.73480795574;8846.867296990486;8850.778730531789;8871.24594409476;8577;8667.913320866837;8694.260987816044;8694.304455643532;8698.478091314479;34312.31375372504;39321.80339098315;39783.60216397828;39851.202975940316;39858;3530.3115892400992;3562.4300111982216;3834.4248362745534;4166.6250037496775;4443.089166720847;29777.404451911058;30647.233819154477;31691.84154079238;33316;33379.49930751041;4318.805653745558;4375.037491751809;4376.474823021258;4392.978035109836;4497.168023915586;329423;335155;335494;336230.99999999756;337458;64608.35391646023;65058.34941650618;65416.34583654198;65442.672786636715;65654.34345656482;38387;38970;39150.80424597859;41421.79289103535;41568;17230.913845430692;17294.827051729575;17306.13469326554;17437.82562174362;17516.29934802619;13077.346132693327;13161.73676526464;13176.209427434385;13218.339083046001;13235.536756213678;21172.788272117083;21345.466363341042;21482.677759833616;21509.892450537645;21552;7908.327792137733;8146.144654811278;8206.794830129174;8214.548199848947;8228.958855205805;985.3250523391499;1078.223678951154;1104.9392283424488;1106.0844610080387;1208.4803534480259;32090.679093209237;33279.334413312085;35887;35921;35923.28153436917;1143.2568830260398;1163.5694792926672;1177.093637898813;1235.2897084176634;1246.376811594203;15331.310091045929;15601.977197645158;15962.920185398998;16106.275217615235;16199.838001620068;446659;451266;451444;451645;453296;55650;56003.15995260074;56585;56730;56865;1426.7289215049107;1456.788765628978;1459.7956286119952;1463.817022872141;1472.3521650473758;29382.559261610666;29918.551221731257;30201.244968875955;30293.69706302997;31134.377312453173;49084;49696.25455618241;49745.25382119199;50184;50234.49765502445;421471;423268.88365557976;423500;423723;425935;27934.860325699054;28640.713592863805;28722.71277287284;28803.423931520832;28869.278268042628;45071.549284508044;46237.53762462332;46776.29835552401;46783;46833.2975005382;39410.60589394184;39575.60424395719;39726.40410393904;40151.59848401596;40609;39063.02342441348;39772.2045559093;39804;40345.798271008454;40396.79801600973;34767.30465390729;40156.39765403463;40270.59729402669;40330;40360.79819600883;34474;34483.928081594175;34769.826150869085;34870;35056;27368.589471158346;27638.861805691646;27984;28278.293042674097;28449.146525604265 17:23:41 INFO - PROCESS | 4557 | |2;jquery.html;403.29020923175204;403.93133167361555;408.3629537920844;408.6710198290375;420.7244255012966;14047.78928316076;18137.818621813778;18753.34363297285;19893.502662433446;19918.103685334157;18928.1482333295;19344.613107737838;19344.70982935257;19456.9027154864;19615.901920490414;5572.944270557283;5659.462351076641;5820.708964551776;5834.533237341003;5853.85365365865;5660.235868157808;5671.234383358235;5672.68800215988;5683.119116536944;5775.5668324875805;5603.663780173182;5670.886582268373;5679.545636349103;5721.284839395075;5746.367899531048;5665.150227465892;5665.830025099212;5669.8582535436535;5674.09214525676;5677;5122.718250496258;5426.728663566845;5448.318960129984;5501.9174712379345;5520.530754885839;13524.391402386818;13725.245111518863;13956.860431395758;13960.511382101678;14009.719805603932;2248.3592176229695;2335.6496525521306;2363.302825666415;2584.3539115221197;2712.22701530063;10664.893351066545;11861.94069029658;11892.821607675893;14729.55811325662;14977.850221497754;1943.494691380237;1994.0926878270352;2002.4793553676004;2021.7371741673635;2025.6657651487487;83146.58426707888;86544;87163.56418217931;87434.12565874323;87821.56089219578;10922;11058.447077646086;11468.94265528667;11905.761884762256;12150.878491214975;15747;15813.841861581237;15906.363745450284;15908;15966.441174558835;8162.918370816335;8309.584520773937;8319.8336033279;8399.70601028961;8529.872051919227;7869.606519673994;7880.211978802188;8048.235417635316;8146.144654811278;8194.836103277901;4710.152172608963;4848.903021939542;4864.5621894029;4928.112939670822;4975.975120124376;1913.3590247267043;1978.5152637603878;1993.5016245938516;2054.065400242886;2068.379486154148;971.5142428785607;1062.7980683670078;1072.265498133781;1166.830809532613;1214.7874122028609;18700.719489207673;18893.244270229035;18894.294030862682;18972.24111035543;19223.327183548787;1066.274933045521;1073.436445865911;1075.091547642241;1089.7639672574114;1144.1133121830649;10689.358638481715;10729.409882456539;10880.619178328721;10901.781964360827;10906.945465272624;472234;483483;489262;490922;497278;69020.6548967252;81209.18790812016;81417.18582814214;91542.54228728813;92373.53813231025;1045.3884477580548;1075.833245846895;1092.9016388525072;1135;1136.1138312116398;17145.228464718868;17164.570885727957;17225.932888053012;17291.48125556185;17389.39137130245;39468.80265598768;39617;39833.60166398299;40262;40935.795321024394;53850.73074634602;55765;56260.71869640626;56362.718186408805;56472;8811.339149563937;8887.244584210155;8907.599158037774;8919.286457083548;9111.362204645611;9983.201343892326;12162.756744864877;13024;13341;13625.454981801013;6573.375529324707;8008.519488830456;11753.353565553634;12071.155019148926;12081.335526546125;11041.171912106463;11475.885241147482;11891.940540297242;11913.583024594098;11934.761304773681;6701.698423570853;10777.730556736144;11107.05590024857;11505.309681419141;12584.370781461073;7565.82729676901;8002.239787220437;8111.9594402027615;8244.134365891496;8966.327525435749;11218.495167717636;11957.521699132285;12374.752504950031;12507.187032842836;12561.87438125607 17:23:41 INFO - PROCESS | 4557 | |3;mootools.html;1531.3032570180571;1535.0175887432042;1665.883388162829;1821.5355084453463;1832.569346203642;7507.324340809326;8045.557494337809;8198.344132469403;8714.389992700513;8745.081766414522;8192.95903520483;8366.37252206084;8426.789330266747;8479.788005299855;8515.489070655765;2303.781140791622;2336.836421450499;2338.473843385233;2347.3310106619615;2353.7763912428377;2304.7349554801244;2314.8032417244553;2316.444053427174;2351.353377821096;2357.964630530543;2309.8614083155067;2327.9185228517003;2332.7200735911715;2361.504084142332;2377.9048838046456;2272.1706577099403;2275.7041584594062;2279.8632082075046;2290;2300.1029598456616;2232.944176395587;2245.786650268222;2254.718160229971;2263.7962583367575;2266.6826644269813;8449.831003379897;8469;8524.445911015764;8547.658093676246;8548.529830859363;5009.849704508834;5152.510511501401;5153.381594208681;5162.561182299509;5165.793368265265;3113.8598763055716;3125.46867032605;3287.4575695010294;3298.7855789373853;3299.0597679661423;1028.454918892988;1071.8874518175635;1074.648251706506;1081.8214994525895;1098.6703988803326;11345;11364.431778411046;11370.772584548346;11404.372759498225;11415.657530274106;4487.865364039084;4498.842540511132;4584.381108550369;4611.262198048296;4618.930716039262;9652.131308182157;9658.613655453844;9681.854772178423;9685.854712179324;9706.854397184048;5097.847064588068;5156.535911767884;5182.222666600041;5194.662346947436;5205.29728486657;4253.829846806155;4560.361549383089;4677.953220467752;4683.063387322549;4785.760711964388;3920.6079392060565;3924.47019652349;3947.9013024674614;3970.8014599269923;4071.2875246831686;1272.0586765793432;1291.3801375339701;1294.4563283420987;1309.0574786153954;1322.4115268705525;857.6826574167474;915.5788337364753;949.7483166960761;961.8220629183623;989.2234595842373;5922.407759224129;5958.493528050164;5979.4917432018765;6012.909806352908;6022.939770602238;1058.8200005999;1102.9889701103048;1105.3865104866716;1124.7862906047824;1140.7775483780583;4100.220958017967;4120.690948178899;4180.1012782251355;4197.034682023152;4251.936220956688;10218.948905255575;10576.947115264375;10677;10690.144788416908;10693.89306106929;9925.454100024424;10347.586096556053;10377.896221037692;10526.210534209966;10631.893681063246;7935.64289606969;8035.196480352035;8142.674293028331;8145.470544414594;8162.224588664068;5872.706364681834;6042.425969532887;6054.728507013577;6167.938320616916;6180.289266734383;9372.625094996123;9647.517624118625;9667.178289845442;9671.806563868542;9722.270829687943;9656.37233579815;9731.805363892541;9753.02469753019;9782;9864.408135511892;6976.476764242803;7661.463697541119;7700.075990881131;7702.114256860533;7839.333656639022;8412.07467178622;8489.066202717573;8512.787180320542;8548.529830859363;8551.957240214007;7375.446841486802;7498.887516687145;7602.163761986288;7637.694492220249;7731.961340193263;7517.135529414188;7575.734849280248;7596;7632.618369081412;7707.730229441942;6936.79189624312;6938.722451101899;6998.160220773336;7017.228104908354;7023.789286321418;4988.650794444499;5073.746312684277;5103.464136265788;5166.354205724285;5296.788128474972;5087.3386459759995;5134.306868572844;5152.072626927039;5184.611154163377;5331.360236771612 17:23:41 INFO - PROCESS | 4557 | |4;prototype.html;344.79140120227254;347.7200853313083;350.43929712460067;354.8828886467468;355.2805568723333;5644.576656750744;5723.742431590573;5735.369109397968;5742.741576629051;5747.712614369286;5585.413531579186;5607.887842243153;5623.606347555673;5642.858928526789;5644.57665675074;3998.6601138903084;4098.582205076537;4370.409994650713;4380.145871555048;4390.134192967992;4365.88254696472;4368.97815510922;4395.1868904252815;4395.626371758404;4427.203103441379;4347.152305300468;4358.716683415568;4366.803493842769;4376.956230437702;4380.496242932056;4123.463949686551;4342.174986752539;4357.629601483878;4364.519902810688;4395.296752519597;3798.2783271178387;3812.7140464465274;3814.866479673226;3820.9617903820886;3829.1767270037076;5419.485148910847;5460.099083651193;5460.890782184374;5512.476314750093;5513.7794488220425;4934.481879402647;4992.425871024842;4994.650374473788;5034.521720436553;5096.974515127437;5851.765929362863;5865.85335366615;5870.442307980735;5878.382769809151;5879.67661778602;4219.789010549491;4227.365895115727;4235.449391579105;4239.194553034913;4239.258129827299;5990.472429530485;6013.458788709037;6145.293291271516;6185.505159587222;6249.593776404519;4312.137572485515;4314.223439780807;4315.395844581761;4339.240632889232;4357.4988876279;4358.542353052884;4376.468236117397;4382.386465894777;4388.113111362145;4421.982943922916;4957.132501812241;5007.549320561167;5034.093863104603;5036.269740887551;5062.797488100435;5891.204687367151;5934.732937017759;5947.464728174398;5980.790672326448;6020.879582408327;1485.3167542930373;1506.472734542923;1509.7735339699134;1510.2599726134115;1516.9393224271125;929.934904556688;966.5312323523086;972.4457059476172;973.4305431322614;983.4001259231862;5007.47421520735;5037.672551284155;5063.518965698253;5103.795848166106;5115.365586722841;5329.387120481117;5365.436629153961;5430.212619170277;5438.510534051875;5499.3675727291875;4895.290182923456;5099.949000509948;5135.871603209875;5148.6910785353;5164.715940623227;2872.578073853456;2873.468408344463;2907.825530468179;2922.4885645012037;2923.327634644001;5513.979913715975;5527.115661494142;5585.748641311151;5598.244237027949;5605.775768969277;5245.763940622681;5307.920381194285;5419.756110975016;5520.53075488588;5557.694326812064;5409.6213265071065;5437.293151890308;5449.836504904859;5507.311586051824;5513.814529876096;5013.2981382607195;5299.231611416246;5320.866978325573;5347.598930080338;5372.140457526777;5297.417284098823;5321.563177941856;5325.387580428145;5353.785848566014;5395;5996.380977136236;6179.258488981351;6207.937920620917;6343.270523889627;6353.078803573549;4318.762468064287;4323.416338794348;4357.433533640607;4371.016521282686;4376.299792033259;5840.912386314294;6155.261368635793;6173.382661733791;6220.222472190976;6229.56393052482;5878.617889837147;5930.555208359304;5959.97360897297;5964.761409543569;5979.162917191684;5923.259592550931;5923.963306421445;5931.228940237742;5949.077892926603;5970.731317090655;5590.5527557796095;5808.593398462067;5809.157672137601;5827.446392592697;5831.1836342912875;5892.6759028253855;5962.582619216613;5972.313183983897;6012.428819262163;6026.035834266497;5713.800016999385;5843.853903652443;5847.502962248086;5866.560007999503;5874.911876321944 17:23:41 INFO - PROCESS | 4557 | |5;yui.html;770.8997830282062;772.9381649468044;773.7330620935778;822.4284122534833;848.7326492154971;13933.721325573482;14382.712345753078;14680.265986700675;14720.484783032596;15577.143257120853;13476.730465390687;13548.051636385457;13640.249786261751;13647.727045459085;13668.043236973415;694.4166899804163;822.8066404394963;846.5936350551739;847.6185716427632;850.0904032684998;856.2678909532353;861.0614430271004;865.3293697384546;866.7356456280863;868.0061329777401;872.3980453487105;875.1117615620151;878.2052242720316;886.450400751535;887.4187407248263;873.7422460374205;874.2699845628907;875.9343049271298;879.2921698033081;881.3125761905724;646.1115965547373;646.9676516174172;647.6599785112807;649.9480041596709;651.5894986158737;14644.853551464455;14699.706005879929;14732.042417242845;14741.92629036848;14771.778423323658;14137.293135343294;14231.715365692731;14445.92777036108;14645.853541464661;14839.332230049673;11522.423878806027;11559.537618495335;11687.32078294477;11739.765204695943;12049.638510844688;3855.7108216883566;3872.8644497442738;3928.4892963914795;4036.9596304036877;4045.1505183911413;53616.73191634017;53766.73116634392;55670;55888;56004.15993760056;11321.886781132083;11345.886541134483;11444.198906076661;11544.711382215512;11606.651800446;20437.48906277355;20508.282210122576;20655.8967205166;20687.58624827495;21031.68452473214;8276.462029968034;8347.874781878276;8524.829503410021;8536.70121545743;8638.585151626337;4684.063187362541;4726.858194254178;4761.857144285677;4797.592204662573;4885.5847252983895;3346.6486018968144;3436.0722604896537;3437.432823584131;3438.3639026780124;3445.638207988125;600.5885968111858;605.2918085839578;609.3053918532876;609.5732986909181;616.3528295289927;619.4517851701277;731.9048523691993;736.2563810551275;765.8698021336274;768.6425811997448;8942.150495702897;9235.722928312027;9327.766805829908;9424.293178011676;9424.963820909834;713.0765658472291;716.5163514627606;722.1983598205987;737.8302990312259;746.6901235987114;4100.794960251976;4115.1975364804175;4182.2681030819485;4368.9296122450205;4498.437695288089;58610.41389586135;59761.70119149376;60236;60863.39136608666;63821;54874.72562637161;56650;57660.135097973565;58084.419155807904;58539.41460585425;50700;50899.74550127226;51052.74473627608;51675;51942.22086668703;9349;9407.623695052122;9566.61733530651;9615.759606009906;9627.229821614394;32290.83854580712;32895.177620559676;33035.33929321352;33068.33863322672;33348.33303333871;41311.38032929569;45084.77457612691;45109.32336014897;45618;47637;11650.592229271935;12260.570880019157;12345.753084938431;12392.132550721362;12445.25328480294;13959.930200348934;14397.568072957829;14408.13551186932;14507.637309066935;14833.703325933637;12548.121631485708;12771.10602257833;12892.548760793326;13203.735925281633;13328.666783330495;12933.159344642569;12993.48026078984;13094.672633184247;13295.800562991757;13713.451461941411;12564.120511564102;12625.873741262838;12643.367831608566;12758.234505929673;12853.421596028014;10408.427536485264;10649.201309901633;10777.353358798497;10797.514111865143;10868.184886133413;10399.792004159723;10728.197789967331;11187.21689481761;11191.160662950475;11234.213605047567 17:23:41 INFO - PROCESS | 4557 | __end_tp_report 17:23:41 INFO - PROCESS | 4557 | __start_cc_report 17:23:41 INFO - PROCESS | 4557 | _x_x_mozilla_cycle_collect,334 17:23:41 INFO - PROCESS | 4557 | __end_cc_report 17:23:41 INFO - PROCESS | 4557 | __startTimestamp1463012621525__endTimestamp 17:23:41 INFO - PROCESS | 4557 | 17:23:41 INFO - PROCESS | 4557 | ------- Summary: start ------- 17:23:41 INFO - PROCESS | 4557 | Number of tests: 6 17:23:41 INFO - PROCESS | 4557 | 17:23:41 INFO - PROCESS | 4557 | [#0] dojo.html Cycles:165 Average:5502.77 Median:5762.74 stddev:757.85 (13.2%) stddev-sans-first:738.10 17:23:41 INFO - PROCESS | 4557 | Values: 3187.8 3203.3 3209.6 3252.8 3273.7 5375.1 5403.5 5432.6 5447.9 5523.6 5367.4 5469.8 5515.5 5553.6 5598.0 4958.3 4989.6 5093.8 5140.4 5184.0 490.6 4866.1 4999.2 5035.2 5082.3 5036.7 5073.1 5076.9 5092.2 5101.6 5097.1 5113.7 5117.1 5121.9 5133.8 4876.2 4972.5 5016.9 5041.6 5071.4 5425.2 5481.8 5494.0 5520.4 5521.8 5647.9 6051.7 6060.9 6062.4 6066.8 5938.7 5983.6 5999.2 6043.6 6058.1 5611.1 5627.7 5633.2 5648.5 5652.5 5906.0 6102.2 6178.1 6197.7 6217.2 5848.4 5862.7 5877.2 5880.0 5907.4 6018.8 6049.0 6049.6 6051.1 6052.2 5724.3 5809.0 5818.7 5976.1 6053.1 5828.0 5837.9 5844.1 5846.6 5848.2 4437.4 4439.2 4450.2 4455.4 4469.4 3913.2 3966.8 4001.4 4022.9 4037.7 5503.9 5639.1 5693.2 5722.7 5753.1 5999.3 6025.1 6026.5 6026.7 6033.0 5568.3 5604.8 5634.1 5672.3 5773.4 5075.9 5104.1 5115.9 5122.4 5142.8 5937.3 6193.1 6202.1 6207.2 6217.8 5900.6 5924.8 5942.3 5981.1 6031.4 6119.1 6128.8 6130.9 6170.8 6182.0 5649.1 5848.9 5907.2 5925.5 5943.6 5993.0 6094.4 6105.9 6109.0 6116.6 5830.7 5832.7 5842.6 5878.5 5906.2 5523.2 5789.4 5819.7 5892.5 5909.9 5725.6 5748.2 5751.4 5800.8 5816.6 5941.0 5953.9 5958.1 5961.3 5964.4 5579.2 5762.7 5795.2 5824.3 5847.7 17:23:41 INFO - PROCESS | 4557 | 17:23:41 INFO - PROCESS | 4557 | [#1] ext.html Cycles:180 Average:56378.67 Median:40300.30 stddev:107202.02 (266.0%) stddev-sans-first:107420.92 17:23:41 INFO - PROCESS | 4557 | Values: 588.3 642.9 660.7 662.4 677.4 36988.6 42872.8 43238.4 43281.0 43453.0 42560.0 42674.6 42926.0 43010.0 43054.4 8687.8 8837.6 8844.7 8850.2 8857.8 8722.6 8745.2 8785.3 8813.3 8833.5 8856.2 8863.6 8876.1 8882.2 8893.0 8750.6 8839.7 8846.9 8850.8 8871.2 8577.0 8667.9 8694.3 8694.3 8698.5 34312.3 39321.8 39783.6 39851.2 39858.0 3530.3 3562.4 3834.4 4166.6 4443.1 29777.4 30647.2 31691.8 33316.0 33379.5 4318.8 4375.0 4376.5 4393.0 4497.2 329423.0 335155.0 335494.0 336231.0 337458.0 64608.4 65058.3 65416.3 65442.7 65654.3 38387.0 38970.0 39150.8 41421.8 41568.0 17230.9 17294.8 17306.1 17437.8 17516.3 13077.3 13161.7 13176.2 13218.3 13235.5 21172.8 21345.5 21482.7 21509.9 21552.0 7908.3 8146.1 8206.8 8214.5 8229.0 985.3 1078.2 1104.9 1106.1 1208.5 32090.7 33279.3 35887.0 35921.0 35923.3 1143.3 1163.6 1177.1 1235.3 1246.4 15331.3 15602.0 15962.9 16106.3 16199.8 446659.0 451266.0 451444.0 451645.0 453296.0 55650.0 56003.2 56585.0 56730.0 56865.0 1426.7 1456.8 1459.8 1463.8 1472.4 29382.6 29918.6 30201.2 30293.7 31134.4 49084.0 49696.3 49745.3 50184.0 50234.5 421471.0 423268.9 423500.0 423723.0 425935.0 27934.9 28640.7 28722.7 28803.4 28869.3 45071.5 46237.5 46776.3 46783.0 46833.3 39410.6 39575.6 39726.4 40151.6 40609.0 39063.0 39772.2 39804.0 40345.8 40396.8 34767.3 40156.4 40270.6 40330.0 40360.8 34474.0 34483.9 34769.8 34870.0 35056.0 27368.6 27638.9 27984.0 28278.3 28449.1 17:23:41 INFO - PROCESS | 4557 | 17:23:41 INFO - PROCESS | 4557 | [#2] jquery.html Cycles:180 Average:28443.77 Median:2292.00 stddev:80203.92 (3499.3%) stddev-sans-first:80401.28 17:23:41 INFO - PROCESS | 4557 | Values: 403.3 403.9 408.4 408.7 420.7 14047.8 18137.8 18753.3 19893.5 19918.1 18928.1 19344.6 19344.7 19456.9 19615.9 5572.9 5659.5 5820.7 5834.5 5853.9 5660.2 5671.2 5672.7 5683.1 5775.6 5603.7 5670.9 5679.5 5721.3 5746.4 5665.2 5665.8 5669.9 5674.1 5677.0 5122.7 5426.7 5448.3 5501.9 5520.5 13524.4 13725.2 13956.9 13960.5 14009.7 2248.4 2335.6 2363.3 2584.4 2712.2 10664.9 11861.9 11892.8 14729.6 14977.9 1943.5 1994.1 2002.5 2021.7 2025.7 83146.6 86544.0 87163.6 87434.1 87821.6 10922.0 11058.4 11468.9 11905.8 12150.9 15747.0 15813.8 15906.4 15908.0 15966.4 8162.9 8309.6 8319.8 8399.7 8529.9 7869.6 7880.2 8048.2 8146.1 8194.8 4710.2 4848.9 4864.6 4928.1 4976.0 1913.4 1978.5 1993.5 2054.1 2068.4 971.5 1062.8 1072.3 1166.8 1214.8 18700.7 18893.2 18894.3 18972.2 19223.3 1066.3 1073.4 1075.1 1089.8 1144.1 10689.4 10729.4 10880.6 10901.8 10906.9 472234.0 483483.0 489262.0 490922.0 497278.0 69020.7 81209.2 81417.2 91542.5 92373.5 1045.4 1075.8 1092.9 1135.0 1136.1 17145.2 17164.6 17225.9 17291.5 17389.4 39468.8 39617.0 39833.6 40262.0 40935.8 53850.7 55765.0 56260.7 56362.7 56472.0 8811.3 8887.2 8907.6 8919.3 9111.4 9983.2 12162.8 13024.0 13341.0 13625.5 6573.4 8008.5 11753.4 12071.2 12081.3 11041.2 11475.9 11891.9 11913.6 11934.8 6701.7 10777.7 11107.1 11505.3 12584.4 7565.8 8002.2 8112.0 8244.1 8966.3 11218.5 11957.5 12374.8 12507.2 12561.9 17:23:41 INFO - PROCESS | 4557 | 17:23:41 INFO - PROCESS | 4557 | [#3] mootools.html Cycles:180 Average:5656.10 Median:5143.19 stddev:3113.40 (60.5%) stddev-sans-first:3106.70 17:23:41 INFO - PROCESS | 4557 | Values: 1531.3 1535.0 1665.9 1821.5 1832.6 7507.3 8045.6 8198.3 8714.4 8745.1 8193.0 8366.4 8426.8 8479.8 8515.5 2303.8 2336.8 2338.5 2347.3 2353.8 2304.7 2314.8 2316.4 2351.4 2358.0 2309.9 2327.9 2332.7 2361.5 2377.9 2272.2 2275.7 2279.9 2290.0 2300.1 2232.9 2245.8 2254.7 2263.8 2266.7 8449.8 8469.0 8524.4 8547.7 8548.5 5009.8 5152.5 5153.4 5162.6 5165.8 3113.9 3125.5 3287.5 3298.8 3299.1 1028.5 1071.9 1074.6 1081.8 1098.7 11345.0 11364.4 11370.8 11404.4 11415.7 4487.9 4498.8 4584.4 4611.3 4618.9 9652.1 9658.6 9681.9 9685.9 9706.9 5097.8 5156.5 5182.2 5194.7 5205.3 4253.8 4560.4 4678.0 4683.1 4785.8 3920.6 3924.5 3947.9 3970.8 4071.3 1272.1 1291.4 1294.5 1309.1 1322.4 857.7 915.6 949.7 961.8 989.2 5922.4 5958.5 5979.5 6012.9 6022.9 1058.8 1103.0 1105.4 1124.8 1140.8 4100.2 4120.7 4180.1 4197.0 4251.9 10218.9 10576.9 10677.0 10690.1 10693.9 9925.5 10347.6 10377.9 10526.2 10631.9 7935.6 8035.2 8142.7 8145.5 8162.2 5872.7 6042.4 6054.7 6167.9 6180.3 9372.6 9647.5 9667.2 9671.8 9722.3 9656.4 9731.8 9753.0 9782.0 9864.4 6976.5 7661.5 7700.1 7702.1 7839.3 8412.1 8489.1 8512.8 8548.5 8552.0 7375.4 7498.9 7602.2 7637.7 7732.0 7517.1 7575.7 7596.0 7632.6 7707.7 6936.8 6938.7 6998.2 7017.2 7023.8 4988.7 5073.7 5103.5 5166.4 5296.8 5087.3 5134.3 5152.1 5184.6 5331.4 17:23:41 INFO - PROCESS | 4557 | 17:23:41 INFO - PROCESS | 4557 | [#4] prototype.html Cycles:180 Average:4815.31 Median:5359.61 stddev:1401.98 (26.2%) stddev-sans-first:1365.17 17:23:41 INFO - PROCESS | 4557 | Values: 344.8 347.7 350.4 354.9 355.3 5644.6 5723.7 5735.4 5742.7 5747.7 5585.4 5607.9 5623.6 5642.9 5644.6 3998.7 4098.6 4370.4 4380.1 4390.1 4365.9 4369.0 4395.2 4395.6 4427.2 4347.2 4358.7 4366.8 4377.0 4380.5 4123.5 4342.2 4357.6 4364.5 4395.3 3798.3 3812.7 3814.9 3821.0 3829.2 5419.5 5460.1 5460.9 5512.5 5513.8 4934.5 4992.4 4994.7 5034.5 5097.0 5851.8 5865.9 5870.4 5878.4 5879.7 4219.8 4227.4 4235.4 4239.2 4239.3 5990.5 6013.5 6145.3 6185.5 6249.6 4312.1 4314.2 4315.4 4339.2 4357.5 4358.5 4376.5 4382.4 4388.1 4422.0 4957.1 5007.5 5034.1 5036.3 5062.8 5891.2 5934.7 5947.5 5980.8 6020.9 1485.3 1506.5 1509.8 1510.3 1516.9 929.9 966.5 972.4 973.4 983.4 5007.5 5037.7 5063.5 5103.8 5115.4 5329.4 5365.4 5430.2 5438.5 5499.4 4895.3 5099.9 5135.9 5148.7 5164.7 2872.6 2873.5 2907.8 2922.5 2923.3 5514.0 5527.1 5585.7 5598.2 5605.8 5245.8 5307.9 5419.8 5520.5 5557.7 5409.6 5437.3 5449.8 5507.3 5513.8 5013.3 5299.2 5320.9 5347.6 5372.1 5297.4 5321.6 5325.4 5353.8 5395.0 5996.4 6179.3 6207.9 6343.3 6353.1 4318.8 4323.4 4357.4 4371.0 4376.3 5840.9 6155.3 6173.4 6220.2 6229.6 5878.6 5930.6 5960.0 5964.8 5979.2 5923.3 5924.0 5931.2 5949.1 5970.7 5590.6 5808.6 5809.2 5827.4 5831.2 5892.7 5962.6 5972.3 6012.4 6026.0 5713.8 5843.9 5847.5 5866.6 5874.9 17:23:41 INFO - PROCESS | 4557 | 17:23:41 INFO - PROCESS | 4557 | [#5] yui.html Cycles:180 Average:15025.50 Median:24791.61 stddev:17145.18 (69.2%) stddev-sans-first:17159.86 17:23:41 INFO - PROCESS | 4557 | Values: 770.9 772.9 773.7 822.4 848.7 13933.7 14382.7 14680.3 14720.5 15577.1 13476.7 13548.1 13640.2 13647.7 13668.0 694.4 822.8 846.6 847.6 850.1 856.3 861.1 865.3 866.7 868.0 872.4 875.1 878.2 886.5 887.4 873.7 874.3 875.9 879.3 881.3 646.1 647.0 647.7 649.9 651.6 14644.9 14699.7 14732.0 14741.9 14771.8 14137.3 14231.7 14445.9 14645.9 14839.3 11522.4 11559.5 11687.3 11739.8 12049.6 3855.7 3872.9 3928.5 4037.0 4045.2 53616.7 53766.7 55670.0 55888.0 56004.2 11321.9 11345.9 11444.2 11544.7 11606.7 20437.5 20508.3 20655.9 20687.6 21031.7 8276.5 8347.9 8524.8 8536.7 8638.6 4684.1 4726.9 4761.9 4797.6 4885.6 3346.6 3436.1 3437.4 3438.4 3445.6 600.6 605.3 609.3 609.6 616.4 619.5 731.9 736.3 765.9 768.6 8942.2 9235.7 9327.8 9424.3 9425.0 713.1 716.5 722.2 737.8 746.7 4100.8 4115.2 4182.3 4368.9 4498.4 58610.4 59761.7 60236.0 60863.4 63821.0 54874.7 56650.0 57660.1 58084.4 58539.4 50700.0 50899.7 51052.7 51675.0 51942.2 9349.0 9407.6 9566.6 9615.8 9627.2 32290.8 32895.2 33035.3 33068.3 33348.3 41311.4 45084.8 45109.3 45618.0 47637.0 11650.6 12260.6 12345.8 12392.1 12445.3 13959.9 14397.6 14408.1 14507.6 14833.7 12548.1 12771.1 12892.5 13203.7 13328.7 12933.2 12993.5 13094.7 13295.8 13713.5 12564.1 12625.9 12643.4 12758.2 12853.4 10408.4 10649.2 10777.4 10797.5 10868.2 10399.8 10728.2 11187.2 11191.2 11234.2 17:23:41 INFO - PROCESS | 4557 | -------- Summary: end -------- 17:23:41 INFO - PROCESS | 4557 | 17:23:42 INFO - TEST-INFO | 4557: exit 0 17:23:42 INFO - TEST-OK | dromaeo_css | took 1110793ms 17:23:42 INFO - TEST-START | kraken 17:23:42 INFO - operating with platform_type : linux_ 17:23:42 INFO - Initialising browser for kraken test... 17:23:42 INFO - TEST-INFO | started process 4792 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAghIMN/profile http://localhost:54355/getInfo.html) 17:23:46 INFO - PROCESS | 4792 | 17:23:46 INFO - PROCESS | 4792 | (process:4860): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:23:47 INFO - PROCESS | 4792 | __metrics Screen width/height:1600/1200 17:23:47 INFO - PROCESS | 4792 | colorDepth:24 17:23:47 INFO - PROCESS | 4792 | Browser inner width/height: 1024/697 17:23:47 INFO - PROCESS | 4792 | __metrics 17:23:48 ERROR - PROCESS | 4792 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 17:23:49 INFO - TEST-INFO | 4792: exit 0 17:23:49 INFO - Browser initialized. 17:23:49 INFO - Running cycle 1/1 for kraken test... 17:23:49 INFO - TEST-INFO | started process 4911 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAghIMN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:23:51 INFO - PROCESS | 4911 | 17:23:51 INFO - PROCESS | 4911 | (process:4971): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:24:01 INFO - PROCESS | 4911 | RSS: Main: 162684928 17:24:01 INFO - PROCESS | 4911 | 17:24:03 INFO - PROCESS | 4911 | Cycle 1(1): loaded http://localhost:54355/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54355/tests/kraken/driver.html?testName=audio-beat-detection) 17:24:04 INFO - PROCESS | 4911 | RSS: Main: 167620608 17:24:04 INFO - PROCESS | 4911 | 17:24:07 INFO - PROCESS | 4911 | Cycle 1(1): loaded http://localhost:54355/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54355/tests/kraken/driver.html?testName=audio-dft) 17:24:07 INFO - PROCESS | 4911 | RSS: Main: 167800832 17:24:07 INFO - PROCESS | 4911 | 17:24:10 INFO - PROCESS | 4911 | Cycle 1(1): loaded http://localhost:54355/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54355/tests/kraken/driver.html?testName=audio-fft) 17:24:11 INFO - PROCESS | 4911 | RSS: Main: 162381824 17:24:11 INFO - PROCESS | 4911 | 17:24:13 INFO - PROCESS | 4911 | Cycle 1(1): loaded http://localhost:54355/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54355/tests/kraken/driver.html?testName=audio-oscillator) 17:24:14 INFO - PROCESS | 4911 | RSS: Main: 162693120 17:24:14 INFO - PROCESS | 4911 | 17:24:16 INFO - PROCESS | 4911 | Cycle 1(1): loaded http://localhost:54355/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54355/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:24:17 INFO - PROCESS | 4911 | RSS: Main: 162955264 17:24:17 INFO - PROCESS | 4911 | 17:24:20 INFO - PROCESS | 4911 | Cycle 1(1): loaded http://localhost:54355/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54355/tests/kraken/driver.html?testName=imaging-darkroom) 17:24:20 INFO - PROCESS | 4911 | RSS: Main: 163573760 17:24:20 INFO - PROCESS | 4911 | 17:24:24 INFO - PROCESS | 4911 | Cycle 1(1): loaded http://localhost:54355/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54355/tests/kraken/driver.html?testName=imaging-desaturate) 17:24:25 INFO - PROCESS | 4911 | RSS: Main: 162406400 17:24:25 INFO - PROCESS | 4911 | 17:24:27 INFO - PROCESS | 4911 | Cycle 1(1): loaded http://localhost:54355/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54355/tests/kraken/driver.html?testName=json-parse-financial) 17:24:28 INFO - PROCESS | 4911 | RSS: Main: 162775040 17:24:28 INFO - PROCESS | 4911 | 17:24:30 INFO - PROCESS | 4911 | Cycle 1(1): loaded http://localhost:54355/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54355/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:24:30 INFO - PROCESS | 4911 | RSS: Main: 163028992 17:24:30 INFO - PROCESS | 4911 | 17:24:32 INFO - PROCESS | 4911 | Cycle 1(1): loaded http://localhost:54355/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54355/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:24:33 INFO - PROCESS | 4911 | RSS: Main: 163303424 17:24:33 INFO - PROCESS | 4911 | 17:24:35 INFO - PROCESS | 4911 | Cycle 1(1): loaded http://localhost:54355/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54355/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:24:36 INFO - PROCESS | 4911 | RSS: Main: 163733504 17:24:36 INFO - PROCESS | 4911 | 17:24:38 INFO - PROCESS | 4911 | Cycle 1(1): loaded http://localhost:54355/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54355/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:24:39 INFO - PROCESS | 4911 | RSS: Main: 163762176 17:24:39 INFO - PROCESS | 4911 | 17:24:42 INFO - PROCESS | 4911 | Cycle 1(1): loaded http://localhost:54355/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54355/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:24:42 INFO - PROCESS | 4911 | RSS: Main: 163467264 17:24:42 INFO - PROCESS | 4911 | 17:24:44 INFO - PROCESS | 4911 | Cycle 1(1): loaded http://localhost:54355/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54355/tests/kraken/driver.html?testName=ai-astar) 17:24:44 INFO - PROCESS | 4911 | RSS: Main: 165310464 17:24:44 INFO - PROCESS | 4911 | 17:24:44 INFO - PROCESS | 4911 | __start_tp_report 17:24:44 INFO - PROCESS | 4911 | _x_x_mozilla_page_load 17:24:44 INFO - PROCESS | 4911 | _x_x_mozilla_page_load_details 17:24:44 INFO - PROCESS | 4911 | |i|pagename|runs| 17:24:44 INFO - PROCESS | 4911 | |0;ai-astar;108;113;106;111;112;113;108;110;114;111 17:24:44 INFO - PROCESS | 4911 | |1;audio-beat-detection;150;127;157;217;132;154;159;127;173;134 17:24:44 INFO - PROCESS | 4911 | |2;audio-dft;163;163;161;163;166;176;162;163;162;161 17:24:44 INFO - PROCESS | 4911 | |3;audio-fft;75;76;75;159;76;75;74;75;188;74 17:24:44 INFO - PROCESS | 4911 | |4;audio-oscillator;93;92;178;90;92;92;151;94;93;155 17:24:44 INFO - PROCESS | 4911 | |5;imaging-gaussian-blur;118;117;117;117;117;117;118;117;117;118 17:24:44 INFO - PROCESS | 4911 | |6;imaging-darkroom;146;147;148;146;147;147;147;147;146;147 17:24:44 INFO - PROCESS | 4911 | |7;imaging-desaturate;95;96;95;96;95;96;95;95;96;95 17:24:44 INFO - PROCESS | 4911 | |8;json-parse-financial;59;61;59;59;60;61;60;115;58;57 17:24:44 INFO - PROCESS | 4911 | |9;json-stringify-tinderbox;60;60;60;59;60;59;59;63;65;61 17:24:44 INFO - PROCESS | 4911 | |10;stanford-crypto-aes;79;80;80;84;80;79;83;79;80;80 17:24:44 INFO - PROCESS | 4911 | |11;stanford-crypto-ccm;127;135;129;130;124;129;121;123;212;128 17:24:44 INFO - PROCESS | 4911 | |12;stanford-crypto-pbkdf2;173;174;170;176;174;170;173;168;171;169 17:24:44 INFO - PROCESS | 4911 | |13;stanford-crypto-sha256-iterative;67;66;69;64;66;64;69;65;63;67 17:24:44 INFO - PROCESS | 4911 | __end_tp_report 17:24:44 INFO - PROCESS | 4911 | __start_cc_report 17:24:44 INFO - PROCESS | 4911 | _x_x_mozilla_cycle_collect,864 17:24:44 INFO - PROCESS | 4911 | __end_cc_report 17:24:44 INFO - PROCESS | 4911 | __startTimestamp1463012684913__endTimestamp 17:24:44 INFO - PROCESS | 4911 | 17:24:44 INFO - PROCESS | 4911 | ------- Summary: start ------- 17:24:44 INFO - PROCESS | 4911 | Number of tests: 14 17:24:44 INFO - PROCESS | 4911 | 17:24:44 INFO - PROCESS | 4911 | [#0] ai-astar Cycles:10 Average:110.60 Median:111.50 stddev:2.59 (2.3%) stddev-sans-first:2.57 17:24:44 INFO - PROCESS | 4911 | Values: 108.0 113.0 106.0 111.0 112.0 113.0 108.0 110.0 114.0 111.0 17:24:44 INFO - PROCESS | 4911 | 17:24:44 INFO - PROCESS | 4911 | [#1] audio-beat-detection Cycles:10 Average:153.00 Median:155.50 stddev:27.31 (17.6%) stddev-sans-first:28.94 17:24:44 INFO - PROCESS | 4911 | Values: 150.0 127.0 157.0 217.0 132.0 154.0 159.0 127.0 173.0 134.0 17:24:44 INFO - PROCESS | 4911 | 17:24:44 INFO - PROCESS | 4911 | [#2] audio-dft Cycles:10 Average:164.00 Median:163.00 stddev:4.45 (2.7%) stddev-sans-first:4.70 17:24:44 INFO - PROCESS | 4911 | Values: 163.0 163.0 161.0 163.0 166.0 176.0 162.0 163.0 162.0 161.0 17:24:44 INFO - PROCESS | 4911 | 17:24:44 INFO - PROCESS | 4911 | [#3] audio-fft Cycles:10 Average:94.70 Median:75.00 stddev:42.10 (56.1%) stddev-sans-first:44.04 17:24:44 INFO - PROCESS | 4911 | Values: 75.0 76.0 75.0 159.0 76.0 75.0 74.0 75.0 188.0 74.0 17:24:44 INFO - PROCESS | 4911 | 17:24:44 INFO - PROCESS | 4911 | [#4] audio-oscillator Cycles:10 Average:113.00 Median:92.00 stddev:34.07 (37.0%) stddev-sans-first:35.36 17:24:44 INFO - PROCESS | 4911 | Values: 93.0 92.0 178.0 90.0 92.0 92.0 151.0 94.0 93.0 155.0 17:24:44 INFO - PROCESS | 4911 | 17:24:44 INFO - PROCESS | 4911 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 17:24:44 INFO - PROCESS | 4911 | Values: 118.0 117.0 117.0 117.0 117.0 117.0 118.0 117.0 117.0 118.0 17:24:44 INFO - PROCESS | 4911 | 17:24:44 INFO - PROCESS | 4911 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.63 (0.4%) stddev-sans-first:0.60 17:24:44 INFO - PROCESS | 4911 | Values: 146.0 147.0 148.0 146.0 147.0 147.0 147.0 147.0 146.0 147.0 17:24:44 INFO - PROCESS | 4911 | 17:24:44 INFO - PROCESS | 4911 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 17:24:44 INFO - PROCESS | 4911 | Values: 95.0 96.0 95.0 96.0 95.0 96.0 95.0 95.0 96.0 95.0 17:24:44 INFO - PROCESS | 4911 | 17:24:44 INFO - PROCESS | 4911 | [#8] json-parse-financial Cycles:10 Average:64.90 Median:59.50 stddev:17.65 (29.7%) stddev-sans-first:18.59 17:24:44 INFO - PROCESS | 4911 | Values: 59.0 61.0 59.0 59.0 60.0 61.0 60.0 115.0 58.0 57.0 17:24:44 INFO - PROCESS | 4911 | 17:24:44 INFO - PROCESS | 4911 | [#9] json-stringify-tinderbox Cycles:10 Average:60.60 Median:60.00 stddev:1.96 (3.3%) stddev-sans-first:2.06 17:24:44 INFO - PROCESS | 4911 | Values: 60.0 60.0 60.0 59.0 60.0 59.0 59.0 63.0 65.0 61.0 17:24:44 INFO - PROCESS | 4911 | 17:24:44 INFO - PROCESS | 4911 | [#10] stanford-crypto-aes Cycles:10 Average:80.40 Median:80.00 stddev:1.71 (2.1%) stddev-sans-first:1.74 17:24:44 INFO - PROCESS | 4911 | Values: 79.0 80.0 80.0 84.0 80.0 79.0 83.0 79.0 80.0 80.0 17:24:44 INFO - PROCESS | 4911 | 17:24:44 INFO - PROCESS | 4911 | [#11] stanford-crypto-ccm Cycles:10 Average:135.80 Median:129.00 stddev:27.07 (21.0%) stddev-sans-first:28.52 17:24:44 INFO - PROCESS | 4911 | Values: 127.0 135.0 129.0 130.0 124.0 129.0 121.0 123.0 212.0 128.0 17:24:44 INFO - PROCESS | 4911 | 17:24:44 INFO - PROCESS | 4911 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.80 Median:173.00 stddev:2.57 (1.5%) stddev-sans-first:2.69 17:24:44 INFO - PROCESS | 4911 | Values: 173.0 174.0 170.0 176.0 174.0 170.0 173.0 168.0 171.0 169.0 17:24:44 INFO - PROCESS | 4911 | 17:24:44 INFO - PROCESS | 4911 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.00 Median:66.50 stddev:2.05 (3.1%) stddev-sans-first:2.15 17:24:44 INFO - PROCESS | 4911 | Values: 67.0 66.0 69.0 64.0 66.0 64.0 69.0 65.0 63.0 67.0 17:24:44 INFO - PROCESS | 4911 | -------- Summary: end -------- 17:24:44 INFO - PROCESS | 4911 | 17:24:45 INFO - TEST-INFO | 4911: exit 0 17:24:45 INFO - TEST-OK | kraken | took 63657ms 17:24:45 INFO - SUITE-END | took 1174s 17:24:46 INFO - Completed test suite (00:19:34) 17:24:46 INFO - javascript benchmark 17:24:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3187.7768556201063, 3203.2792621660124, 3209.5667084943557, 3252.837358132093, 3273.6889995450438, 5375.086235339992, 5403.486668766466, 5432.592555558329, 5447.945520544793, 5523.613347065707, 5367.35591728993, 5469.808556700506, 5515.503604675579, 5553.639013464122, 5598.020346439377, 4958.256261560768, 4989.57588604969, 5093.770780314876, 5140.357455318085, 5183.974080129613, 490.64371072752493, 4866.051120031595, 4999.225120106389, 5035.169197082495, 5082.339295891547, 5036.697798132105, 5073.086844368012, 5076.949230507703, 5092.159793634046, 5101.591872650198, 5097.108006098918, 5113.667611605234, 5117.078925793356, 5121.8719532012, 5133.794648214067, 4876.244182151772, 4972.477889821553, 5016.949830501685, 5041.571466425358, 5071.41678706946, 5425.186222066682, 5481.835544933619, 5494.0, 5520.365158006841, 5521.834344969658, 5647.943520564783, 6051.727672254759, 6060.909086363708, 6062.424069713415, 6066.787662431793, 5938.673372964486, 5983.551233657493, 5999.190109335227, 6043.637381757108, 6058.0610005449225, 5611.0741727614895, 5627.71861406928, 5633.15502674598, 5648.548116150698, 5652.547796176296, 5906.0, 6102.237220347457, 6178.104174894615, 6197.690115494207, 6217.191765070512, 5848.444397782204, 5862.736176872051, 5877.23595932526, 5879.970600146972, 5907.3797251288, 6018.8194354169445, 6049.03215485529, 6049.606775559574, 6051.062085376773, 6052.213212282375, 5724.341700704389, 5809.041508151107, 5818.709064546756, 5976.133460648181, 6053.061775424816, 5827.970860145672, 5837.9124313135335, 5844.064949608042, 5846.649201047951, 5848.2397288353095, 4437.356583295404, 4439.156560253606, 4450.221211288012, 4455.353973673799, 4469.351943968171, 3913.1977944521304, 3966.801659916993, 4001.3597824347967, 4022.899427514277, 4037.7375470594316, 5503.862403439946, 5639.125935480007, 5693.17448969897, 5722.656640601577, 5753.079507278815, 5999.250093738283, 6025.126356678257, 6026.54800889935, 6026.6986650667295, 6033.0, 5568.276124103841, 5604.775808967677, 5634.070378387521, 5672.319321681424, 5773.364929857797, 5075.923861142086, 5104.106781313255, 5115.8721031973755, 5122.410922743858, 5142.820001299937, 5937.317208520989, 6193.1329613854095, 6202.131701561785, 6207.162033125561, 6217.844553886189, 5900.586958912835, 5924.7926322578505, 5942.257217847769, 5981.1327357532045, 6031.396860313934, 6119.082137679384, 6128.785492507741, 6130.877382452415, 6170.81487555374, 6181.9690901547, 5649.096144616841, 5848.883022339614, 5907.202527658711, 5925.525957923442, 5943.58394912352, 5993.041113421831, 6094.350380525191, 6105.877882442415, 6109.033772226435, 6116.5718399711595, 5830.708464576839, 5832.708364581838, 5842.561807864342, 5878.500327472213, 5906.232189815297, 5523.171524271392, 5789.363170051375, 5819.738111784895, 5892.469677729025, 5909.852253693692, 5725.570582206435, 5748.166515855094, 5751.396103409249, 5800.796972105956, 5816.563757718272, 5941.0, 5953.880922381615, 5958.136070269873, 5961.2846458425265, 5964.373740757158, 5579.246801681721, 5762.740676669644, 5795.188673585617, 5824.271966004249, 5847.707614619167], "value": 5452.1412979750885, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [588.2764200033959, 642.893922502787, 660.735705717713, 662.3641304347829, 677.4241894389767, 36988.630113698855, 42872.785636071814, 43238.351424728615, 43281.0, 43453.0, 42560.0, 42674.573254267445, 42926.0, 43010.0, 43054.354184687174, 8687.782805429868, 8837.55812209387, 8844.73465796024, 8850.247728943015, 8857.778555536132, 8722.607482663263, 8745.169208925143, 8785.297176225919, 8813.294936405073, 8833.514156721378, 8856.158664926821, 8863.556822158866, 8876.112388761137, 8882.200601945824, 8892.955535222347, 8750.649974001033, 8839.73480795574, 8846.867296990486, 8850.778730531789, 8871.24594409476, 8577.0, 8667.913320866837, 8694.260987816044, 8694.304455643532, 8698.478091314479, 34312.31375372504, 39321.80339098315, 39783.60216397828, 39851.202975940316, 39858.0, 3530.3115892400992, 3562.4300111982216, 3834.4248362745534, 4166.6250037496775, 4443.089166720847, 29777.404451911058, 30647.233819154477, 31691.84154079238, 33316.0, 33379.49930751041, 4318.805653745558, 4375.037491751809, 4376.474823021258, 4392.978035109836, 4497.168023915586, 329423.0, 335155.0, 335494.0, 336230.99999999756, 337458.0, 64608.35391646023, 65058.34941650618, 65416.34583654198, 65442.672786636715, 65654.34345656482, 38387.0, 38970.0, 39150.80424597859, 41421.79289103535, 41568.0, 17230.913845430692, 17294.827051729575, 17306.13469326554, 17437.82562174362, 17516.29934802619, 13077.346132693327, 13161.73676526464, 13176.209427434385, 13218.339083046001, 13235.536756213678, 21172.788272117083, 21345.466363341042, 21482.677759833616, 21509.892450537645, 21552.0, 7908.327792137733, 8146.144654811278, 8206.794830129174, 8214.548199848947, 8228.958855205805, 985.3250523391499, 1078.223678951154, 1104.9392283424488, 1106.0844610080387, 1208.4803534480259, 32090.679093209237, 33279.334413312085, 35887.0, 35921.0, 35923.28153436917, 1143.2568830260398, 1163.5694792926672, 1177.093637898813, 1235.2897084176634, 1246.376811594203, 15331.310091045929, 15601.977197645158, 15962.920185398998, 16106.275217615235, 16199.838001620068, 446659.0, 451266.0, 451444.0, 451645.0, 453296.0, 55650.0, 56003.15995260074, 56585.0, 56730.0, 56865.0, 1426.7289215049107, 1456.788765628978, 1459.7956286119952, 1463.817022872141, 1472.3521650473758, 29382.559261610666, 29918.551221731257, 30201.244968875955, 30293.69706302997, 31134.377312453173, 49084.0, 49696.25455618241, 49745.25382119199, 50184.0, 50234.49765502445, 421471.0, 423268.88365557976, 423500.0, 423723.0, 425935.0, 27934.860325699054, 28640.713592863805, 28722.71277287284, 28803.423931520832, 28869.278268042628, 45071.549284508044, 46237.53762462332, 46776.29835552401, 46783.0, 46833.2975005382, 39410.60589394184, 39575.60424395719, 39726.40410393904, 40151.59848401596, 40609.0, 39063.02342441348, 39772.2045559093, 39804.0, 40345.798271008454, 40396.79801600973, 34767.30465390729, 40156.39765403463, 40270.59729402669, 40330.0, 40360.79819600883, 34474.0, 34483.928081594175, 34769.826150869085, 34870.0, 35056.0, 27368.589471158346, 27638.861805691646, 27984.0, 28278.293042674097, 28449.146525604265], "value": 19931.763037715238, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [403.29020923175204, 403.93133167361555, 408.3629537920844, 408.6710198290375, 420.7244255012966, 14047.78928316076, 18137.818621813778, 18753.34363297285, 19893.502662433446, 19918.103685334157, 18928.1482333295, 19344.613107737838, 19344.70982935257, 19456.9027154864, 19615.901920490414, 5572.944270557283, 5659.462351076641, 5820.708964551776, 5834.533237341003, 5853.85365365865, 5660.235868157808, 5671.234383358235, 5672.68800215988, 5683.119116536944, 5775.5668324875805, 5603.663780173182, 5670.886582268373, 5679.545636349103, 5721.284839395075, 5746.367899531048, 5665.150227465892, 5665.830025099212, 5669.8582535436535, 5674.09214525676, 5677.0, 5122.718250496258, 5426.728663566845, 5448.318960129984, 5501.9174712379345, 5520.530754885839, 13524.391402386818, 13725.245111518863, 13956.860431395758, 13960.511382101678, 14009.719805603932, 2248.3592176229695, 2335.6496525521306, 2363.302825666415, 2584.3539115221197, 2712.22701530063, 10664.893351066545, 11861.94069029658, 11892.821607675893, 14729.55811325662, 14977.850221497754, 1943.494691380237, 1994.0926878270352, 2002.4793553676004, 2021.7371741673635, 2025.6657651487487, 83146.58426707888, 86544.0, 87163.56418217931, 87434.12565874323, 87821.56089219578, 10922.0, 11058.447077646086, 11468.94265528667, 11905.761884762256, 12150.878491214975, 15747.0, 15813.841861581237, 15906.363745450284, 15908.0, 15966.441174558835, 8162.918370816335, 8309.584520773937, 8319.8336033279, 8399.70601028961, 8529.872051919227, 7869.606519673994, 7880.211978802188, 8048.235417635316, 8146.144654811278, 8194.836103277901, 4710.152172608963, 4848.903021939542, 4864.5621894029, 4928.112939670822, 4975.975120124376, 1913.3590247267043, 1978.5152637603878, 1993.5016245938516, 2054.065400242886, 2068.379486154148, 971.5142428785607, 1062.7980683670078, 1072.265498133781, 1166.830809532613, 1214.7874122028609, 18700.719489207673, 18893.244270229035, 18894.294030862682, 18972.24111035543, 19223.327183548787, 1066.274933045521, 1073.436445865911, 1075.091547642241, 1089.7639672574114, 1144.1133121830649, 10689.358638481715, 10729.409882456539, 10880.619178328721, 10901.781964360827, 10906.945465272624, 472234.0, 483483.0, 489262.0, 490922.0, 497278.0, 69020.6548967252, 81209.18790812016, 81417.18582814214, 91542.54228728813, 92373.53813231025, 1045.3884477580548, 1075.833245846895, 1092.9016388525072, 1135.0, 1136.1138312116398, 17145.228464718868, 17164.570885727957, 17225.932888053012, 17291.48125556185, 17389.39137130245, 39468.80265598768, 39617.0, 39833.60166398299, 40262.0, 40935.795321024394, 53850.73074634602, 55765.0, 56260.71869640626, 56362.718186408805, 56472.0, 8811.339149563937, 8887.244584210155, 8907.599158037774, 8919.286457083548, 9111.362204645611, 9983.201343892326, 12162.756744864877, 13024.0, 13341.0, 13625.454981801013, 6573.375529324707, 8008.519488830456, 11753.353565553634, 12071.155019148926, 12081.335526546125, 11041.171912106463, 11475.885241147482, 11891.940540297242, 11913.583024594098, 11934.761304773681, 6701.698423570853, 10777.730556736144, 11107.05590024857, 11505.309681419141, 12584.370781461073, 7565.82729676901, 8002.239787220437, 8111.9594402027615, 8244.134365891496, 8966.327525435749, 11218.495167717636, 11957.521699132285, 12374.752504950031, 12507.187032842836, 12561.87438125607], "value": 9156.530561104104, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1531.3032570180571, 1535.0175887432042, 1665.883388162829, 1821.5355084453463, 1832.569346203642, 7507.324340809326, 8045.557494337809, 8198.344132469403, 8714.389992700513, 8745.081766414522, 8192.95903520483, 8366.37252206084, 8426.789330266747, 8479.788005299855, 8515.489070655765, 2303.781140791622, 2336.836421450499, 2338.473843385233, 2347.3310106619615, 2353.7763912428377, 2304.7349554801244, 2314.8032417244553, 2316.444053427174, 2351.353377821096, 2357.964630530543, 2309.8614083155067, 2327.9185228517003, 2332.7200735911715, 2361.504084142332, 2377.9048838046456, 2272.1706577099403, 2275.7041584594062, 2279.8632082075046, 2290.0, 2300.1029598456616, 2232.944176395587, 2245.786650268222, 2254.718160229971, 2263.7962583367575, 2266.6826644269813, 8449.831003379897, 8469.0, 8524.445911015764, 8547.658093676246, 8548.529830859363, 5009.849704508834, 5152.510511501401, 5153.381594208681, 5162.561182299509, 5165.793368265265, 3113.8598763055716, 3125.46867032605, 3287.4575695010294, 3298.7855789373853, 3299.0597679661423, 1028.454918892988, 1071.8874518175635, 1074.648251706506, 1081.8214994525895, 1098.6703988803326, 11345.0, 11364.431778411046, 11370.772584548346, 11404.372759498225, 11415.657530274106, 4487.865364039084, 4498.842540511132, 4584.381108550369, 4611.262198048296, 4618.930716039262, 9652.131308182157, 9658.613655453844, 9681.854772178423, 9685.854712179324, 9706.854397184048, 5097.847064588068, 5156.535911767884, 5182.222666600041, 5194.662346947436, 5205.29728486657, 4253.829846806155, 4560.361549383089, 4677.953220467752, 4683.063387322549, 4785.760711964388, 3920.6079392060565, 3924.47019652349, 3947.9013024674614, 3970.8014599269923, 4071.2875246831686, 1272.0586765793432, 1291.3801375339701, 1294.4563283420987, 1309.0574786153954, 1322.4115268705525, 857.6826574167474, 915.5788337364753, 949.7483166960761, 961.8220629183623, 989.2234595842373, 5922.407759224129, 5958.493528050164, 5979.4917432018765, 6012.909806352908, 6022.939770602238, 1058.8200005999, 1102.9889701103048, 1105.3865104866716, 1124.7862906047824, 1140.7775483780583, 4100.220958017967, 4120.690948178899, 4180.1012782251355, 4197.034682023152, 4251.936220956688, 10218.948905255575, 10576.947115264375, 10677.0, 10690.144788416908, 10693.89306106929, 9925.454100024424, 10347.586096556053, 10377.896221037692, 10526.210534209966, 10631.893681063246, 7935.64289606969, 8035.196480352035, 8142.674293028331, 8145.470544414594, 8162.224588664068, 5872.706364681834, 6042.425969532887, 6054.728507013577, 6167.938320616916, 6180.289266734383, 9372.625094996123, 9647.517624118625, 9667.178289845442, 9671.806563868542, 9722.270829687943, 9656.37233579815, 9731.805363892541, 9753.02469753019, 9782.0, 9864.408135511892, 6976.476764242803, 7661.463697541119, 7700.075990881131, 7702.114256860533, 7839.333656639022, 8412.07467178622, 8489.066202717573, 8512.787180320542, 8548.529830859363, 8551.957240214007, 7375.446841486802, 7498.887516687145, 7602.163761986288, 7637.694492220249, 7731.961340193263, 7517.135529414188, 7575.734849280248, 7596.0, 7632.618369081412, 7707.730229441942, 6936.79189624312, 6938.722451101899, 6998.160220773336, 7017.228104908354, 7023.789286321418, 4988.650794444499, 5073.746312684277, 5103.464136265788, 5166.354205724285, 5296.788128474972, 5087.3386459759995, 5134.306868572844, 5152.072626927039, 5184.611154163377, 5331.360236771612], "value": 4582.422431769385, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [344.79140120227254, 347.7200853313083, 350.43929712460067, 354.8828886467468, 355.2805568723333, 5644.576656750744, 5723.742431590573, 5735.369109397968, 5742.741576629051, 5747.712614369286, 5585.413531579186, 5607.887842243153, 5623.606347555673, 5642.858928526789, 5644.57665675074, 3998.6601138903084, 4098.582205076537, 4370.409994650713, 4380.145871555048, 4390.134192967992, 4365.88254696472, 4368.97815510922, 4395.1868904252815, 4395.626371758404, 4427.203103441379, 4347.152305300468, 4358.716683415568, 4366.803493842769, 4376.956230437702, 4380.496242932056, 4123.463949686551, 4342.174986752539, 4357.629601483878, 4364.519902810688, 4395.296752519597, 3798.2783271178387, 3812.7140464465274, 3814.866479673226, 3820.9617903820886, 3829.1767270037076, 5419.485148910847, 5460.099083651193, 5460.890782184374, 5512.476314750093, 5513.7794488220425, 4934.481879402647, 4992.425871024842, 4994.650374473788, 5034.521720436553, 5096.974515127437, 5851.765929362863, 5865.85335366615, 5870.442307980735, 5878.382769809151, 5879.67661778602, 4219.789010549491, 4227.365895115727, 4235.449391579105, 4239.194553034913, 4239.258129827299, 5990.472429530485, 6013.458788709037, 6145.293291271516, 6185.505159587222, 6249.593776404519, 4312.137572485515, 4314.223439780807, 4315.395844581761, 4339.240632889232, 4357.4988876279, 4358.542353052884, 4376.468236117397, 4382.386465894777, 4388.113111362145, 4421.982943922916, 4957.132501812241, 5007.549320561167, 5034.093863104603, 5036.269740887551, 5062.797488100435, 5891.204687367151, 5934.732937017759, 5947.464728174398, 5980.790672326448, 6020.879582408327, 1485.3167542930373, 1506.472734542923, 1509.7735339699134, 1510.2599726134115, 1516.9393224271125, 929.934904556688, 966.5312323523086, 972.4457059476172, 973.4305431322614, 983.4001259231862, 5007.47421520735, 5037.672551284155, 5063.518965698253, 5103.795848166106, 5115.365586722841, 5329.387120481117, 5365.436629153961, 5430.212619170277, 5438.510534051875, 5499.3675727291875, 4895.290182923456, 5099.949000509948, 5135.871603209875, 5148.6910785353, 5164.715940623227, 2872.578073853456, 2873.468408344463, 2907.825530468179, 2922.4885645012037, 2923.327634644001, 5513.979913715975, 5527.115661494142, 5585.748641311151, 5598.244237027949, 5605.775768969277, 5245.763940622681, 5307.920381194285, 5419.756110975016, 5520.53075488588, 5557.694326812064, 5409.6213265071065, 5437.293151890308, 5449.836504904859, 5507.311586051824, 5513.814529876096, 5013.2981382607195, 5299.231611416246, 5320.866978325573, 5347.598930080338, 5372.140457526777, 5297.417284098823, 5321.563177941856, 5325.387580428145, 5353.785848566014, 5395.0, 5996.380977136236, 6179.258488981351, 6207.937920620917, 6343.270523889627, 6353.078803573549, 4318.762468064287, 4323.416338794348, 4357.433533640607, 4371.016521282686, 4376.299792033259, 5840.912386314294, 6155.261368635793, 6173.382661733791, 6220.222472190976, 6229.56393052482, 5878.617889837147, 5930.555208359304, 5959.97360897297, 5964.761409543569, 5979.162917191684, 5923.259592550931, 5923.963306421445, 5931.228940237742, 5949.077892926603, 5970.731317090655, 5590.5527557796095, 5808.593398462067, 5809.157672137601, 5827.446392592697, 5831.1836342912875, 5892.6759028253855, 5962.582619216613, 5972.313183983897, 6012.428819262163, 6026.035834266497, 5713.800016999385, 5843.853903652443, 5847.502962248086, 5866.560007999503, 5874.911876321944], "value": 4370.510865216707, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [770.8997830282062, 772.9381649468044, 773.7330620935778, 822.4284122534833, 848.7326492154971, 13933.721325573482, 14382.712345753078, 14680.265986700675, 14720.484783032596, 15577.143257120853, 13476.730465390687, 13548.051636385457, 13640.249786261751, 13647.727045459085, 13668.043236973415, 694.4166899804163, 822.8066404394963, 846.5936350551739, 847.6185716427632, 850.0904032684998, 856.2678909532353, 861.0614430271004, 865.3293697384546, 866.7356456280863, 868.0061329777401, 872.3980453487105, 875.1117615620151, 878.2052242720316, 886.450400751535, 887.4187407248263, 873.7422460374205, 874.2699845628907, 875.9343049271298, 879.2921698033081, 881.3125761905724, 646.1115965547373, 646.9676516174172, 647.6599785112807, 649.9480041596709, 651.5894986158737, 14644.853551464455, 14699.706005879929, 14732.042417242845, 14741.92629036848, 14771.778423323658, 14137.293135343294, 14231.715365692731, 14445.92777036108, 14645.853541464661, 14839.332230049673, 11522.423878806027, 11559.537618495335, 11687.32078294477, 11739.765204695943, 12049.638510844688, 3855.7108216883566, 3872.8644497442738, 3928.4892963914795, 4036.9596304036877, 4045.1505183911413, 53616.73191634017, 53766.73116634392, 55670.0, 55888.0, 56004.15993760056, 11321.886781132083, 11345.886541134483, 11444.198906076661, 11544.711382215512, 11606.651800446, 20437.48906277355, 20508.282210122576, 20655.8967205166, 20687.58624827495, 21031.68452473214, 8276.462029968034, 8347.874781878276, 8524.829503410021, 8536.70121545743, 8638.585151626337, 4684.063187362541, 4726.858194254178, 4761.857144285677, 4797.592204662573, 4885.5847252983895, 3346.6486018968144, 3436.0722604896537, 3437.432823584131, 3438.3639026780124, 3445.638207988125, 600.5885968111858, 605.2918085839578, 609.3053918532876, 609.5732986909181, 616.3528295289927, 619.4517851701277, 731.9048523691993, 736.2563810551275, 765.8698021336274, 768.6425811997448, 8942.150495702897, 9235.722928312027, 9327.766805829908, 9424.293178011676, 9424.963820909834, 713.0765658472291, 716.5163514627606, 722.1983598205987, 737.8302990312259, 746.6901235987114, 4100.794960251976, 4115.1975364804175, 4182.2681030819485, 4368.9296122450205, 4498.437695288089, 58610.41389586135, 59761.70119149376, 60236.0, 60863.39136608666, 63821.0, 54874.72562637161, 56650.0, 57660.135097973565, 58084.419155807904, 58539.41460585425, 50700.0, 50899.74550127226, 51052.74473627608, 51675.0, 51942.22086668703, 9349.0, 9407.623695052122, 9566.61733530651, 9615.759606009906, 9627.229821614394, 32290.83854580712, 32895.177620559676, 33035.33929321352, 33068.33863322672, 33348.33303333871, 41311.38032929569, 45084.77457612691, 45109.32336014897, 45618.0, 47637.0, 11650.592229271935, 12260.570880019157, 12345.753084938431, 12392.132550721362, 12445.25328480294, 13959.930200348934, 14397.568072957829, 14408.13551186932, 14507.637309066935, 14833.703325933637, 12548.121631485708, 12771.10602257833, 12892.548760793326, 13203.735925281633, 13328.666783330495, 12933.159344642569, 12993.48026078984, 13094.672633184247, 13295.800562991757, 13713.451461941411, 12564.120511564102, 12625.873741262838, 12643.367831608566, 12758.234505929673, 12853.421596028014, 10408.427536485264, 10649.201309901633, 10777.353358798497, 10797.514111865143, 10868.184886133413, 10399.792004159723, 10728.197789967331, 11187.21689481761, 11191.160662950475, 11234.213605047567], "value": 6878.388754413869, "unit": "score"}], "name": "dromaeo_css", "value": 7180.701033456759, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 113.0, 106.0, 111.0, 112.0, 113.0, 108.0, 110.0, 114.0, 111.0], "value": 110.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 127.0, 157.0, 217.0, 132.0, 154.0, 159.0, 127.0, 173.0, 134.0], "value": 153.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 161.0, 163.0, 166.0, 176.0, 162.0, 163.0, 162.0, 161.0], "value": 164.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 159.0, 76.0, 75.0, 74.0, 75.0, 188.0, 74.0], "value": 94.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 178.0, 90.0, 92.0, 92.0, 151.0, 94.0, 93.0, 155.0], "value": 113.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 118.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 148.0, 146.0, 147.0, 147.0, 147.0, 147.0, 146.0, 147.0], "value": 146.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 96.0, 95.0, 96.0, 95.0, 95.0, 96.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 61.0, 59.0, 59.0, 60.0, 61.0, 60.0, 115.0, 58.0, 57.0], "value": 64.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 60.0, 59.0, 60.0, 59.0, 59.0, 63.0, 65.0, 61.0], "value": 60.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 80.0, 80.0, 84.0, 80.0, 79.0, 83.0, 79.0, 80.0, 80.0], "value": 80.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 135.0, 129.0, 130.0, 124.0, 129.0, 121.0, 123.0, 212.0, 128.0], "value": 135.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 174.0, 170.0, 176.0, 174.0, 170.0, 173.0, 168.0, 171.0, 169.0], "value": 171.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 69.0, 64.0, 66.0, 64.0, 69.0, 65.0, 63.0, 67.0], "value": 66.0, "unit": "score"}], "name": "kraken", "value": 1574.3, "alertThreshold": 2.0}]} 17:24:46 INFO - Return code: 0 17:24:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 17:24:46 ERROR - # TBPL SUCCESS # 17:24:46 INFO - Running post-action listener: _resource_record_post_action 17:24:46 INFO - ##### 17:24:46 INFO - ##### Finished run-tests step (success) 17:24:46 INFO - ##### 17:24:46 INFO - Running post-run listener: _resource_record_post_run 17:24:47 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 77824; Write bytes: 361377792; Read time: 988; Write time: 737440 17:24:47 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 65536; Write bytes: 76451840; Read time: 668; Write time: 226776 17:24:47 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 12288; Write bytes: 282218496; Read time: 320; Write time: 510080 17:24:47 INFO - Running post-run listener: _upload_blobber_files 17:24:47 INFO - Blob upload gear active. 17:24:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:24:47 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 17:24:47 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'] 17:24:47 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 17:24:47 INFO - (blobuploader) - INFO - Open directory for files ... 17:24:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:24:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:24:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:24:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:24:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:24:49 INFO - (blobuploader) - INFO - Done attempting. 17:24:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:24:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:24:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:24:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:24:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:24:49 INFO - (blobuploader) - INFO - Done attempting. 17:24:49 INFO - (blobuploader) - INFO - Iteration through files over. 17:24:49 INFO - Return code: 0 17:24:49 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:24:49 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:24:49 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8c35847cdf66a7268c8f95b455954530e413f30c1bee2accdd1467e2037b3367848339c9e2934c4827934a0da104550d43081e1ccb8c5a6073ccd3fcbaeaa5f9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4f6eb274c4a2cb79d33babff68af9f39a6b400172738fdf969b0494d6b65584e0d806104f77603e8515996100aa171d120b53bf5adcc912e7b4a0ce75a646fda"} 17:24:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:24:49 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:24:49 INFO - Contents: 17:24:49 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8c35847cdf66a7268c8f95b455954530e413f30c1bee2accdd1467e2037b3367848339c9e2934c4827934a0da104550d43081e1ccb8c5a6073ccd3fcbaeaa5f9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4f6eb274c4a2cb79d33babff68af9f39a6b400172738fdf969b0494d6b65584e0d806104f77603e8515996100aa171d120b53bf5adcc912e7b4a0ce75a646fda"} 17:24:49 INFO - Running post-run listener: copy_logs_to_upload_dir 17:24:49 INFO - Copying logs to upload dir... 17:24:49 INFO - mkdir: /builds/slave/test/build/upload/logs 17:24:49 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.601066 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-05-11 17:24:49.778742) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-11 17:24:49.781970) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=df17445c3590ff7897617a0e00000225-1463002841.227289-1948646140 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/8c35847cdf66a7268c8f95b455954530e413f30c1bee2accdd1467e2037b3367848339c9e2934c4827934a0da104550d43081e1ccb8c5a6073ccd3fcbaeaa5f9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4f6eb274c4a2cb79d33babff68af9f39a6b400172738fdf969b0494d6b65584e0d806104f77603e8515996100aa171d120b53bf5adcc912e7b4a0ce75a646fda"} build_url:https://queue.taskcluster.net/v1/task/UFCJ5mh2SMawOCo7MluSyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011192 build_url: 'https://queue.taskcluster.net/v1/task/UFCJ5mh2SMawOCo7MluSyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8c35847cdf66a7268c8f95b455954530e413f30c1bee2accdd1467e2037b3367848339c9e2934c4827934a0da104550d43081e1ccb8c5a6073ccd3fcbaeaa5f9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4f6eb274c4a2cb79d33babff68af9f39a6b400172738fdf969b0494d6b65584e0d806104f77603e8515996100aa171d120b53bf5adcc912e7b4a0ce75a646fda"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-11 17:24:49.806583) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 17:24:49.806928) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=df17445c3590ff7897617a0e00000225-1463002841.227289-1948646140 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004579 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 17:24:49.889395) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-11 17:24:49.889722) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-11 17:24:49.890031) ========= ========= Total master_lag: 0.18 =========