builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-029 starttime: 1460775255.94 results: success (0) buildid: 20160415173001 builduid: c0811d795fc341f0a060638f98497c38 revision: 29782c3286ca0d496b16cd3a7a0edd0741641d99 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-15 19:54:15.944230) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-15 19:54:15.947518) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-15 19:54:15.947795) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-15 19:54:15.981555) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 19:54:15.981890) ========= 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=0274524eba3bdaad075c2247000001d4-1460767739.655611-647564653 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-15 19:54:16-- 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% 37.7M=0s 2016-04-15 19:54:16 (37.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.377216 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 19:54:16.372904) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 19:54:16.376259) ========= 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=0274524eba3bdaad075c2247000001d4-1460767739.655611-647564653 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014194 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 19:54:16.428987) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 19:54:16.429343) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 29782c3286ca0d496b16cd3a7a0edd0741641d99 --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 29782c3286ca0d496b16cd3a7a0edd0741641d99 --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=0274524eba3bdaad075c2247000001d4-1460767739.655611-647564653 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-15 19:54:16,696 truncating revision to first 12 chars 2016-04-15 19:54:16,696 Setting DEBUG logging. 2016-04-15 19:54:16,696 attempt 1/10 2016-04-15 19:54:16,696 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/29782c3286ca?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-15 19:54:16,950 unpacking tar archive at: fx-team-29782c3286ca/testing/mozharness/ program finished with exit code 0 elapsedTime=0.553402 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 19:54:16.995654) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-15 19:54:16.995994) ========= script_repo_revision: 29782c3286ca0d496b16cd3a7a0edd0741641d99 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-15 19:54:16.996382) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-15 19:54:16.996778) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-15 19:54:17.006586) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-04-15 19:54:17.006899) ========= /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=0274524eba3bdaad075c2247000001d4-1460767739.655611-647564653 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:54:17 INFO - MultiFileLogger online at 20160415 19:54:17 in /builds/slave/test 19:54:17 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 19:54:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:54:17 INFO - {'append_to_log': False, 19:54:17 INFO - 'base_work_dir': '/builds/slave/test', 19:54:17 INFO - 'blob_upload_branch': 'Fx-Team', 19:54:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:54:17 INFO - 'branch': 'Fx-Team', 19:54:17 INFO - 'buildbot_json_path': 'buildprops.json', 19:54:17 INFO - 'config_files': ('talos/linux_config.py',), 19:54:17 INFO - 'default_actions': ('clobber', 19:54:17 INFO - 'read-buildbot-config', 19:54:17 INFO - 'download-and-extract', 19:54:17 INFO - 'populate-webroot', 19:54:17 INFO - 'create-virtualenv', 19:54:17 INFO - 'install', 19:54:17 INFO - 'run-tests'), 19:54:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:54:17 INFO - 'download_minidump_stackwalk': True, 19:54:17 INFO - 'download_symbols': 'ondemand', 19:54:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:54:17 INFO - 'tooltool.py': '/tools/tooltool.py', 19:54:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:54:17 INFO - '/tools/misc-python/virtualenv.py')}, 19:54:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:54:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:54:17 INFO - 'installer_path': 'installer.exe', 19:54:17 INFO - 'log_level': 'info', 19:54:17 INFO - 'log_name': 'talos', 19:54:17 INFO - 'log_to_console': True, 19:54:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:54:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:54:17 INFO - 'opt_config_files': (), 19:54:17 INFO - 'pip_index': False, 19:54:17 INFO - 'sps_profile': False, 19:54:17 INFO - 'sps_profile_interval': 0, 19:54:17 INFO - 'suite': 'dromaeojs-e10s', 19:54:17 INFO - 'system_bits': '32', 19:54:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:54:17 INFO - 'title': 'talos-linux64-ix-029', 19:54:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:54:17 INFO - 'use_talos_json': True, 19:54:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:54:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:54:17 INFO - 'work_dir': 'build'} 19:54:17 INFO - ##### 19:54:17 INFO - ##### Running clobber step. 19:54:17 INFO - ##### 19:54:17 INFO - Running pre-action listener: _resource_record_pre_action 19:54:17 INFO - Running main action method: clobber 19:54:17 INFO - rmtree: /builds/slave/test/build 19:54:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:54:17 INFO - Running post-action listener: _resource_record_post_action 19:54:17 INFO - ##### 19:54:17 INFO - ##### Running read-buildbot-config step. 19:54:17 INFO - ##### 19:54:17 INFO - Running pre-action listener: _resource_record_pre_action 19:54:17 INFO - Running main action method: read_buildbot_config 19:54:17 INFO - Using buildbot properties: 19:54:17 INFO - { 19:54:17 INFO - "project": "", 19:54:17 INFO - "product": "firefox", 19:54:17 INFO - "script_repo_revision": "production", 19:54:17 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 19:54:17 INFO - "repository": "", 19:54:17 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 19:54:17 INFO - "buildid": "20160415173001", 19:54:17 INFO - "pgo_build": "True", 19:54:17 INFO - "basedir": "/builds/slave/test", 19:54:17 INFO - "buildnumber": 391, 19:54:17 INFO - "slavename": "talos-linux64-ix-029", 19:54:17 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 19:54:17 INFO - "platform": "ubuntu64_hw", 19:54:17 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 19:54:17 INFO - "branch": "fx-team", 19:54:17 INFO - "repo_path": "integration/fx-team", 19:54:17 INFO - "revision": "29782c3286ca0d496b16cd3a7a0edd0741641d99", 19:54:17 INFO - "stage_platform": "linux64-pgo", 19:54:17 INFO - "builduid": "c0811d795fc341f0a060638f98497c38", 19:54:17 INFO - "slavebuilddir": "test" 19:54:17 INFO - } 19:54:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/VZTDkKEnTuyduPyyDVXmtQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 19:54:17 INFO - Running post-action listener: _resource_record_post_action 19:54:17 INFO - ##### 19:54:17 INFO - ##### Running download-and-extract step. 19:54:17 INFO - ##### 19:54:17 INFO - Running pre-action listener: _resource_record_pre_action 19:54:17 INFO - Running main action method: download_and_extract 19:54:17 INFO - mkdir: /builds/slave/test/build/tests 19:54:17 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')]} 19:54:17 INFO - https://queue.taskcluster.net/v1/task/VZTDkKEnTuyduPyyDVXmtQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 19:54:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VZTDkKEnTuyduPyyDVXmtQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 19:54:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VZTDkKEnTuyduPyyDVXmtQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 19:54:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VZTDkKEnTuyduPyyDVXmtQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 19:54:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VZTDkKEnTuyduPyyDVXmtQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 19:54:20 INFO - Downloaded 1361 bytes. 19:54:20 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 19:54:20 INFO - Using the following test package requirements: 19:54:20 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 19:54:20 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 19:54:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:54:20 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 19:54:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 19:54:20 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 19:54:20 INFO - u'jsshell-linux-x86_64.zip'], 19:54:20 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 19:54:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:54:20 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 19:54:20 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 19:54:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:54:20 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 19:54:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:54:20 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 19:54:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:54:20 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 19:54:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:54:20 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:54: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')]} 19:54:20 INFO - https://queue.taskcluster.net/v1/task/VZTDkKEnTuyduPyyDVXmtQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:54:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VZTDkKEnTuyduPyyDVXmtQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 19:54:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VZTDkKEnTuyduPyyDVXmtQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 19:54:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VZTDkKEnTuyduPyyDVXmtQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 19:54:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VZTDkKEnTuyduPyyDVXmtQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:54:23 INFO - Downloaded 23774974 bytes. 19:54:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:54:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 19:54:24 INFO - Return code: 0 19:54:24 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 19:54:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:54:24 INFO - https://queue.taskcluster.net/v1/task/VZTDkKEnTuyduPyyDVXmtQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:54:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VZTDkKEnTuyduPyyDVXmtQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 19:54:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VZTDkKEnTuyduPyyDVXmtQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 19:54:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VZTDkKEnTuyduPyyDVXmtQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 19:54:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VZTDkKEnTuyduPyyDVXmtQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:54:32 INFO - Downloaded 23774974 bytes. 19:54:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:54:32 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 19:54:34 INFO - Return code: 0 19:54:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:54:34 INFO - https://queue.taskcluster.net/v1/task/VZTDkKEnTuyduPyyDVXmtQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:54:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VZTDkKEnTuyduPyyDVXmtQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 19:54:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VZTDkKEnTuyduPyyDVXmtQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 19:54:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VZTDkKEnTuyduPyyDVXmtQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 19:54:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VZTDkKEnTuyduPyyDVXmtQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 19:54:35 INFO - Downloaded 10841076 bytes. 19:54:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:54:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 19:54:35 INFO - Return code: 0 19:54:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:54:35 INFO - https://queue.taskcluster.net/v1/task/VZTDkKEnTuyduPyyDVXmtQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:54:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VZTDkKEnTuyduPyyDVXmtQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 19:54:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VZTDkKEnTuyduPyyDVXmtQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 19:54:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VZTDkKEnTuyduPyyDVXmtQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 19:54:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VZTDkKEnTuyduPyyDVXmtQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 19:54:36 INFO - Downloaded 58221203 bytes. 19:54:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VZTDkKEnTuyduPyyDVXmtQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 19:54:36 INFO - mkdir: /builds/slave/test/properties 19:54:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:54:36 INFO - Writing to file /builds/slave/test/properties/build_url 19:54:36 INFO - Contents: 19:54:36 INFO - build_url:https://queue.taskcluster.net/v1/task/VZTDkKEnTuyduPyyDVXmtQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 19:54:37 INFO - Running post-action listener: _resource_record_post_action 19:54:37 INFO - Running post-action listener: set_extra_try_arguments 19:54:37 INFO - ##### 19:54:37 INFO - ##### Running populate-webroot step. 19:54:37 INFO - ##### 19:54:37 INFO - Running pre-action listener: _resource_record_pre_action 19:54:37 INFO - Running main action method: populate_webroot 19:54:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:54:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:54:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:54:37 INFO - '--tppagecycles', 19:54:37 INFO - '7'], 19:54:37 INFO - 'tests': ['tsvgm']}}, 19:54:37 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:54:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:54:37 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:54:37 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:54:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:54:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:54:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:54:37 INFO - 'talos_options': ['--disable-e10s'], 19:54:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:54:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:54:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:54:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:54:37 INFO - 'talos_options': ['--disable-e10s'], 19:54:37 INFO - 'tests': ['damp', 'tps']}, 19:54:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:54:37 INFO - 'tests': ['damp', 'tps']}, 19:54:37 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:54:37 INFO - 'tests': ['dromaeo_dom']}, 19:54:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:54:37 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:54:37 INFO - 'tests': ['a11yr', 19:54:37 INFO - 'ts_paint', 19:54:37 INFO - 'tpaint', 19:54:37 INFO - 'sessionrestore', 19:54:37 INFO - 'sessionrestore_no_auto_restore', 19:54:37 INFO - 'tabpaint']}, 19:54:37 INFO - 'other-e10s': {'tests': ['a11yr', 19:54:37 INFO - 'ts_paint', 19:54:37 INFO - 'tpaint', 19:54:37 INFO - 'sessionrestore', 19:54:37 INFO - 'sessionrestore_no_auto_restore', 19:54:37 INFO - 'tabpaint']}, 19:54:37 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:54:37 INFO - 'ts_paint', 19:54:37 INFO - 'tpaint', 19:54:37 INFO - 'sessionrestore', 19:54:37 INFO - 'sessionrestore_no_auto_restore', 19:54:37 INFO - 'tabpaint']}, 19:54:37 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:54:37 INFO - 'ts_paint', 19:54:37 INFO - 'tpaint', 19:54:37 INFO - 'sessionrestore', 19:54:37 INFO - 'sessionrestore_no_auto_restore', 19:54:37 INFO - 'tabpaint']}, 19:54:37 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:54:37 INFO - 'tests': ['a11yr', 19:54:37 INFO - 'ts_paint', 19:54:37 INFO - 'tpaint', 19:54:37 INFO - 'sessionrestore', 19:54:37 INFO - 'sessionrestore_no_auto_restore', 19:54:37 INFO - 'tabpaint']}, 19:54:37 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:54:37 INFO - 'tests': ['a11yr', 19:54:37 INFO - 'ts_paint', 19:54:37 INFO - 'tpaint', 19:54:37 INFO - 'sessionrestore', 19:54:37 INFO - 'sessionrestore_no_auto_restore', 19:54:37 INFO - 'tabpaint']}, 19:54:37 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:54:37 INFO - 'tests': ['tsvgx', 19:54:37 INFO - 'tsvgr_opacity', 19:54:37 INFO - 'tart', 19:54:37 INFO - 'tscrollx', 19:54:37 INFO - 'cart']}, 19:54:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:54:37 INFO - 'tsvgr_opacity', 19:54:37 INFO - 'tart', 19:54:37 INFO - 'tscrollx', 19:54:37 INFO - 'cart']}, 19:54:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:54:37 INFO - 'talos_options': ['--disable-e10s'], 19:54:37 INFO - 'tests': ['tp5o']}, 19:54:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:54:37 INFO - 'tests': ['tp5o']}, 19:54:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:54:37 INFO - 'talos_options': ['--disable-e10s', 19:54:37 INFO - '--xperf_path', 19:54:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:54:37 INFO - 'tests': ['tp5n']}, 19:54:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:54:37 INFO - 'talos_options': ['--xperf_path', 19:54:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:54:37 INFO - 'tests': ['tp5n']}}, 19:54:37 INFO - 'talos.zip': {'path': '', 19:54:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:54:37 INFO - Running post-action listener: _resource_record_post_action 19:54:37 INFO - ##### 19:54:37 INFO - ##### Running create-virtualenv step. 19:54:37 INFO - ##### 19:54:37 INFO - Running pre-action listener: _resource_record_pre_action 19:54:37 INFO - Running main action method: create_virtualenv 19:54:37 INFO - Creating virtualenv /builds/slave/test/build/venv 19:54:37 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 19:54:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:54:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:54:37 INFO - Using real prefix '/usr' 19:54:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:54:38 INFO - Installing distribute.............................................................................................................................................................................................done. 19:54:40 INFO - Installing pip.................done. 19:54:40 INFO - Return code: 0 19:54:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:54:40 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')]} 19:54:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:54:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:54:40 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')]} 19:54:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:54:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:54:40 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 0x7f1b40726f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x275f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x282a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b9410>, '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 0x28ba310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28ba7a0>, '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': '0274524eba3bdaad075c2247000001d4-1460767739.655611-647564653', '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 19:54:40 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 19:54:40 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 19:54:40 INFO - Using env: {'DISPLAY': ':0', 19:54:40 INFO - 'HOME': '/home/cltbld', 19:54:40 INFO - 'LANG': 'en_US.UTF-8', 19:54:40 INFO - 'LANGUAGE': 'en_US:en', 19:54:40 INFO - 'LOGNAME': 'cltbld', 19:54:40 INFO - 'MAIL': '/var/mail/cltbld', 19:54:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:54:40 INFO - 'MOZ_NO_REMOTE': '1', 19:54:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:54:40 INFO - 'NO_EM_RESTART': '1', 19:54:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:54:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:54:40 INFO - 'PWD': '/builds/slave/test', 19:54:40 INFO - 'SHELL': '/bin/bash', 19:54:40 INFO - 'SHLVL': '1', 19:54:40 INFO - 'TERM': 'linux', 19:54:40 INFO - 'TMOUT': '86400', 19:54:40 INFO - 'USER': 'cltbld', 19:54:40 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1460767739.655611-647564653', 19:54:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:54:40 INFO - '_': '/tools/buildbot/bin/python'} 19:54:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:54:40 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 19:54:40 INFO - Cleaning up... 19:54:40 INFO - Return code: 0 19:54:40 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 19:54:40 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')]} 19:54:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:54:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:54:40 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')]} 19:54:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:54:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:54:40 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 0x7f1b40726f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x275f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x282a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b9410>, '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 0x28ba310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28ba7a0>, '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': '0274524eba3bdaad075c2247000001d4-1460767739.655611-647564653', '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 19:54:40 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 19:54:40 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 19:54:40 INFO - Using env: {'DISPLAY': ':0', 19:54:40 INFO - 'HOME': '/home/cltbld', 19:54:40 INFO - 'LANG': 'en_US.UTF-8', 19:54:40 INFO - 'LANGUAGE': 'en_US:en', 19:54:40 INFO - 'LOGNAME': 'cltbld', 19:54:40 INFO - 'MAIL': '/var/mail/cltbld', 19:54:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:54:40 INFO - 'MOZ_NO_REMOTE': '1', 19:54:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:54:40 INFO - 'NO_EM_RESTART': '1', 19:54:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:54:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:54:40 INFO - 'PWD': '/builds/slave/test', 19:54:40 INFO - 'SHELL': '/bin/bash', 19:54:40 INFO - 'SHLVL': '1', 19:54:40 INFO - 'TERM': 'linux', 19:54:40 INFO - 'TMOUT': '86400', 19:54:40 INFO - 'USER': 'cltbld', 19:54:40 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1460767739.655611-647564653', 19:54:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:54:40 INFO - '_': '/tools/buildbot/bin/python'} 19:54:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:54:40 INFO - Downloading/unpacking psutil>=0.7.1 19:54:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:54:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:54:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:54:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:54:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:54:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:54:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:54:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:54:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:54:42 INFO - Installing collected packages: psutil 19:54:42 INFO - Running setup.py install for psutil 19:54:42 INFO - building 'psutil._psutil_linux' extension 19:54:42 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 19:54:42 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 19:54:42 INFO - building 'psutil._psutil_posix' extension 19:54:42 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 19:54:43 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 19:54:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:54:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:54:43 INFO - Successfully installed psutil 19:54:43 INFO - Cleaning up... 19:54:43 INFO - Return code: 0 19:54:43 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 19:54:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:54:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:54:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:54:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:54:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:54:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:54:43 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 0x7f1b40726f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x275f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x282a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b9410>, '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 0x28ba310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28ba7a0>, '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': '0274524eba3bdaad075c2247000001d4-1460767739.655611-647564653', '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 19:54:43 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 19:54:43 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 19:54:43 INFO - Using env: {'DISPLAY': ':0', 19:54:43 INFO - 'HOME': '/home/cltbld', 19:54:43 INFO - 'LANG': 'en_US.UTF-8', 19:54:43 INFO - 'LANGUAGE': 'en_US:en', 19:54:43 INFO - 'LOGNAME': 'cltbld', 19:54:43 INFO - 'MAIL': '/var/mail/cltbld', 19:54:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:54:43 INFO - 'MOZ_NO_REMOTE': '1', 19:54:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:54:43 INFO - 'NO_EM_RESTART': '1', 19:54:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:54:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:54:43 INFO - 'PWD': '/builds/slave/test', 19:54:43 INFO - 'SHELL': '/bin/bash', 19:54:43 INFO - 'SHLVL': '1', 19:54:43 INFO - 'TERM': 'linux', 19:54:43 INFO - 'TMOUT': '86400', 19:54:43 INFO - 'USER': 'cltbld', 19:54:43 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1460767739.655611-647564653', 19:54:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:54:43 INFO - '_': '/tools/buildbot/bin/python'} 19:54:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:54:43 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 19:54: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 19:54: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 19:54: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 19:54: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 19:54: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 19:54: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 19:54:45 INFO - Downloading mozsystemmonitor-0.0.tar.gz 19:54:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:54:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 19:54:45 INFO - Installing collected packages: mozsystemmonitor 19:54:45 INFO - Running setup.py install for mozsystemmonitor 19:54:45 INFO - Successfully installed mozsystemmonitor 19:54:45 INFO - Cleaning up... 19:54:45 INFO - Return code: 0 19:54:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:54:45 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')]} 19:54:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:54:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:54:45 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')]} 19:54:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:54:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:54:45 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 0x7f1b40726f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x275f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x282a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b9410>, '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 0x28ba310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28ba7a0>, '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': '0274524eba3bdaad075c2247000001d4-1460767739.655611-647564653', '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 19:54:45 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 19:54:45 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 19:54:45 INFO - Using env: {'DISPLAY': ':0', 19:54:45 INFO - 'HOME': '/home/cltbld', 19:54:45 INFO - 'LANG': 'en_US.UTF-8', 19:54:45 INFO - 'LANGUAGE': 'en_US:en', 19:54:45 INFO - 'LOGNAME': 'cltbld', 19:54:45 INFO - 'MAIL': '/var/mail/cltbld', 19:54:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:54:45 INFO - 'MOZ_NO_REMOTE': '1', 19:54:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:54:45 INFO - 'NO_EM_RESTART': '1', 19:54:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:54:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:54:45 INFO - 'PWD': '/builds/slave/test', 19:54:45 INFO - 'SHELL': '/bin/bash', 19:54:45 INFO - 'SHLVL': '1', 19:54:45 INFO - 'TERM': 'linux', 19:54:45 INFO - 'TMOUT': '86400', 19:54:45 INFO - 'USER': 'cltbld', 19:54:45 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1460767739.655611-647564653', 19:54:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:54:45 INFO - '_': '/tools/buildbot/bin/python'} 19:54:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:54:45 INFO - Downloading/unpacking blobuploader==1.2.4 19:54:45 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 19:54:45 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 19:54:45 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 19:54:45 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 19:54:45 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 19:54:45 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 19:54:47 INFO - Downloading blobuploader-1.2.4.tar.gz 19:54:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:54:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:54:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:54:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:54:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:54:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:54:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:54:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:54:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:54:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:54:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:54:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:54:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:54:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:54:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:54:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:54:48 INFO - Downloading docopt-0.6.1.tar.gz 19:54:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:54:48 INFO - Installing collected packages: blobuploader, requests, docopt 19:54:48 INFO - Running setup.py install for blobuploader 19:54:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:54:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:54:48 INFO - Running setup.py install for requests 19:54:48 INFO - Running setup.py install for docopt 19:54:48 INFO - Successfully installed blobuploader requests docopt 19:54:48 INFO - Cleaning up... 19:54:48 INFO - Return code: 0 19:54:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:54:48 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')]} 19:54:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:54:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:54:48 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')]} 19:54:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:54:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:54:48 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 0x7f1b40726f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x275f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x282a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b9410>, '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 0x28ba310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28ba7a0>, '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': '0274524eba3bdaad075c2247000001d4-1460767739.655611-647564653', '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 19:54:48 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 19:54:48 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 19:54:48 INFO - Using env: {'DISPLAY': ':0', 19:54:48 INFO - 'HOME': '/home/cltbld', 19:54:48 INFO - 'LANG': 'en_US.UTF-8', 19:54:48 INFO - 'LANGUAGE': 'en_US:en', 19:54:48 INFO - 'LOGNAME': 'cltbld', 19:54:48 INFO - 'MAIL': '/var/mail/cltbld', 19:54:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:54:48 INFO - 'MOZ_NO_REMOTE': '1', 19:54:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:54:48 INFO - 'NO_EM_RESTART': '1', 19:54:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:54:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:54:48 INFO - 'PWD': '/builds/slave/test', 19:54:48 INFO - 'SHELL': '/bin/bash', 19:54:48 INFO - 'SHLVL': '1', 19:54:48 INFO - 'TERM': 'linux', 19:54:48 INFO - 'TMOUT': '86400', 19:54:48 INFO - 'USER': 'cltbld', 19:54:48 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1460767739.655611-647564653', 19:54:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:54:48 INFO - '_': '/tools/buildbot/bin/python'} 19:54:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:54:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:54:49 INFO - Running setup.py (path:/tmp/pip-fCnFbB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:54:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:54:49 INFO - Running setup.py (path:/tmp/pip-iK6XsW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:54:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:54:49 INFO - Running setup.py (path:/tmp/pip-QgWhQp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:54:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:54:49 INFO - Running setup.py (path:/tmp/pip-b7Bi4L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:54:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:54:49 INFO - Running setup.py (path:/tmp/pip-Px_OHS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:54:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:54:49 INFO - Running setup.py (path:/tmp/pip-dMATDn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:54:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:54:49 INFO - Running setup.py (path:/tmp/pip-Nnh1bq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:54:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:54:49 INFO - Running setup.py (path:/tmp/pip-FMtsbx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:54:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:54:49 INFO - Running setup.py (path:/tmp/pip-7or2KJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:54:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:54:49 INFO - Running setup.py (path:/tmp/pip-mUD2OG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:54:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:54:49 INFO - Running setup.py (path:/tmp/pip-25doMN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:54:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:54:49 INFO - Running setup.py (path:/tmp/pip-bjZQqw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:54:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:54:49 INFO - Running setup.py (path:/tmp/pip-Z_MPar-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:54:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:54:49 INFO - Running setup.py (path:/tmp/pip-ApuDZq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:54:50 INFO - Running setup.py (path:/tmp/pip-YjCTgL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:54:50 INFO - Running setup.py (path:/tmp/pip-jvY02S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:54:50 INFO - Running setup.py (path:/tmp/pip-Gqm1Fj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:54:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:54:50 INFO - Running setup.py install for manifestparser 19:54:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:54:50 INFO - Running setup.py install for mozcrash 19:54:50 INFO - Running setup.py install for mozdebug 19:54:50 INFO - Running setup.py install for mozdevice 19:54:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:54:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:54:50 INFO - Running setup.py install for mozfile 19:54:50 INFO - Running setup.py install for mozhttpd 19:54:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:54:50 INFO - Running setup.py install for mozinfo 19:54:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:54:50 INFO - Running setup.py install for mozInstall 19:54:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:54:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:54:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:54:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:54:51 INFO - Running setup.py install for mozleak 19:54:51 INFO - Running setup.py install for mozlog 19:54:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:54:51 INFO - Running setup.py install for moznetwork 19:54:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:54:51 INFO - Running setup.py install for mozprocess 19:54:51 INFO - Running setup.py install for mozprofile 19:54:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:54:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:54:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:54:51 INFO - Running setup.py install for mozrunner 19:54:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:54:51 INFO - Running setup.py install for mozscreenshot 19:54:51 INFO - Running setup.py install for moztest 19:54:51 INFO - Running setup.py install for mozversion 19:54:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:54:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:54:52 INFO - Cleaning up... 19:54:52 INFO - Return code: 0 19:54:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:54:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:54:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:54:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:54:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:54:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:54:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:54:52 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 0x7f1b40726f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x275f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x282a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b9410>, '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 0x28ba310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28ba7a0>, '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': '0274524eba3bdaad075c2247000001d4-1460767739.655611-647564653', '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 19:54:52 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 19:54:52 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 19:54:52 INFO - Using env: {'DISPLAY': ':0', 19:54:52 INFO - 'HOME': '/home/cltbld', 19:54:52 INFO - 'LANG': 'en_US.UTF-8', 19:54:52 INFO - 'LANGUAGE': 'en_US:en', 19:54:52 INFO - 'LOGNAME': 'cltbld', 19:54:52 INFO - 'MAIL': '/var/mail/cltbld', 19:54:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:54:52 INFO - 'MOZ_NO_REMOTE': '1', 19:54:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:54:52 INFO - 'NO_EM_RESTART': '1', 19:54:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:54:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:54:52 INFO - 'PWD': '/builds/slave/test', 19:54:52 INFO - 'SHELL': '/bin/bash', 19:54:52 INFO - 'SHLVL': '1', 19:54:52 INFO - 'TERM': 'linux', 19:54:52 INFO - 'TMOUT': '86400', 19:54:52 INFO - 'USER': 'cltbld', 19:54:52 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1460767739.655611-647564653', 19:54:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:54:52 INFO - '_': '/tools/buildbot/bin/python'} 19:54:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:54:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:54:52 INFO - Running setup.py (path:/tmp/pip-vQmVRJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:54:52 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)) 19:54:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:54:52 INFO - Running setup.py (path:/tmp/pip-EjBf6w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:54:52 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)) 19:54:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:54:52 INFO - Running setup.py (path:/tmp/pip-avmOdK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:54:52 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)) 19:54:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:54:52 INFO - Running setup.py (path:/tmp/pip-KiCmHB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:54:52 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)) 19:54:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:54:52 INFO - Running setup.py (path:/tmp/pip-58D_3V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:54:52 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)) 19:54:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:54:52 INFO - Running setup.py (path:/tmp/pip-NHupnm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:54:52 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)) 19:54:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:54:52 INFO - Running setup.py (path:/tmp/pip-DMFlyx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:54:52 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)) 19:54:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:54:52 INFO - Running setup.py (path:/tmp/pip-FbQqnm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:54:52 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)) 19:54:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:54:52 INFO - Running setup.py (path:/tmp/pip-R0yzqP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:54:52 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)) 19:54:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:54:52 INFO - Running setup.py (path:/tmp/pip-5gQZDY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:54:53 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)) 19:54:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:54:53 INFO - Running setup.py (path:/tmp/pip-waUDUK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:54:53 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)) 19:54:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:54:53 INFO - Running setup.py (path:/tmp/pip-9YhDFF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:54:53 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)) 19:54:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:54:53 INFO - Running setup.py (path:/tmp/pip-RWr0Oo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:54:53 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)) 19:54:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:54:53 INFO - Running setup.py (path:/tmp/pip-LxtcPm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:54:53 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)) 19:54:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:54:53 INFO - Running setup.py (path:/tmp/pip-9SAPaI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:54:53 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)) 19:54:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:54:53 INFO - Running setup.py (path:/tmp/pip-I9GdgY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:54:53 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)) 19:54:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:54:53 INFO - Running setup.py (path:/tmp/pip-3Tngn5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:54:53 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)) 19:54:53 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)) 19:54:53 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)) 19:54:53 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)) 19:54:53 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)) 19:54:53 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)) 19:54:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:54:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:54:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:54:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:54:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:54:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:54:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:54:55 INFO - Downloading blessings-1.6.tar.gz 19:54:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:54:55 INFO - Installing collected packages: blessings 19:54:55 INFO - Running setup.py install for blessings 19:54:55 INFO - Successfully installed blessings 19:54:55 INFO - Cleaning up... 19:54:55 INFO - Return code: 0 19:54:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:54:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:54:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:54:55 INFO - Reading from file tmpfile_stdout 19:54:55 INFO - Current package versions: 19:54:55 INFO - argparse == 1.2.1 19:54:55 INFO - blessings == 1.6 19:54:55 INFO - blobuploader == 1.2.4 19:54:55 INFO - docopt == 0.6.1 19:54:55 INFO - manifestparser == 1.1 19:54:55 INFO - mozInstall == 1.12 19:54:55 INFO - mozcrash == 0.17 19:54:55 INFO - mozdebug == 0.1 19:54:55 INFO - mozdevice == 0.48 19:54:55 INFO - mozfile == 1.2 19:54:55 INFO - mozhttpd == 0.7 19:54:55 INFO - mozinfo == 0.9 19:54:55 INFO - mozleak == 0.1 19:54:55 INFO - mozlog == 3.1 19:54:55 INFO - moznetwork == 0.27 19:54:55 INFO - mozprocess == 0.22 19:54:55 INFO - mozprofile == 0.28 19:54:55 INFO - mozrunner == 6.11 19:54:55 INFO - mozscreenshot == 0.1 19:54:55 INFO - mozsystemmonitor == 0.0 19:54:55 INFO - moztest == 0.7 19:54:55 INFO - mozversion == 1.4 19:54:55 INFO - psutil == 3.1.1 19:54:55 INFO - requests == 1.2.3 19:54:55 INFO - wsgiref == 0.1.2 19:54:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:54:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:54:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:54:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:54:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:54:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:54:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:54:55 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 0x7f1b40726f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x275f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x282a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b9410>, '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 0x28ba310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28ba7a0>, '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': '0274524eba3bdaad075c2247000001d4-1460767739.655611-647564653', '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 19:54:55 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 19:54:55 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 19:54:55 INFO - Using env: {'DISPLAY': ':0', 19:54:55 INFO - 'HOME': '/home/cltbld', 19:54:55 INFO - 'LANG': 'en_US.UTF-8', 19:54:55 INFO - 'LANGUAGE': 'en_US:en', 19:54:55 INFO - 'LOGNAME': 'cltbld', 19:54:55 INFO - 'MAIL': '/var/mail/cltbld', 19:54:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:54:55 INFO - 'MOZ_NO_REMOTE': '1', 19:54:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:54:55 INFO - 'NO_EM_RESTART': '1', 19:54:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:54:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:54:55 INFO - 'PWD': '/builds/slave/test', 19:54:55 INFO - 'SHELL': '/bin/bash', 19:54:55 INFO - 'SHLVL': '1', 19:54:55 INFO - 'TERM': 'linux', 19:54:55 INFO - 'TMOUT': '86400', 19:54:55 INFO - 'USER': 'cltbld', 19:54:55 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1460767739.655611-647564653', 19:54:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:54:55 INFO - '_': '/tools/buildbot/bin/python'} 19:54:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:54:56 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)) 19:54:56 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)) 19:54:56 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)) 19:54:56 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)) 19:54:56 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)) 19:54:56 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)) 19:54:56 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)) 19:54:56 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)) 19:54:56 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)) 19:54:56 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)) 19:54:56 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)) 19:54:56 INFO - Cleaning up... 19:54:56 INFO - Return code: 0 19:54:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:54:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:54:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:54:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:54:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:54:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:54:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:54:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1b40726f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x275f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x282a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b9410>, '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 0x28ba310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28ba7a0>, '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': '0274524eba3bdaad075c2247000001d4-1460767739.655611-647564653', '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 19:54:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 19:54:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 19:54:56 INFO - Using env: {'DISPLAY': ':0', 19:54:56 INFO - 'HOME': '/home/cltbld', 19:54:56 INFO - 'LANG': 'en_US.UTF-8', 19:54:56 INFO - 'LANGUAGE': 'en_US:en', 19:54:56 INFO - 'LOGNAME': 'cltbld', 19:54:56 INFO - 'MAIL': '/var/mail/cltbld', 19:54:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:54:56 INFO - 'MOZ_NO_REMOTE': '1', 19:54:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:54:56 INFO - 'NO_EM_RESTART': '1', 19:54:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:54:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:54:56 INFO - 'PWD': '/builds/slave/test', 19:54:56 INFO - 'SHELL': '/bin/bash', 19:54:56 INFO - 'SHLVL': '1', 19:54:56 INFO - 'TERM': 'linux', 19:54:56 INFO - 'TMOUT': '86400', 19:54:56 INFO - 'USER': 'cltbld', 19:54:56 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1460767739.655611-647564653', 19:54:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:54:56 INFO - '_': '/tools/buildbot/bin/python'} 19:54:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:54:56 INFO - Downloading/unpacking jsonschema 19:54:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:54:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:54:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:54:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:54:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:54:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:54:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:54:58 INFO - Downloading/unpacking functools32 (from jsonschema) 19:54:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:54:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:54:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:54:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:54:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:54:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:54:58 INFO - Downloading functools32-3.2.3-2.tar.gz 19:54:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:54:58 INFO - warning: no files found matching '*.txt' 19:54:58 INFO - no previously-included directories found matching 'build' 19:54:58 INFO - no previously-included directories found matching 'dist' 19:54:58 INFO - no previously-included directories found matching '.git*' 19:54:58 INFO - Installing collected packages: jsonschema, functools32 19:54:58 INFO - Running setup.py install for functools32 19:54:58 INFO - warning: no files found matching '*.txt' 19:54:58 INFO - no previously-included directories found matching 'build' 19:54:58 INFO - no previously-included directories found matching 'dist' 19:54:58 INFO - no previously-included directories found matching '.git*' 19:54:58 INFO - Successfully installed jsonschema functools32 19:54:58 INFO - Cleaning up... 19:54:58 INFO - Return code: 0 19:54:58 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 19:54:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:54:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:54:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:54:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:54:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:54:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:54:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1b40726f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x275f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x282a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b9410>, '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 0x28ba310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28ba7a0>, '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': '0274524eba3bdaad075c2247000001d4-1460767739.655611-647564653', '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 19:54:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 19:54:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 19:54:58 INFO - Using env: {'DISPLAY': ':0', 19:54:58 INFO - 'HOME': '/home/cltbld', 19:54:58 INFO - 'LANG': 'en_US.UTF-8', 19:54:58 INFO - 'LANGUAGE': 'en_US:en', 19:54:58 INFO - 'LOGNAME': 'cltbld', 19:54:58 INFO - 'MAIL': '/var/mail/cltbld', 19:54:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:54:58 INFO - 'MOZ_NO_REMOTE': '1', 19:54:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:54:58 INFO - 'NO_EM_RESTART': '1', 19:54:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:54:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:54:58 INFO - 'PWD': '/builds/slave/test', 19:54:58 INFO - 'SHELL': '/bin/bash', 19:54:58 INFO - 'SHLVL': '1', 19:54:58 INFO - 'TERM': 'linux', 19:54:58 INFO - 'TMOUT': '86400', 19:54:58 INFO - 'USER': 'cltbld', 19:54:58 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1460767739.655611-647564653', 19:54:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:54:58 INFO - '_': '/tools/buildbot/bin/python'} 19:54:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:54:58 INFO - Downloading/unpacking flake8 19:54:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:54:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:54:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:54:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:54:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:54:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:55:00 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:55:00 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:55:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:55:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:55:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:55:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:55:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:55:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:55:00 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:55:00 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:55:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:55:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:55:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:55:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:55:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:55:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:55:01 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:55:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:55:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:55:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:55:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:55:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:55:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:55:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 19:55:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:55:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:55:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:55:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:55:01 INFO - no previously-included directories found matching 'docs/_build' 19:55:01 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:55:01 INFO - Running setup.py install for pep8 19:55:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:55:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:55:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:55:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:55:01 INFO - no previously-included directories found matching 'docs/_build' 19:55:01 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 19:55:01 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:55:01 INFO - Cleaning up... 19:55:01 INFO - Return code: 0 19:55:01 INFO - Running post-action listener: _resource_record_post_action 19:55:01 INFO - Running post-action listener: _start_resource_monitoring 19:55:01 INFO - Starting resource monitoring. 19:55:01 INFO - ##### 19:55:01 INFO - ##### Running install step. 19:55:01 INFO - ##### 19:55:01 INFO - Running pre-action listener: _resource_record_pre_action 19:55:01 INFO - Running main action method: install 19:55:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:55:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:55:01 INFO - Reading from file tmpfile_stdout 19:55:01 INFO - Detecting whether we're running mozinstall >=1.0... 19:55:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:55:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:55:01 INFO - Reading from file tmpfile_stdout 19:55:01 INFO - Output received: 19:55:01 INFO - Usage: mozinstall [options] installer 19:55:01 INFO - Options: 19:55:01 INFO - -h, --help show this help message and exit 19:55:01 INFO - -d DEST, --destination=DEST 19:55:01 INFO - Directory to install application into. [default: 19:55:01 INFO - "/builds/slave/test"] 19:55:01 INFO - --app=APP Application being installed. [default: firefox] 19:55:01 INFO - mkdir: /builds/slave/test/build/application 19:55:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 19:55:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 19:55:18 INFO - Reading from file tmpfile_stdout 19:55:18 INFO - Output received: 19:55:18 INFO - /builds/slave/test/build/application/firefox/firefox 19:55:18 INFO - Running post-action listener: _resource_record_post_action 19:55:18 INFO - ##### 19:55:18 INFO - ##### Running run-tests step. 19:55:18 INFO - ##### 19:55:18 INFO - Running pre-action listener: _resource_record_pre_action 19:55:18 INFO - Running main action method: run_tests 19:55:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:55:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:55:18 INFO - Python 2.7.3 19:55:18 INFO - Return code: 0 19:55:18 INFO - grabbing minidump binary from tooltool 19:55: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')]} 19:55:18 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b9410>, '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 0x28ba310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28ba7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:55:18 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 19:55:18 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 19:55:18 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:55:18 INFO - Return code: 0 19:55:18 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:55:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:55:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:55:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:55:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:55:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 19:55:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 19:55:19 INFO - Return code: 0 19:55:19 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/VZTDkKEnTuyduPyyDVXmtQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--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 19:55:19 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/VZTDkKEnTuyduPyyDVXmtQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-029 --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 19:55:19 INFO - Using env: {'DISPLAY': ':0', 19:55:19 INFO - 'HOME': '/home/cltbld', 19:55:19 INFO - 'LANG': 'en_US.UTF-8', 19:55:19 INFO - 'LANGUAGE': 'en_US:en', 19:55:19 INFO - 'LOGNAME': 'cltbld', 19:55:19 INFO - 'MAIL': '/var/mail/cltbld', 19:55:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:55:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:55:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:55:19 INFO - 'MOZ_NO_REMOTE': '1', 19:55:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:55:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:55:19 INFO - 'NO_EM_RESTART': '1', 19:55:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:55:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:55:19 INFO - 'PWD': '/builds/slave/test', 19:55:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:55:19 INFO - 'SHELL': '/bin/bash', 19:55:19 INFO - 'SHLVL': '1', 19:55:19 INFO - 'TERM': 'linux', 19:55:19 INFO - 'TMOUT': '86400', 19:55:19 INFO - 'USER': 'cltbld', 19:55:19 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1460767739.655611-647564653', 19:55:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:55:19 INFO - '_': '/tools/buildbot/bin/python'} 19:55:19 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/VZTDkKEnTuyduPyyDVXmtQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--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 19:55:19 INFO - mozversion application_buildid: 20160415173001 19:55:19 INFO - mozversion application_changeset: 29782c3286ca0d496b16cd3a7a0edd0741641d99 19:55:19 INFO - mozversion application_display_name: Nightly 19:55:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:55:19 INFO - mozversion application_name: Firefox 19:55:19 INFO - mozversion application_remotingname: firefox 19:55:19 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 19:55:19 INFO - mozversion application_vendor: Mozilla 19:55:19 INFO - mozversion application_version: 48.0a1 19:55:19 INFO - mozversion platform_buildid: 20160415173001 19:55:19 INFO - mozversion platform_changeset: 29782c3286ca0d496b16cd3a7a0edd0741641d99 19:55:19 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 19:55:19 INFO - mozversion platform_version: 48.0a1 19:55:19 INFO - using testdate: 1460775319 19:55:19 INFO - actual date: 1460775319 19:55:19 INFO - starting webserver on 'localhost:60722' 19:55:19 INFO - SUITE-START | Running 2 tests 19:55:19 INFO - TEST-START | dromaeo_css 19:55:19 INFO - operating with platform_type : linux_ 19:55:19 INFO - Initialising browser for dromaeo_css test... 19:55:19 INFO - TEST-INFO | started process 13477 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_ufWY4/profile http://localhost:60722/getInfo.html) 19:55:23 INFO - PROCESS | 13477 | 19:55:23 INFO - PROCESS | 13477 | (process:13543): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:55:23 INFO - PROCESS | 13477 | JavaScript error: jar:file:///builds/slave/test/build/application/firefox/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 19:55:24 INFO - PROCESS | 13477 | __metrics Screen width/height:1600/1200 19:55:24 INFO - PROCESS | 13477 | colorDepth:24 19:55:24 INFO - PROCESS | 13477 | Browser inner width/height: 1024/697 19:55:24 INFO - PROCESS | 13477 | __metrics 19:55:24 ERROR - PROCESS | 13477 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 19:55:24 INFO - PROCESS | 13477 | [Parent 13477] WARNING: pipe error: Broken pipe: file /builds/slave/fx-team-l64-pgo-00000000000000/build/src/ipc/chromium/src/chrome/common/ipc_channel_posix.cc, line 652 19:55:25 INFO - TEST-INFO | 13477: exit 0 19:55:25 INFO - Browser initialized. 19:55:25 INFO - Running cycle 1/1 for dromaeo_css test... 19:55:25 INFO - TEST-INFO | started process 13594 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_ufWY4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:55:27 INFO - PROCESS | 13594 | 19:55:27 INFO - PROCESS | 13594 | (process:13653): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:55:37 INFO - PROCESS | 13594 | RSS: Main: 163606528 19:55:37 INFO - PROCESS | 13594 | 19:56:27 INFO - PROCESS | 13594 | 1460775387028 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] 19:58:34 INFO - PROCESS | 13594 | Cycle 1(1): loaded http://localhost:60722/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60722/tests/dromaeo/cssquery-ext.html) 19:58:35 INFO - PROCESS | 13594 | RSS: Main: 166952960 19:58:35 INFO - PROCESS | 13594 | 20:01:37 INFO - PROCESS | 13594 | Cycle 1(1): loaded http://localhost:60722/tests/dromaeo/cssquery-ext.html (next: http://localhost:60722/tests/dromaeo/cssquery-jquery.html) 20:01:37 INFO - PROCESS | 13594 | RSS: Main: 165408768 20:01:37 INFO - PROCESS | 13594 | 20:04:39 INFO - PROCESS | 13594 | Cycle 1(1): loaded http://localhost:60722/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60722/tests/dromaeo/cssquery-mootools.html) 20:04:40 INFO - PROCESS | 13594 | RSS: Main: 166240256 20:04:40 INFO - PROCESS | 13594 | 20:07:42 INFO - PROCESS | 13594 | Cycle 1(1): loaded http://localhost:60722/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60722/tests/dromaeo/cssquery-prototype.html) 20:07:42 INFO - PROCESS | 13594 | RSS: Main: 163557376 20:07:42 INFO - PROCESS | 13594 | 20:10:45 INFO - PROCESS | 13594 | Cycle 1(1): loaded http://localhost:60722/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60722/tests/dromaeo/cssquery-yui.html) 20:10:45 INFO - PROCESS | 13594 | RSS: Main: 165322752 20:10:45 INFO - PROCESS | 13594 | 20:13:47 INFO - PROCESS | 13594 | Cycle 1(1): loaded http://localhost:60722/tests/dromaeo/cssquery-yui.html (next: http://localhost:60722/tests/dromaeo/cssquery-dojo.html) 20:13:48 INFO - PROCESS | 13594 | RSS: Main: 167411712 20:13:48 INFO - PROCESS | 13594 | 20:13:48 INFO - PROCESS | 13594 | __start_tp_report 20:13:48 INFO - PROCESS | 13594 | _x_x_mozilla_page_load 20:13:48 INFO - PROCESS | 13594 | _x_x_mozilla_page_load_details 20:13:48 INFO - PROCESS | 13594 | |i|pagename|runs| 20:13:48 INFO - PROCESS | 13594 | |0;dojo.html;3110.4245714542812;3111.782175247733;3176.4282429162754;3192.042387283814;3199.856006479708;5462.153366228236;5466.535344495717;5467.917981230285;5495.203195536645;5496.835094947148;5288.920666190001;5389.434109418504;5436.945630543693;5447.264619276397;5559.972200139004;4918.311436398898;4965;5017.19724844025;5054.69671819692;5108.259302401149;660.731050309564;4913.901721965559;4984.476629953857;5004.149294619923;5018.498150184989;4971.676841005341;4984.352034235562;4991.126552853254;5004.799808007675;5019.472955339692;4935.235038569028;5070.31550740649;5073.644844860862;5089.236614507817;5095.464976177485;4858.295547145644;4873.731944743037;4881.243407271879;4881.585065269456;4925.21196608541;5228.79084836606;5259.0796610593;5279.894402111975;5296.179092240709;5338.786448542053;5731.856703582402;5735.283089613798;5749.59752817303;5872.677002764846;5921.61509501881;5818.069108942549;5859.267591551056;5860.824175274749;5875.324337701177;5906.291245050578;5415.377231618375;5469.234307196995;5473.75368108436;5474.315710536183;5489.286392768954;5917.704114794329;5922.496587790086;5981.551383646244;5988.880222395528;6011.068284415923;5741.425857414309;5761.164631128547;5767.596268261265;5777.45114214149;5783.2192653992015;5811.506021988178;5828.417158284223;5862.560307976919;5871.266091738533;5872.7357268923;5727.713614319351;5775.88448231033;5824.039033559416;5855.560832937546;5865.061590145556;5695.03184458643;5703.17303990919;5760.279965004374;5770.769169233267;5862.443067908542;4399.054203346296;4453.710508816981;4454.042380888124;4456.866294011184;4457.108578284357;3886.591907849692;3894.9415758763075;3903.746256493319;3913.5303763547986;3954.406838974119;5602.571344307175;5622.409646987089;5622.971885140548;5645.604807663506;5663.150527420919;5616.691081990448;5866.061430171152;5923.052311630118;5928.703564821742;5945.940540594539;5547.362053363834;5575.804846830422;5598.468145526169;5669.234653321749;5684.8294551163535;4955.132851750929;4979.502049794992;4979.701217926936;4992.425871024806;5000.799968001239;5909.438603332676;5931.703414829241;5944.762209511658;5980.85047873798;5997.880042399215;5865.384134665969;5872.588918775816;5878.29460464747;5879.441453062123;5907;5976.252968378953;6014.097885317237;6014.879702405839;6016.398360164124;6024.728887199999;5714.142878568248;5739.770409183753;5743.540516758566;5745.942540574708;5799.82600521985;5779.566532509994;5818.854528636818;5822.184894114743;5829.300483941955;5867.914435829385;5603.831885043455;5625.8593535161945;5632.662040277596;5650.237217975685;5659.943400566106;5589.524890384363;5629.6903670298525;5655.095184770417;5707.429257074259;5749.367569567261;5511.338639363302;5513.035218836607;5546.195801608825;5630.549556035589;5656.60403771732;5665.348484924287;5689.061304884648;5691.345495268097;5719;5757.36668966405;5481.862953426037;5577.721113944368;5585.050541407889;5600.635958662674;5672.801451949162 20:13:48 INFO - PROCESS | 13594 | |1;ext.html;605.207178596039;650.2229835346757;654.5777973207281;662.5329142954221;666.9766558170463;30539;37792;38358.808205959;38473.23053538931;38617;40109.59890401095;40822.18355632893;40838.18323633526;40872;41215.793921030425;8437.240648341649;8649.740507784776;8678.132186781302;8680.435771674822;8691.26124279437;8515.53164575948;8585.098564650716;8619;8682.43564168327;8840.734777956639;8814.779630509225;8829.690960816373;8869.95565022174;8883.73348799537;8918.108189181095;8761.605727742235;8768.60541275641;8820.603072861737;8824.249938755214;8858.73423797287;8721.12788721129;8777.912220877837;8814.823703525894;8822.206001459836;8836.469811811248;41012.38481422781;41400.378994315106;41514.58485415138;41690.37464438036;41727.7913610433;3443.4146195146886;3654.853805847763;3679;3907.8046097695;4309.5690430956965;32016.359672806648;32455.67544324574;32717.345653087043;32975.6702432975;33029.834850825835;4078.9592104078874;4122.958770412288;4125.422440858282;4169.97835530297;4196.685248606367;262148;262355;263182.9999999981;264937;265051;58917.70541147267;59596.10605840916;59714.701426493455;59766.103508447406;59825.700871496236;62246.377536224056;63578.364216357244;64820.35179648238;65279;65351;16381.836181638031;16556.089415082046;16568.420105296256;16593.419230327123;16596.83403165977;12804.551840685532;12833.358332083546;12870.67823304425;12871.613851584467;12887.35563221854;19115.818787607594;19211.23155073809;19283.22867085301;19378.903105484664;19748.70376944347;7039.788806335818;7124.323189297009;7169.7849064528145;7179.892301615376;7212.639368031578;1025.220832167558;1039.4335087377397;1126.5550107707409;1173.0263880978766;1197.239752756988;27201.047963321187;27409.31476713098;27501.174964751088;27963.860180699372;28020.579691304647;1082.6481393546972;1135.9659210223706;1148.2536351371675;1152.5159433038143;1222.7615614954998;14797.563060068904;14970.550883473514;15009.174495402858;15136.924315378352;15301;440974;445481;445694;446313;447405;55876;57243.71378143166;57370;57468;57486.13770793442;1389.305347326337;1411.5906387147818;1412.4915030589186;1417.7022825206823;1491.2543728135931;29262.414751705273;29437.411251775273;29784.55323170111;30171.396572068876;30728.385432291678;46458.767706161256;47227;47462;47652.761736192486;47699.52300476951;340047;340395;340904;426703;428821;28131.156065318075;28398.858005710666;28469.857650711612;28686.131386861147;28967;47332.52667473281;47723.04553908833;47764;47879.042419152116;47956.76021620009;39312.60687393204;39777.80111099542;40410.59589404186;40756.59243407528;41174.176516468906;39652.603473966046;39856.800715996236;40214.396784047676;40235;41246.38130427986;40178.39732403958;41094;41402;41527;42622.78688606661;38574;39113;41981.58018419899;42436.78781606072;43295.35056974085;33097.50353744744;33220.667793322726;33360.165995849326;33367.83316083501;34019.4897076549 20:13:48 INFO - PROCESS | 13594 | |2;jquery.html;382.4912865888368;384.23728898137193;390.55408634385424;396.2847061054796;404.1391835390618;17897.105144742774;18004.459866204;18448.723269150956;18481.72277415838;19261.325853595128;17868.55328616785;17936.910315448436;17984.190711417985;18988.62022759544;19443.319483818068;5474.534664553507;5475.4524547545325;5671.319441667006;5707.086866101425;5724.34170070441;5614.606977511576;5653;5655.971720141393;5661.60368774186;5671.6880571568545;5399.082156033483;5607.551395888339;5638.04153293939;5643.012472817261;5643.830685079454;5559.833205003856;5588.077967135418;5602.915956260639;5607.43925607438;5624.662520248778;4857.902841943177;4877.756112194376;4880.2435622478215;4986.10250154972;4997.950020499785;22091.558168836535;22165.889170554045;22215.555688886292;22738;22845.657315140284;2367.6448532720055;2373.6320870265135;2516.5721827289403;2634.6838379394403;2948.498755211619;13871.375788089561;14470.131792092508;14523.709525809425;14593.34329955144;14786.334614942245;1834.8899066056078;1908.7709474862966;1929.7394851695121;1947.1529884500287;1957.9510512237166;56647.43352566463;67258;75086.62456687736;77044;78552.21447785506;10199.13307368882;10319.896801031893;10520.684379468628;10572.629957951434;10626.73433164177;14655.34050967709;14789.630259243606;14817.925910370379;14870.628234294229;14934.402623894923;7668.578228197391;7894.210578942175;7917.485363451357;8004.359651227888;8021.679132834738;7404.074490688664;7485.588292643957;7592.468527203043;7598.404335089693;7625.504342217849;6485.475913160403;6495.253045899687;6524.119243902012;6541.640209788412;6570.704318305688;1931.5460866696314;1946.4647222013775;1951.8438524917972;1958.4222654317011;1961.5488437659133;972.9562169702381;1038.553422028535;1059.3780393526115;1071.566015763617;1141.8230174322994;18759.718604220947;18960.905195473933;19264.749214657095;19329.613407731766;19449;1061.9522121504551;1072.7371793910543;1094.108301734084;1104.2932523185168;1118.9888101119047;10643.84034239487;11107.38909359993;11198.216124871344;11208.775824483464;11217.102631789438;465764;473164;473258;483586;484829;74028.62985685145;75929;76313.6184319086;76918.6154069226;79139;1067.4449286371043;1071.9892801072046;1072.4852071005805;1073.640330489295;1077.2350634532204;16607.418740344514;16770.1614919256;16966;17038.403655871985;17222.91388543049;23702.88148559246;31817.36365272635;34637.30725385529;35963.820180898925;36280.27439451249;47878.521214787404;47946.280805788636;48130.27804583004;48165.75917120392;48190.03619927512;7400.148982866824;7853.960730196312;8002.799930001796;8422.199891010345;8597.398182127441;9398.483083430478;12895.935520322339;13005.739885202054;13016.804747928978;13390.397432115384;11500.25248358854;11660.12549058807;11670.649880503599;11680.591179308683;11769.705757355792;11250.212485125963;11398;11514.36670983104;11640.825387619023;11835.408229588314;12230.205036672587;12346.691332716753;12410.689732756753;12501.24992500453;12506.624801255977;7585.317321441097;7910.5649189295145;7960.4825686330205;8067;8145.592720364077;11472.254303470581;11569.132315076571;11607.129465290305;11649.41752912334;11828.76342473163 20:13:48 INFO - PROCESS | 13594 | |3;mootools.html;1487.9925600372;1510.6827566211095;1656.9751453728188;1787.8837875538097;1805.1425572852897;7353.080864891888;8013.759587212378;8168.877466837995;8454.112318206591;8480.83038339233;8086.231807978247;8098.959505202466;8110.188981101887;8123.903273058136;8191.549464779435;2234.6089434349005;2282.6233671444193;2282.9657555136687;2283.1666441748725;2290.828187885915;2222.51104756954;2238.3956331790487;2281.5208806150727;2300.1029598456616;2310.8151347892212;2206.316042026977;2208.6576580630026;2226.220822712054;2259.7062381890332;2278.943026424336;2222.288867562381;2228.2646726580188;2233.7877901599322;2240.1711366794307;2241.081156725751;2199.1423344895343;2199.6590528468114;2205.0077465140753;2208.9226877059227;2211.402921211264;8410.116937721512;8525.786855328604;8554.230119289294;8555.401121921468;8568.871466928002;4795.184818580849;4908.631852611068;4925.26121081837;4930.309756634074;4951.282064100686;3064.4790385634496;3087.984560077208;3179.2528755742383;3199.840007999591;3285.78642388244;1124.7581769919425;1139.0488941733663;1168.1180708565064;1169.5789515774316;1191.576990168495;11411.657650270505;11425.485853136628;11656.30062196271;11941.820872686916;11974.64076077719;4367.956320436755;4378.146261478981;4526.366308716782;4528.637708983273;4533.977330113328;9198.49408282551;9202.723918282461;9291.21024712907;9295;9300.11648893354;5012.273220383024;5050.217216331474;5061.772220250024;5063.392392912874;5073.847784566469;4041.6160464755803;4582.931256031162;4691.835785747482;4729.6689231754135;4758.7858546364805;3676.4485327201132;3695.371786796251;3717;3744.3260213161893;3785.772853628791;1115.8326251062406;1120.6301920366259;1129.5368898751472;1139.481535901163;1150.0282261489028;860.74177746677;1025.3489034463169;1026.7997740440542;1035.7928414317166;1046.0585473074143;5882.705864706748;5890.764369425175;5936.970315148396;6035.456808887221;6100.816975490742;399.12193175015085;400.50937601438005;401.65056400931377;404.08071637026;425.64671322802;4019.8191081400823;4205.915881682349;4221.535631080578;4228.9788551057045;4233.661307095425;9816.509174541245;9964.950175249078;10075.798484030278;10319.94840025795;10394.272400931863;9959.601615935426;10000.849987250198;10112.14046806015;10122.240831937634;10125.088742013108;7533.4349923755935;7685.961570192113;7869.685212591547;7886.171951944963;7991.600419978978;5893.32226793907;5941.257342832146;6005.918934591816;6070.7875224366935;6074.483668888194;9503.334766566273;9512.476813775309;9514.476703781358;9598.712038638852;9608.711738647851;9502.952485237529;9597.376170548892;9721.9027809721;9870.210383169186;9877.753056173653;6598.472122230306;7294.234105418855;7438.181800002104;7805.063392392949;8102.797430064295;8130.390220733587;8180;8200.794980125545;8208.630611622611;8228.50628962264;7085.787426377217;7377.963110184414;7408.111026676617;7419.740309089156;7497.175310715707;7167.850389362817;7512.774616761506;7536.472446928662;7537.886931695919;7636.885446718193;6601.273859875314;6608.1079054328975;6624.436922861611;6678.83302917431;6685.465162786868;4912.771807048238;5109.9233511498105;5116.923246151385;5206.479352064764;5234.528892399702;5136;5197.4282828889545;5207.635465517377;5218.843434696965;5260.9736951315 20:13:48 INFO - PROCESS | 13594 | |4;prototype.html;315.4589878358615;315.6338647169283;323.5454186867451;326.74024150800113;328.1451818014075;5884.264466941632;5902.173695682597;6013.458788709016;6078.908816367758;6122.724477398511;5775.27809023872;5883.8529036774;5920.851978700534;5933.970330148354;5969.1046343048565;4566.269396896489;4575.405197324343;4578.130155270488;4588.24293991491;4595.609373203265;4512.661550383718;4556.521565235652;4574.290984897346;4579.587837094661;4580.885477863047;4489.0023939347;4489.2817149256125;4521.389612402333;4522.3216517522305;4523.3441151033085;4514.164879497303;4545.909081818345;4546.97726511367;4547.8635640930825;4549.340345649895;3846.1730727893637;3981.3629819229072;3984.641382275609;3995.860144894915;3996.18078293949;5699.116636921284;5704.1443783432405;5725.227094342252;5742.97128514359;5782.10377391505;5232.659877107976;5238.81664141757;5253.264542963988;5255.1329030709885;5285.55072818807;6011.669358185298;6229.4426393401645;6258.405451482102;6263.185785847856;6271.592346497463;4352.499462561815;4372.540883207281;4384.561543845622;4391.516933137353;4421.314696222059;6332.588381755125;6503.772367967145;6559.147310849607;6570.967145164243;6587.176602924635;4479.865604031885;4501;4508.278675411984;4509.6843220974215;4519.367288579601;4543.068670922453;4553.749543775058;4561.361409402686;4568.314752787109;4571.588557029883;5177.418872140659;5255.237990491358;5262.71055091966;5269.947300526946;5277.894442111213;5939.673317967553;6105.236845394325;6179.28938172116;6262.1859158310035;6294.716737746812;1554.401555401156;1558.1819544739103;1566.9451569195023;1573.5122112145273;1575.5667191522423;1043.8173319669027;1045.268312181476;1046.9895301046893;1060.2790102730064;1064.1114669251263;6077.24034495688;6117.357677443893;6120;6121.510279177655;6121.663308518075;6405.615663060138;6434.74261029563;6465.838354041187;6495.902561461582;6505.414512693786;6013.5189184865985;6127.3566275540425;6142.815715528452;6145.201123853871;6156.353582873823;3474.6872781449792;3486.564179477565;3493.1441796759955;3503.8773642922883;3505.4040813061843;6517.250516190604;6690.0968369270495;6729.461643068543;6749.966250168816;6767.593944363354;6569.67151642416;6617.602943823386;6636.270010298863;6643.236027856762;6692.389967912518;6557.737690492327;6629.801105966829;6716.227633822173;6718.630475323806;6744.966275168593;6454.225492940877;6461.64460954652;6490;6498.350164983463;6527.15147030883;6320.083587879823;6329.284682911077;6367.299597044229;6369.681515924092;6416.358364163546;6649.700763465559;6668.233153187251;6675.365840245169;6681.732730690718;6689.297623749436;4436.223660859401;4445.1998640245065;4449.154660614473;4450.910981780411;4478.283474644041;6246.562740608296;6262.09199666055;6378.489720822416;6491.870162596816;6512.902306465312;6338.207724034496;6341.239051313872;6347;6353.4599559038;6365.745370185326;6162.815115546541;6300.684965751786;6321.178246828067;6331.366863313816;6358.364163583605;6208.161898143693;6218.626882387071;6225.8132256032395;6243.7814676486105;6262.2172228471445;6256.6214244309385;6310.6529140895855;6357.332480089524;6365.267994180728;6368.331325210786;6073.453389194994;6200.596961197508;6225.8132256032395;6227.314995350598;6233.75064997395 20:13:48 INFO - PROCESS | 13594 | |5;yui.html;780.0171783552726;786.4534148766606;810.8013536683511;814.672084502262;835.6114406800837;14225.43098276069;14654.926725366358;14658.560243192722;14675.192864392455;14683.33924973376;12673.936630316859;12959.93520032401;12965.351732413388;13012.869871301284;13099.214047157153;801.7594721583531;808.7412028150994;808.9635966381527;814.6904176412954;817.3216230528647;681.2744427185057;789.376392649806;812.6708682983401;813.0487329824091;815.4943934760457;845.3195177881803;845.7251393297172;847.516915358246;849.087231226431;851.0765819086299;846.8475674378609;849.6304107713164;849.9065102838683;850.3792231670853;851.1531026628544;616.9105479705418;620.2959640807716;621.3289647181034;623.1462895832739;624.0140577886928;14101.083429577046;14178.43286268548;14182.361793719307;14182.85817141836;14204.147751134966;13363.732725345535;13448.260345680983;13545.661358466019;13667.726645467035;13690.93154534221;10239.18086553074;10300.89699103007;10343;10460.581576736922;10594.682159535227;3626;3690.1697118148472;3694.556653201606;3698.130939229279;3731.2350968051483;51695.22457163146;52862.73568632132;54525.72737136289;54637.18044229379;54642.180367294524;10827;10940;11049.33703977764;11196.832047519294;11199.72000699989;18061.458156255332;18133.36533221331;19181.61636767257;19218.807811921703;19256.614867702847;8254.793630159294;8305.294050005696;8325.500469971821;8472.830543389098;8527.701530446404;4783.976080119647;4797.784099715521;4818.68678535894;4837.95162048382;5038.874028149326;3157.2896098377682;3249.4800831866787;3260.8858689945737;3278.4098862205033;3291.144302481372;600.7266693654377;604.1119554255238;612.6691586543305;642.0850288339099;646.7865604350553;561.469994265631;611.6085705148708;650.9707063182168;667.3526679121245;737.8893166025032;9013.143751343612;9293.67472138472;9432.625528857634;9444.244460443148;9459.952700236454;651.869626074787;711.5339452658517;718.2853061204136;721.8700633885951;765.8315170662445;4350.630196433339;4426.269665505156;4431.756253406029;4447.155040542287;4515.277555591089;66597;67513.3248667507;68590.65704671445;68615.65692171507;68707.65646171737;58604;59652;60221;60638.69680651568;60854;53591.73204133954;53957.46042539524;54240.45759542354;54380.18429723557;54536;8417.452865563719;8422.873656895274;8543.743687689379;8555.363970312468;8574.742757717278;33905.32189356248;34070.31859362749;34667;34975.65024349724;35056.47415288824;45139.32291015703;46769.766151170385;48464;48830.26754598613;49548.25677614911;11176.385298808644;11179.66461006171;11187.664370068911;11338.263012904135;11662.067034637379;11797.764044718886;11973.401329933295;12373.62879113628;12497.37513124322;12552.372381381078;11081.944590276997;11283.66149015531;11306.547738090714;11562.76874462523;11995.1003674723;11685.883141168479;11727.061835053346;11735.765284694087;12062.215955962834;12184.390780460764;11255.606053788406;11473.942630286796;11572.59495917639;11579;11658.53365865356;9241.122093401116;9317.86023209666;9343.813123737624;9467.952660236655;9658.517074146404;9609.099359326934;9913.65302214419;9993.900060999296;10055.245856560641;10062.195024398177 20:13:48 INFO - PROCESS | 13594 | __end_tp_report 20:13:48 INFO - PROCESS | 13594 | __start_cc_report 20:13:48 INFO - PROCESS | 13594 | _x_x_mozilla_cycle_collect,333 20:13:48 INFO - PROCESS | 13594 | __end_cc_report 20:13:48 INFO - PROCESS | 13594 | __startTimestamp1460776428203__endTimestamp 20:13:48 INFO - PROCESS | 13594 | 20:13:48 INFO - PROCESS | 13594 | ------- Summary: start ------- 20:13:48 INFO - PROCESS | 13594 | Number of tests: 6 20:13:48 INFO - PROCESS | 13594 | 20:13:48 INFO - PROCESS | 13594 | [#0] dojo.html Cycles:165 Average:5384.65 Median:5630.55 stddev:717.44 (12.7%) stddev-sans-first:697.10 20:13:48 INFO - PROCESS | 13594 | Values: 3110.4 3111.8 3176.4 3192.0 3199.9 5462.2 5466.5 5467.9 5495.2 5496.8 5288.9 5389.4 5436.9 5447.3 5560.0 4918.3 4965.0 5017.2 5054.7 5108.3 660.7 4913.9 4984.5 5004.1 5018.5 4971.7 4984.4 4991.1 5004.8 5019.5 4935.2 5070.3 5073.6 5089.2 5095.5 4858.3 4873.7 4881.2 4881.6 4925.2 5228.8 5259.1 5279.9 5296.2 5338.8 5731.9 5735.3 5749.6 5872.7 5921.6 5818.1 5859.3 5860.8 5875.3 5906.3 5415.4 5469.2 5473.8 5474.3 5489.3 5917.7 5922.5 5981.6 5988.9 6011.1 5741.4 5761.2 5767.6 5777.5 5783.2 5811.5 5828.4 5862.6 5871.3 5872.7 5727.7 5775.9 5824.0 5855.6 5865.1 5695.0 5703.2 5760.3 5770.8 5862.4 4399.1 4453.7 4454.0 4456.9 4457.1 3886.6 3894.9 3903.7 3913.5 3954.4 5602.6 5622.4 5623.0 5645.6 5663.2 5616.7 5866.1 5923.1 5928.7 5945.9 5547.4 5575.8 5598.5 5669.2 5684.8 4955.1 4979.5 4979.7 4992.4 5000.8 5909.4 5931.7 5944.8 5980.9 5997.9 5865.4 5872.6 5878.3 5879.4 5907.0 5976.3 6014.1 6014.9 6016.4 6024.7 5714.1 5739.8 5743.5 5745.9 5799.8 5779.6 5818.9 5822.2 5829.3 5867.9 5603.8 5625.9 5632.7 5650.2 5659.9 5589.5 5629.7 5655.1 5707.4 5749.4 5511.3 5513.0 5546.2 5630.5 5656.6 5665.3 5689.1 5691.3 5719.0 5757.4 5481.9 5577.7 5585.1 5600.6 5672.8 20:13:48 INFO - PROCESS | 13594 | 20:13:48 INFO - PROCESS | 13594 | [#1] ext.html Cycles:180 Average:53361.36 Median:40830.18 stddev:97578.01 (239.0%) stddev-sans-first:97771.34 20:13:48 INFO - PROCESS | 13594 | Values: 605.2 650.2 654.6 662.5 667.0 30539.0 37792.0 38358.8 38473.2 38617.0 40109.6 40822.2 40838.2 40872.0 41215.8 8437.2 8649.7 8678.1 8680.4 8691.3 8515.5 8585.1 8619.0 8682.4 8840.7 8814.8 8829.7 8870.0 8883.7 8918.1 8761.6 8768.6 8820.6 8824.2 8858.7 8721.1 8777.9 8814.8 8822.2 8836.5 41012.4 41400.4 41514.6 41690.4 41727.8 3443.4 3654.9 3679.0 3907.8 4309.6 32016.4 32455.7 32717.3 32975.7 33029.8 4079.0 4123.0 4125.4 4170.0 4196.7 262148.0 262355.0 263183.0 264937.0 265051.0 58917.7 59596.1 59714.7 59766.1 59825.7 62246.4 63578.4 64820.4 65279.0 65351.0 16381.8 16556.1 16568.4 16593.4 16596.8 12804.6 12833.4 12870.7 12871.6 12887.4 19115.8 19211.2 19283.2 19378.9 19748.7 7039.8 7124.3 7169.8 7179.9 7212.6 1025.2 1039.4 1126.6 1173.0 1197.2 27201.0 27409.3 27501.2 27963.9 28020.6 1082.6 1136.0 1148.3 1152.5 1222.8 14797.6 14970.6 15009.2 15136.9 15301.0 440974.0 445481.0 445694.0 446313.0 447405.0 55876.0 57243.7 57370.0 57468.0 57486.1 1389.3 1411.6 1412.5 1417.7 1491.3 29262.4 29437.4 29784.6 30171.4 30728.4 46458.8 47227.0 47462.0 47652.8 47699.5 340047.0 340395.0 340904.0 426703.0 428821.0 28131.2 28398.9 28469.9 28686.1 28967.0 47332.5 47723.0 47764.0 47879.0 47956.8 39312.6 39777.8 40410.6 40756.6 41174.2 39652.6 39856.8 40214.4 40235.0 41246.4 40178.4 41094.0 41402.0 41527.0 42622.8 38574.0 39113.0 41981.6 42436.8 43295.4 33097.5 33220.7 33360.2 33367.8 34019.5 20:13:48 INFO - PROCESS | 13594 | 20:13:48 INFO - PROCESS | 13594 | [#2] jquery.html Cycles:180 Average:27363.74 Median:22476.78 stddev:77995.76 (347.0%) stddev-sans-first:78188.24 20:13:48 INFO - PROCESS | 13594 | Values: 382.5 384.2 390.6 396.3 404.1 17897.1 18004.5 18448.7 18481.7 19261.3 17868.6 17936.9 17984.2 18988.6 19443.3 5474.5 5475.5 5671.3 5707.1 5724.3 5614.6 5653.0 5656.0 5661.6 5671.7 5399.1 5607.6 5638.0 5643.0 5643.8 5559.8 5588.1 5602.9 5607.4 5624.7 4857.9 4877.8 4880.2 4986.1 4998.0 22091.6 22165.9 22215.6 22738.0 22845.7 2367.6 2373.6 2516.6 2634.7 2948.5 13871.4 14470.1 14523.7 14593.3 14786.3 1834.9 1908.8 1929.7 1947.2 1958.0 56647.4 67258.0 75086.6 77044.0 78552.2 10199.1 10319.9 10520.7 10572.6 10626.7 14655.3 14789.6 14817.9 14870.6 14934.4 7668.6 7894.2 7917.5 8004.4 8021.7 7404.1 7485.6 7592.5 7598.4 7625.5 6485.5 6495.3 6524.1 6541.6 6570.7 1931.5 1946.5 1951.8 1958.4 1961.5 973.0 1038.6 1059.4 1071.6 1141.8 18759.7 18960.9 19264.7 19329.6 19449.0 1062.0 1072.7 1094.1 1104.3 1119.0 10643.8 11107.4 11198.2 11208.8 11217.1 465764.0 473164.0 473258.0 483586.0 484829.0 74028.6 75929.0 76313.6 76918.6 79139.0 1067.4 1072.0 1072.5 1073.6 1077.2 16607.4 16770.2 16966.0 17038.4 17222.9 23702.9 31817.4 34637.3 35963.8 36280.3 47878.5 47946.3 48130.3 48165.8 48190.0 7400.1 7854.0 8002.8 8422.2 8597.4 9398.5 12895.9 13005.7 13016.8 13390.4 11500.3 11660.1 11670.6 11680.6 11769.7 11250.2 11398.0 11514.4 11640.8 11835.4 12230.2 12346.7 12410.7 12501.2 12506.6 7585.3 7910.6 7960.5 8067.0 8145.6 11472.3 11569.1 11607.1 11649.4 11828.8 20:13:48 INFO - PROCESS | 13594 | 20:13:48 INFO - PROCESS | 13594 | [#3] mootools.html Cycles:180 Average:5525.77 Median:4940.80 stddev:3093.52 (62.6%) stddev-sans-first:3087.32 20:13:48 INFO - PROCESS | 13594 | Values: 1488.0 1510.7 1657.0 1787.9 1805.1 7353.1 8013.8 8168.9 8454.1 8480.8 8086.2 8099.0 8110.2 8123.9 8191.5 2234.6 2282.6 2283.0 2283.2 2290.8 2222.5 2238.4 2281.5 2300.1 2310.8 2206.3 2208.7 2226.2 2259.7 2278.9 2222.3 2228.3 2233.8 2240.2 2241.1 2199.1 2199.7 2205.0 2208.9 2211.4 8410.1 8525.8 8554.2 8555.4 8568.9 4795.2 4908.6 4925.3 4930.3 4951.3 3064.5 3088.0 3179.3 3199.8 3285.8 1124.8 1139.0 1168.1 1169.6 1191.6 11411.7 11425.5 11656.3 11941.8 11974.6 4368.0 4378.1 4526.4 4528.6 4534.0 9198.5 9202.7 9291.2 9295.0 9300.1 5012.3 5050.2 5061.8 5063.4 5073.8 4041.6 4582.9 4691.8 4729.7 4758.8 3676.4 3695.4 3717.0 3744.3 3785.8 1115.8 1120.6 1129.5 1139.5 1150.0 860.7 1025.3 1026.8 1035.8 1046.1 5882.7 5890.8 5937.0 6035.5 6100.8 399.1 400.5 401.7 404.1 425.6 4019.8 4205.9 4221.5 4229.0 4233.7 9816.5 9965.0 10075.8 10319.9 10394.3 9959.6 10000.8 10112.1 10122.2 10125.1 7533.4 7686.0 7869.7 7886.2 7991.6 5893.3 5941.3 6005.9 6070.8 6074.5 9503.3 9512.5 9514.5 9598.7 9608.7 9503.0 9597.4 9721.9 9870.2 9877.8 6598.5 7294.2 7438.2 7805.1 8102.8 8130.4 8180.0 8200.8 8208.6 8228.5 7085.8 7378.0 7408.1 7419.7 7497.2 7167.9 7512.8 7536.5 7537.9 7636.9 6601.3 6608.1 6624.4 6678.8 6685.5 4912.8 5109.9 5116.9 5206.5 5234.5 5136.0 5197.4 5207.6 5218.8 5261.0 20:13:48 INFO - PROCESS | 13594 | 20:13:48 INFO - PROCESS | 13594 | [#4] prototype.html Cycles:180 Average:5263.10 Median:6043.49 stddev:1582.14 (26.2%) stddev-sans-first:1542.39 20:13:48 INFO - PROCESS | 13594 | Values: 315.5 315.6 323.5 326.7 328.1 5884.3 5902.2 6013.5 6078.9 6122.7 5775.3 5883.9 5920.9 5934.0 5969.1 4566.3 4575.4 4578.1 4588.2 4595.6 4512.7 4556.5 4574.3 4579.6 4580.9 4489.0 4489.3 4521.4 4522.3 4523.3 4514.2 4545.9 4547.0 4547.9 4549.3 3846.2 3981.4 3984.6 3995.9 3996.2 5699.1 5704.1 5725.2 5743.0 5782.1 5232.7 5238.8 5253.3 5255.1 5285.6 6011.7 6229.4 6258.4 6263.2 6271.6 4352.5 4372.5 4384.6 4391.5 4421.3 6332.6 6503.8 6559.1 6571.0 6587.2 4479.9 4501.0 4508.3 4509.7 4519.4 4543.1 4553.7 4561.4 4568.3 4571.6 5177.4 5255.2 5262.7 5269.9 5277.9 5939.7 6105.2 6179.3 6262.2 6294.7 1554.4 1558.2 1566.9 1573.5 1575.6 1043.8 1045.3 1047.0 1060.3 1064.1 6077.2 6117.4 6120.0 6121.5 6121.7 6405.6 6434.7 6465.8 6495.9 6505.4 6013.5 6127.4 6142.8 6145.2 6156.4 3474.7 3486.6 3493.1 3503.9 3505.4 6517.3 6690.1 6729.5 6750.0 6767.6 6569.7 6617.6 6636.3 6643.2 6692.4 6557.7 6629.8 6716.2 6718.6 6745.0 6454.2 6461.6 6490.0 6498.4 6527.2 6320.1 6329.3 6367.3 6369.7 6416.4 6649.7 6668.2 6675.4 6681.7 6689.3 4436.2 4445.2 4449.2 4450.9 4478.3 6246.6 6262.1 6378.5 6491.9 6512.9 6338.2 6341.2 6347.0 6353.5 6365.7 6162.8 6300.7 6321.2 6331.4 6358.4 6208.2 6218.6 6225.8 6243.8 6262.2 6256.6 6310.7 6357.3 6365.3 6368.3 6073.5 6200.6 6225.8 6227.3 6233.8 20:13:48 INFO - PROCESS | 13594 | 20:13:48 INFO - PROCESS | 13594 | [#5] yui.html Cycles:180 Average:15010.51 Median:27293.57 stddev:18248.31 (66.9%) stddev-sans-first:18268.21 20:13:48 INFO - PROCESS | 13594 | Values: 780.0 786.5 810.8 814.7 835.6 14225.4 14654.9 14658.6 14675.2 14683.3 12673.9 12959.9 12965.4 13012.9 13099.2 801.8 808.7 809.0 814.7 817.3 681.3 789.4 812.7 813.0 815.5 845.3 845.7 847.5 849.1 851.1 846.8 849.6 849.9 850.4 851.2 616.9 620.3 621.3 623.1 624.0 14101.1 14178.4 14182.4 14182.9 14204.1 13363.7 13448.3 13545.7 13667.7 13690.9 10239.2 10300.9 10343.0 10460.6 10594.7 3626.0 3690.2 3694.6 3698.1 3731.2 51695.2 52862.7 54525.7 54637.2 54642.2 10827.0 10940.0 11049.3 11196.8 11199.7 18061.5 18133.4 19181.6 19218.8 19256.6 8254.8 8305.3 8325.5 8472.8 8527.7 4784.0 4797.8 4818.7 4838.0 5038.9 3157.3 3249.5 3260.9 3278.4 3291.1 600.7 604.1 612.7 642.1 646.8 561.5 611.6 651.0 667.4 737.9 9013.1 9293.7 9432.6 9444.2 9460.0 651.9 711.5 718.3 721.9 765.8 4350.6 4426.3 4431.8 4447.2 4515.3 66597.0 67513.3 68590.7 68615.7 68707.7 58604.0 59652.0 60221.0 60638.7 60854.0 53591.7 53957.5 54240.5 54380.2 54536.0 8417.5 8422.9 8543.7 8555.4 8574.7 33905.3 34070.3 34667.0 34975.7 35056.5 45139.3 46769.8 48464.0 48830.3 49548.3 11176.4 11179.7 11187.7 11338.3 11662.1 11797.8 11973.4 12373.6 12497.4 12552.4 11081.9 11283.7 11306.5 11562.8 11995.1 11685.9 11727.1 11735.8 12062.2 12184.4 11255.6 11473.9 11572.6 11579.0 11658.5 9241.1 9317.9 9343.8 9468.0 9658.5 9609.1 9913.7 9993.9 10055.2 10062.2 20:13:48 INFO - PROCESS | 13594 | -------- Summary: end -------- 20:13:48 INFO - PROCESS | 13594 | 20:13:48 INFO - TEST-INFO | 13594: exit 0 20:13:48 INFO - TEST-OK | dromaeo_css | took 1109118ms 20:13:48 INFO - TEST-START | kraken 20:13:48 INFO - operating with platform_type : linux_ 20:13:48 INFO - Initialising browser for kraken test... 20:13:48 INFO - TEST-INFO | started process 13824 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRguzBU/profile http://localhost:60722/getInfo.html) 20:13:52 INFO - PROCESS | 13824 | 20:13:52 INFO - PROCESS | 13824 | (process:13894): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 20:13:52 INFO - PROCESS | 13824 | JavaScript error: jar:file:///builds/slave/test/build/application/firefox/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 20:13:52 INFO - PROCESS | 13824 | __metrics Screen width/height:1600/1200 20:13:52 INFO - PROCESS | 13824 | colorDepth:24 20:13:52 INFO - PROCESS | 13824 | Browser inner width/height: 1024/697 20:13:52 INFO - PROCESS | 13824 | __metrics 20:13:53 ERROR - PROCESS | 13824 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 20:13:54 INFO - TEST-INFO | 13824: exit 0 20:13:54 INFO - Browser initialized. 20:13:54 INFO - Running cycle 1/1 for kraken test... 20:13:54 INFO - TEST-INFO | started process 13945 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRguzBU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:13:56 INFO - PROCESS | 13945 | 20:13:56 INFO - PROCESS | 13945 | (process:14003): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 20:14:06 INFO - PROCESS | 13945 | RSS: Main: 163344384 20:14:06 INFO - PROCESS | 13945 | 20:14:08 INFO - PROCESS | 13945 | Cycle 1(1): loaded http://localhost:60722/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60722/tests/kraken/driver.html?testName=audio-beat-detection) 20:14:09 INFO - PROCESS | 13945 | RSS: Main: 167682048 20:14:09 INFO - PROCESS | 13945 | 20:14:12 INFO - PROCESS | 13945 | Cycle 1(1): loaded http://localhost:60722/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60722/tests/kraken/driver.html?testName=audio-dft) 20:14:12 INFO - PROCESS | 13945 | RSS: Main: 171765760 20:14:12 INFO - PROCESS | 13945 | 20:14:15 INFO - PROCESS | 13945 | Cycle 1(1): loaded http://localhost:60722/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60722/tests/kraken/driver.html?testName=audio-fft) 20:14:16 INFO - PROCESS | 13945 | RSS: Main: 162148352 20:14:16 INFO - PROCESS | 13945 | 20:14:18 INFO - PROCESS | 13945 | Cycle 1(1): loaded http://localhost:60722/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60722/tests/kraken/driver.html?testName=audio-oscillator) 20:14:19 INFO - PROCESS | 13945 | RSS: Main: 162557952 20:14:19 INFO - PROCESS | 13945 | 20:14:21 INFO - PROCESS | 13945 | Cycle 1(1): loaded http://localhost:60722/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60722/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:14:22 INFO - PROCESS | 13945 | RSS: Main: 163553280 20:14:22 INFO - PROCESS | 13945 | 20:14:25 INFO - PROCESS | 13945 | Cycle 1(1): loaded http://localhost:60722/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60722/tests/kraken/driver.html?testName=imaging-darkroom) 20:14:25 INFO - PROCESS | 13945 | RSS: Main: 163307520 20:14:25 INFO - PROCESS | 13945 | 20:14:29 INFO - PROCESS | 13945 | Cycle 1(1): loaded http://localhost:60722/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60722/tests/kraken/driver.html?testName=imaging-desaturate) 20:14:29 INFO - PROCESS | 13945 | RSS: Main: 165588992 20:14:29 INFO - PROCESS | 13945 | 20:14:32 INFO - PROCESS | 13945 | Cycle 1(1): loaded http://localhost:60722/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60722/tests/kraken/driver.html?testName=json-parse-financial) 20:14:33 INFO - PROCESS | 13945 | RSS: Main: 166281216 20:14:33 INFO - PROCESS | 13945 | 20:14:34 INFO - PROCESS | 13945 | Cycle 1(1): loaded http://localhost:60722/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60722/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:14:35 INFO - PROCESS | 13945 | RSS: Main: 166031360 20:14:35 INFO - PROCESS | 13945 | 20:14:37 INFO - PROCESS | 13945 | Cycle 1(1): loaded http://localhost:60722/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60722/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:14:37 INFO - PROCESS | 13945 | RSS: Main: 166326272 20:14:37 INFO - PROCESS | 13945 | 20:14:39 INFO - PROCESS | 13945 | Cycle 1(1): loaded http://localhost:60722/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60722/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:14:40 INFO - PROCESS | 13945 | RSS: Main: 166305792 20:14:40 INFO - PROCESS | 13945 | 20:14:43 INFO - PROCESS | 13945 | Cycle 1(1): loaded http://localhost:60722/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60722/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:14:43 INFO - PROCESS | 13945 | RSS: Main: 167006208 20:14:43 INFO - PROCESS | 13945 | 20:14:46 INFO - PROCESS | 13945 | Cycle 1(1): loaded http://localhost:60722/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60722/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:14:47 INFO - PROCESS | 13945 | RSS: Main: 166957056 20:14:47 INFO - PROCESS | 13945 | 20:14:48 INFO - PROCESS | 13945 | Cycle 1(1): loaded http://localhost:60722/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60722/tests/kraken/driver.html?testName=ai-astar) 20:14:49 INFO - PROCESS | 13945 | RSS: Main: 168583168 20:14:49 INFO - PROCESS | 13945 | 20:14:49 INFO - PROCESS | 13945 | __start_tp_report 20:14:49 INFO - PROCESS | 13945 | _x_x_mozilla_page_load 20:14:49 INFO - PROCESS | 13945 | _x_x_mozilla_page_load_details 20:14:49 INFO - PROCESS | 13945 | |i|pagename|runs| 20:14:49 INFO - PROCESS | 13945 | |0;ai-astar;114;106;112;111;111;126;111;112;111;112 20:14:49 INFO - PROCESS | 13945 | |1;audio-beat-detection;161;127;157;183;128;156;160;127;189;130 20:14:49 INFO - PROCESS | 13945 | |2;audio-dft;165;163;162;161;161;165;172;164;166;162 20:14:49 INFO - PROCESS | 13945 | |3;audio-fft;75;75;76;161;73;77;73;76;164;77 20:14:49 INFO - PROCESS | 13945 | |4;audio-oscillator;91;91;143;92;92;92;142;92;93;152 20:14:49 INFO - PROCESS | 13945 | |5;imaging-gaussian-blur;119;118;118;117;117;117;117;117;117;117 20:14:49 INFO - PROCESS | 13945 | |6;imaging-darkroom;146;148;146;146;151;150;147;146;146;147 20:14:49 INFO - PROCESS | 13945 | |7;imaging-desaturate;97;94;95;95;95;95;95;95;96;95 20:14:49 INFO - PROCESS | 13945 | |8;json-parse-financial;58;57;59;58;60;59;57;76;55;58 20:14:49 INFO - PROCESS | 13945 | |9;json-stringify-tinderbox;61;61;61;61;61;61;61;60;61;62 20:14:49 INFO - PROCESS | 13945 | |10;stanford-crypto-aes;84;84;76;77;79;85;76;77;78;78 20:14:49 INFO - PROCESS | 13945 | |11;stanford-crypto-ccm;125;123;125;130;125;122;127;129;159;127 20:14:49 INFO - PROCESS | 13945 | |12;stanford-crypto-pbkdf2;164;163;163;167;165;171;165;164;170;164 20:14:49 INFO - PROCESS | 13945 | |13;stanford-crypto-sha256-iterative;68;70;72;70;70;70;68;76;70;69 20:14:49 INFO - PROCESS | 13945 | __end_tp_report 20:14:49 INFO - PROCESS | 13945 | __start_cc_report 20:14:49 INFO - PROCESS | 13945 | _x_x_mozilla_cycle_collect,821 20:14:49 INFO - PROCESS | 13945 | __end_cc_report 20:14:49 INFO - PROCESS | 13945 | __startTimestamp1460776489091__endTimestamp 20:14:49 INFO - PROCESS | 13945 | 20:14:49 INFO - PROCESS | 13945 | ------- Summary: start ------- 20:14:49 INFO - PROCESS | 13945 | Number of tests: 14 20:14:49 INFO - PROCESS | 13945 | 20:14:49 INFO - PROCESS | 13945 | [#0] ai-astar Cycles:10 Average:112.60 Median:112.00 stddev:5.13 (4.6%) stddev-sans-first:5.41 20:14:49 INFO - PROCESS | 13945 | Values: 114.0 106.0 112.0 111.0 111.0 126.0 111.0 112.0 111.0 112.0 20:14:49 INFO - PROCESS | 13945 | 20:14:49 INFO - PROCESS | 13945 | [#1] audio-beat-detection Cycles:10 Average:151.80 Median:158.50 stddev:23.16 (14.6%) stddev-sans-first:24.32 20:14:49 INFO - PROCESS | 13945 | Values: 161.0 127.0 157.0 183.0 128.0 156.0 160.0 127.0 189.0 130.0 20:14:49 INFO - PROCESS | 13945 | 20:14:49 INFO - PROCESS | 13945 | [#2] audio-dft Cycles:10 Average:164.10 Median:164.50 stddev:3.28 (2.0%) stddev-sans-first:3.46 20:14:49 INFO - PROCESS | 13945 | Values: 165.0 163.0 162.0 161.0 161.0 165.0 172.0 164.0 166.0 162.0 20:14:49 INFO - PROCESS | 13945 | 20:14:49 INFO - PROCESS | 13945 | [#3] audio-fft Cycles:10 Average:92.70 Median:75.50 stddev:36.82 (48.8%) stddev-sans-first:38.49 20:14:49 INFO - PROCESS | 13945 | Values: 75.0 75.0 76.0 161.0 73.0 77.0 73.0 76.0 164.0 77.0 20:14:49 INFO - PROCESS | 13945 | 20:14:49 INFO - PROCESS | 13945 | [#4] audio-oscillator Cycles:10 Average:108.00 Median:92.00 stddev:26.13 (28.4%) stddev-sans-first:26.98 20:14:49 INFO - PROCESS | 13945 | Values: 91.0 91.0 143.0 92.0 92.0 92.0 142.0 92.0 93.0 152.0 20:14:49 INFO - PROCESS | 13945 | 20:14:49 INFO - PROCESS | 13945 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.00 stddev:0.70 (0.6%) stddev-sans-first:0.44 20:14:49 INFO - PROCESS | 13945 | Values: 119.0 118.0 118.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 20:14:49 INFO - PROCESS | 13945 | 20:14:49 INFO - PROCESS | 13945 | [#6] imaging-darkroom Cycles:10 Average:147.30 Median:147.00 stddev:1.83 (1.2%) stddev-sans-first:1.88 20:14:49 INFO - PROCESS | 13945 | Values: 146.0 148.0 146.0 146.0 151.0 150.0 147.0 146.0 146.0 147.0 20:14:49 INFO - PROCESS | 13945 | 20:14:49 INFO - PROCESS | 13945 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.79 (0.8%) stddev-sans-first:0.50 20:14:49 INFO - PROCESS | 13945 | Values: 97.0 94.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 20:14:49 INFO - PROCESS | 13945 | 20:14:49 INFO - PROCESS | 13945 | [#8] json-parse-financial Cycles:10 Average:59.70 Median:58.50 stddev:5.89 (10.1%) stddev-sans-first:6.21 20:14:49 INFO - PROCESS | 13945 | Values: 58.0 57.0 59.0 58.0 60.0 59.0 57.0 76.0 55.0 58.0 20:14:49 INFO - PROCESS | 13945 | 20:14:49 INFO - PROCESS | 13945 | [#9] json-stringify-tinderbox Cycles:10 Average:61.00 Median:61.00 stddev:0.47 (0.8%) stddev-sans-first:0.50 20:14:49 INFO - PROCESS | 13945 | Values: 61.0 61.0 61.0 61.0 61.0 61.0 61.0 60.0 61.0 62.0 20:14:49 INFO - PROCESS | 13945 | 20:14:49 INFO - PROCESS | 13945 | [#10] stanford-crypto-aes Cycles:10 Average:79.40 Median:78.50 stddev:3.53 (4.5%) stddev-sans-first:3.33 20:14:49 INFO - PROCESS | 13945 | Values: 84.0 84.0 76.0 77.0 79.0 85.0 76.0 77.0 78.0 78.0 20:14:49 INFO - PROCESS | 13945 | 20:14:49 INFO - PROCESS | 13945 | [#11] stanford-crypto-ccm Cycles:10 Average:129.20 Median:127.00 stddev:10.76 (8.5%) stddev-sans-first:11.30 20:14:49 INFO - PROCESS | 13945 | Values: 125.0 123.0 125.0 130.0 125.0 122.0 127.0 129.0 159.0 127.0 20:14:49 INFO - PROCESS | 13945 | 20:14:49 INFO - PROCESS | 13945 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.60 Median:165.00 stddev:2.84 (1.7%) stddev-sans-first:2.95 20:14:49 INFO - PROCESS | 13945 | Values: 164.0 163.0 163.0 167.0 165.0 171.0 165.0 164.0 170.0 164.0 20:14:49 INFO - PROCESS | 13945 | 20:14:49 INFO - PROCESS | 13945 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.30 Median:70.00 stddev:2.31 (3.3%) stddev-sans-first:2.30 20:14:49 INFO - PROCESS | 13945 | Values: 68.0 70.0 72.0 70.0 70.0 70.0 68.0 76.0 70.0 69.0 20:14:49 INFO - PROCESS | 13945 | -------- Summary: end -------- 20:14:49 INFO - PROCESS | 13945 | 20:14:49 INFO - TEST-INFO | 13945: exit 0 20:14:49 INFO - TEST-OK | kraken | took 61077ms 20:14:49 INFO - SUITE-END | took 1170s 20:14:50 INFO - Completed test suite (00:19:30) 20:14:50 INFO - javascript benchmark 20:14:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3110.4245714542812, 3111.782175247733, 3176.4282429162754, 3192.042387283814, 3199.856006479708, 5462.153366228236, 5466.535344495717, 5467.917981230285, 5495.203195536645, 5496.835094947148, 5288.920666190001, 5389.434109418504, 5436.945630543693, 5447.264619276397, 5559.972200139004, 4918.311436398898, 4965.0, 5017.19724844025, 5054.69671819692, 5108.259302401149, 660.731050309564, 4913.901721965559, 4984.476629953857, 5004.149294619923, 5018.498150184989, 4971.676841005341, 4984.352034235562, 4991.126552853254, 5004.799808007675, 5019.472955339692, 4935.235038569028, 5070.31550740649, 5073.644844860862, 5089.236614507817, 5095.464976177485, 4858.295547145644, 4873.731944743037, 4881.243407271879, 4881.585065269456, 4925.21196608541, 5228.79084836606, 5259.0796610593, 5279.894402111975, 5296.179092240709, 5338.786448542053, 5731.856703582402, 5735.283089613798, 5749.59752817303, 5872.677002764846, 5921.61509501881, 5818.069108942549, 5859.267591551056, 5860.824175274749, 5875.324337701177, 5906.291245050578, 5415.377231618375, 5469.234307196995, 5473.75368108436, 5474.315710536183, 5489.286392768954, 5917.704114794329, 5922.496587790086, 5981.551383646244, 5988.880222395528, 6011.068284415923, 5741.425857414309, 5761.164631128547, 5767.596268261265, 5777.45114214149, 5783.2192653992015, 5811.506021988178, 5828.417158284223, 5862.560307976919, 5871.266091738533, 5872.7357268923, 5727.713614319351, 5775.88448231033, 5824.039033559416, 5855.560832937546, 5865.061590145556, 5695.03184458643, 5703.17303990919, 5760.279965004374, 5770.769169233267, 5862.443067908542, 4399.054203346296, 4453.710508816981, 4454.042380888124, 4456.866294011184, 4457.108578284357, 3886.591907849692, 3894.9415758763075, 3903.746256493319, 3913.5303763547986, 3954.406838974119, 5602.571344307175, 5622.409646987089, 5622.971885140548, 5645.604807663506, 5663.150527420919, 5616.691081990448, 5866.061430171152, 5923.052311630118, 5928.703564821742, 5945.940540594539, 5547.362053363834, 5575.804846830422, 5598.468145526169, 5669.234653321749, 5684.8294551163535, 4955.132851750929, 4979.502049794992, 4979.701217926936, 4992.425871024806, 5000.799968001239, 5909.438603332676, 5931.703414829241, 5944.762209511658, 5980.85047873798, 5997.880042399215, 5865.384134665969, 5872.588918775816, 5878.29460464747, 5879.441453062123, 5907.0, 5976.252968378953, 6014.097885317237, 6014.879702405839, 6016.398360164124, 6024.728887199999, 5714.142878568248, 5739.770409183753, 5743.540516758566, 5745.942540574708, 5799.82600521985, 5779.566532509994, 5818.854528636818, 5822.184894114743, 5829.300483941955, 5867.914435829385, 5603.831885043455, 5625.8593535161945, 5632.662040277596, 5650.237217975685, 5659.943400566106, 5589.524890384363, 5629.6903670298525, 5655.095184770417, 5707.429257074259, 5749.367569567261, 5511.338639363302, 5513.035218836607, 5546.195801608825, 5630.549556035589, 5656.60403771732, 5665.348484924287, 5689.061304884648, 5691.345495268097, 5719.0, 5757.36668966405, 5481.862953426037, 5577.721113944368, 5585.050541407889, 5600.635958662674, 5672.801451949162], "value": 5338.092535630632, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [605.207178596039, 650.2229835346757, 654.5777973207281, 662.5329142954221, 666.9766558170463, 30539.0, 37792.0, 38358.808205959, 38473.23053538931, 38617.0, 40109.59890401095, 40822.18355632893, 40838.18323633526, 40872.0, 41215.793921030425, 8437.240648341649, 8649.740507784776, 8678.132186781302, 8680.435771674822, 8691.26124279437, 8515.53164575948, 8585.098564650716, 8619.0, 8682.43564168327, 8840.734777956639, 8814.779630509225, 8829.690960816373, 8869.95565022174, 8883.73348799537, 8918.108189181095, 8761.605727742235, 8768.60541275641, 8820.603072861737, 8824.249938755214, 8858.73423797287, 8721.12788721129, 8777.912220877837, 8814.823703525894, 8822.206001459836, 8836.469811811248, 41012.38481422781, 41400.378994315106, 41514.58485415138, 41690.37464438036, 41727.7913610433, 3443.4146195146886, 3654.853805847763, 3679.0, 3907.8046097695, 4309.5690430956965, 32016.359672806648, 32455.67544324574, 32717.345653087043, 32975.6702432975, 33029.834850825835, 4078.9592104078874, 4122.958770412288, 4125.422440858282, 4169.97835530297, 4196.685248606367, 262148.0, 262355.0, 263182.9999999981, 264937.0, 265051.0, 58917.70541147267, 59596.10605840916, 59714.701426493455, 59766.103508447406, 59825.700871496236, 62246.377536224056, 63578.364216357244, 64820.35179648238, 65279.0, 65351.0, 16381.836181638031, 16556.089415082046, 16568.420105296256, 16593.419230327123, 16596.83403165977, 12804.551840685532, 12833.358332083546, 12870.67823304425, 12871.613851584467, 12887.35563221854, 19115.818787607594, 19211.23155073809, 19283.22867085301, 19378.903105484664, 19748.70376944347, 7039.788806335818, 7124.323189297009, 7169.7849064528145, 7179.892301615376, 7212.639368031578, 1025.220832167558, 1039.4335087377397, 1126.5550107707409, 1173.0263880978766, 1197.239752756988, 27201.047963321187, 27409.31476713098, 27501.174964751088, 27963.860180699372, 28020.579691304647, 1082.6481393546972, 1135.9659210223706, 1148.2536351371675, 1152.5159433038143, 1222.7615614954998, 14797.563060068904, 14970.550883473514, 15009.174495402858, 15136.924315378352, 15301.0, 440974.0, 445481.0, 445694.0, 446313.0, 447405.0, 55876.0, 57243.71378143166, 57370.0, 57468.0, 57486.13770793442, 1389.305347326337, 1411.5906387147818, 1412.4915030589186, 1417.7022825206823, 1491.2543728135931, 29262.414751705273, 29437.411251775273, 29784.55323170111, 30171.396572068876, 30728.385432291678, 46458.767706161256, 47227.0, 47462.0, 47652.761736192486, 47699.52300476951, 340047.0, 340395.0, 340904.0, 426703.0, 428821.0, 28131.156065318075, 28398.858005710666, 28469.857650711612, 28686.131386861147, 28967.0, 47332.52667473281, 47723.04553908833, 47764.0, 47879.042419152116, 47956.76021620009, 39312.60687393204, 39777.80111099542, 40410.59589404186, 40756.59243407528, 41174.176516468906, 39652.603473966046, 39856.800715996236, 40214.396784047676, 40235.0, 41246.38130427986, 40178.39732403958, 41094.0, 41402.0, 41527.0, 42622.78688606661, 38574.0, 39113.0, 41981.58018419899, 42436.78781606072, 43295.35056974085, 33097.50353744744, 33220.667793322726, 33360.165995849326, 33367.83316083501, 34019.4897076549], "value": 19704.95225628674, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [382.4912865888368, 384.23728898137193, 390.55408634385424, 396.2847061054796, 404.1391835390618, 17897.105144742774, 18004.459866204, 18448.723269150956, 18481.72277415838, 19261.325853595128, 17868.55328616785, 17936.910315448436, 17984.190711417985, 18988.62022759544, 19443.319483818068, 5474.534664553507, 5475.4524547545325, 5671.319441667006, 5707.086866101425, 5724.34170070441, 5614.606977511576, 5653.0, 5655.971720141393, 5661.60368774186, 5671.6880571568545, 5399.082156033483, 5607.551395888339, 5638.04153293939, 5643.012472817261, 5643.830685079454, 5559.833205003856, 5588.077967135418, 5602.915956260639, 5607.43925607438, 5624.662520248778, 4857.902841943177, 4877.756112194376, 4880.2435622478215, 4986.10250154972, 4997.950020499785, 22091.558168836535, 22165.889170554045, 22215.555688886292, 22738.0, 22845.657315140284, 2367.6448532720055, 2373.6320870265135, 2516.5721827289403, 2634.6838379394403, 2948.498755211619, 13871.375788089561, 14470.131792092508, 14523.709525809425, 14593.34329955144, 14786.334614942245, 1834.8899066056078, 1908.7709474862966, 1929.7394851695121, 1947.1529884500287, 1957.9510512237166, 56647.43352566463, 67258.0, 75086.62456687736, 77044.0, 78552.21447785506, 10199.13307368882, 10319.896801031893, 10520.684379468628, 10572.629957951434, 10626.73433164177, 14655.34050967709, 14789.630259243606, 14817.925910370379, 14870.628234294229, 14934.402623894923, 7668.578228197391, 7894.210578942175, 7917.485363451357, 8004.359651227888, 8021.679132834738, 7404.074490688664, 7485.588292643957, 7592.468527203043, 7598.404335089693, 7625.504342217849, 6485.475913160403, 6495.253045899687, 6524.119243902012, 6541.640209788412, 6570.704318305688, 1931.5460866696314, 1946.4647222013775, 1951.8438524917972, 1958.4222654317011, 1961.5488437659133, 972.9562169702381, 1038.553422028535, 1059.3780393526115, 1071.566015763617, 1141.8230174322994, 18759.718604220947, 18960.905195473933, 19264.749214657095, 19329.613407731766, 19449.0, 1061.9522121504551, 1072.7371793910543, 1094.108301734084, 1104.2932523185168, 1118.9888101119047, 10643.84034239487, 11107.38909359993, 11198.216124871344, 11208.775824483464, 11217.102631789438, 465764.0, 473164.0, 473258.0, 483586.0, 484829.0, 74028.62985685145, 75929.0, 76313.6184319086, 76918.6154069226, 79139.0, 1067.4449286371043, 1071.9892801072046, 1072.4852071005805, 1073.640330489295, 1077.2350634532204, 16607.418740344514, 16770.1614919256, 16966.0, 17038.403655871985, 17222.91388543049, 23702.88148559246, 31817.36365272635, 34637.30725385529, 35963.820180898925, 36280.27439451249, 47878.521214787404, 47946.280805788636, 48130.27804583004, 48165.75917120392, 48190.03619927512, 7400.148982866824, 7853.960730196312, 8002.799930001796, 8422.199891010345, 8597.398182127441, 9398.483083430478, 12895.935520322339, 13005.739885202054, 13016.804747928978, 13390.397432115384, 11500.25248358854, 11660.12549058807, 11670.649880503599, 11680.591179308683, 11769.705757355792, 11250.212485125963, 11398.0, 11514.36670983104, 11640.825387619023, 11835.408229588314, 12230.205036672587, 12346.691332716753, 12410.689732756753, 12501.24992500453, 12506.624801255977, 7585.317321441097, 7910.5649189295145, 7960.4825686330205, 8067.0, 8145.592720364077, 11472.254303470581, 11569.132315076571, 11607.129465290305, 11649.41752912334, 11828.76342473163], "value": 9098.238017069567, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1487.9925600372, 1510.6827566211095, 1656.9751453728188, 1787.8837875538097, 1805.1425572852897, 7353.080864891888, 8013.759587212378, 8168.877466837995, 8454.112318206591, 8480.83038339233, 8086.231807978247, 8098.959505202466, 8110.188981101887, 8123.903273058136, 8191.549464779435, 2234.6089434349005, 2282.6233671444193, 2282.9657555136687, 2283.1666441748725, 2290.828187885915, 2222.51104756954, 2238.3956331790487, 2281.5208806150727, 2300.1029598456616, 2310.8151347892212, 2206.316042026977, 2208.6576580630026, 2226.220822712054, 2259.7062381890332, 2278.943026424336, 2222.288867562381, 2228.2646726580188, 2233.7877901599322, 2240.1711366794307, 2241.081156725751, 2199.1423344895343, 2199.6590528468114, 2205.0077465140753, 2208.9226877059227, 2211.402921211264, 8410.116937721512, 8525.786855328604, 8554.230119289294, 8555.401121921468, 8568.871466928002, 4795.184818580849, 4908.631852611068, 4925.26121081837, 4930.309756634074, 4951.282064100686, 3064.4790385634496, 3087.984560077208, 3179.2528755742383, 3199.840007999591, 3285.78642388244, 1124.7581769919425, 1139.0488941733663, 1168.1180708565064, 1169.5789515774316, 1191.576990168495, 11411.657650270505, 11425.485853136628, 11656.30062196271, 11941.820872686916, 11974.64076077719, 4367.956320436755, 4378.146261478981, 4526.366308716782, 4528.637708983273, 4533.977330113328, 9198.49408282551, 9202.723918282461, 9291.21024712907, 9295.0, 9300.11648893354, 5012.273220383024, 5050.217216331474, 5061.772220250024, 5063.392392912874, 5073.847784566469, 4041.6160464755803, 4582.931256031162, 4691.835785747482, 4729.6689231754135, 4758.7858546364805, 3676.4485327201132, 3695.371786796251, 3717.0, 3744.3260213161893, 3785.772853628791, 1115.8326251062406, 1120.6301920366259, 1129.5368898751472, 1139.481535901163, 1150.0282261489028, 860.74177746677, 1025.3489034463169, 1026.7997740440542, 1035.7928414317166, 1046.0585473074143, 5882.705864706748, 5890.764369425175, 5936.970315148396, 6035.456808887221, 6100.816975490742, 399.12193175015085, 400.50937601438005, 401.65056400931377, 404.08071637026, 425.64671322802, 4019.8191081400823, 4205.915881682349, 4221.535631080578, 4228.9788551057045, 4233.661307095425, 9816.509174541245, 9964.950175249078, 10075.798484030278, 10319.94840025795, 10394.272400931863, 9959.601615935426, 10000.849987250198, 10112.14046806015, 10122.240831937634, 10125.088742013108, 7533.4349923755935, 7685.961570192113, 7869.685212591547, 7886.171951944963, 7991.600419978978, 5893.32226793907, 5941.257342832146, 6005.918934591816, 6070.7875224366935, 6074.483668888194, 9503.334766566273, 9512.476813775309, 9514.476703781358, 9598.712038638852, 9608.711738647851, 9502.952485237529, 9597.376170548892, 9721.9027809721, 9870.210383169186, 9877.753056173653, 6598.472122230306, 7294.234105418855, 7438.181800002104, 7805.063392392949, 8102.797430064295, 8130.390220733587, 8180.0, 8200.794980125545, 8208.630611622611, 8228.50628962264, 7085.787426377217, 7377.963110184414, 7408.111026676617, 7419.740309089156, 7497.175310715707, 7167.850389362817, 7512.774616761506, 7536.472446928662, 7537.886931695919, 7636.885446718193, 6601.273859875314, 6608.1079054328975, 6624.436922861611, 6678.83302917431, 6685.465162786868, 4912.771807048238, 5109.9233511498105, 5116.923246151385, 5206.479352064764, 5234.528892399702, 5136.0, 5197.4282828889545, 5207.635465517377, 5218.843434696965, 5260.9736951315], "value": 4373.965738464126, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [315.4589878358615, 315.6338647169283, 323.5454186867451, 326.74024150800113, 328.1451818014075, 5884.264466941632, 5902.173695682597, 6013.458788709016, 6078.908816367758, 6122.724477398511, 5775.27809023872, 5883.8529036774, 5920.851978700534, 5933.970330148354, 5969.1046343048565, 4566.269396896489, 4575.405197324343, 4578.130155270488, 4588.24293991491, 4595.609373203265, 4512.661550383718, 4556.521565235652, 4574.290984897346, 4579.587837094661, 4580.885477863047, 4489.0023939347, 4489.2817149256125, 4521.389612402333, 4522.3216517522305, 4523.3441151033085, 4514.164879497303, 4545.909081818345, 4546.97726511367, 4547.8635640930825, 4549.340345649895, 3846.1730727893637, 3981.3629819229072, 3984.641382275609, 3995.860144894915, 3996.18078293949, 5699.116636921284, 5704.1443783432405, 5725.227094342252, 5742.97128514359, 5782.10377391505, 5232.659877107976, 5238.81664141757, 5253.264542963988, 5255.1329030709885, 5285.55072818807, 6011.669358185298, 6229.4426393401645, 6258.405451482102, 6263.185785847856, 6271.592346497463, 4352.499462561815, 4372.540883207281, 4384.561543845622, 4391.516933137353, 4421.314696222059, 6332.588381755125, 6503.772367967145, 6559.147310849607, 6570.967145164243, 6587.176602924635, 4479.865604031885, 4501.0, 4508.278675411984, 4509.6843220974215, 4519.367288579601, 4543.068670922453, 4553.749543775058, 4561.361409402686, 4568.314752787109, 4571.588557029883, 5177.418872140659, 5255.237990491358, 5262.71055091966, 5269.947300526946, 5277.894442111213, 5939.673317967553, 6105.236845394325, 6179.28938172116, 6262.1859158310035, 6294.716737746812, 1554.401555401156, 1558.1819544739103, 1566.9451569195023, 1573.5122112145273, 1575.5667191522423, 1043.8173319669027, 1045.268312181476, 1046.9895301046893, 1060.2790102730064, 1064.1114669251263, 6077.24034495688, 6117.357677443893, 6120.0, 6121.510279177655, 6121.663308518075, 6405.615663060138, 6434.74261029563, 6465.838354041187, 6495.902561461582, 6505.414512693786, 6013.5189184865985, 6127.3566275540425, 6142.815715528452, 6145.201123853871, 6156.353582873823, 3474.6872781449792, 3486.564179477565, 3493.1441796759955, 3503.8773642922883, 3505.4040813061843, 6517.250516190604, 6690.0968369270495, 6729.461643068543, 6749.966250168816, 6767.593944363354, 6569.67151642416, 6617.602943823386, 6636.270010298863, 6643.236027856762, 6692.389967912518, 6557.737690492327, 6629.801105966829, 6716.227633822173, 6718.630475323806, 6744.966275168593, 6454.225492940877, 6461.64460954652, 6490.0, 6498.350164983463, 6527.15147030883, 6320.083587879823, 6329.284682911077, 6367.299597044229, 6369.681515924092, 6416.358364163546, 6649.700763465559, 6668.233153187251, 6675.365840245169, 6681.732730690718, 6689.297623749436, 4436.223660859401, 4445.1998640245065, 4449.154660614473, 4450.910981780411, 4478.283474644041, 6246.562740608296, 6262.09199666055, 6378.489720822416, 6491.870162596816, 6512.902306465312, 6338.207724034496, 6341.239051313872, 6347.0, 6353.4599559038, 6365.745370185326, 6162.815115546541, 6300.684965751786, 6321.178246828067, 6331.366863313816, 6358.364163583605, 6208.161898143693, 6218.626882387071, 6225.8132256032395, 6243.7814676486105, 6262.2172228471445, 6256.6214244309385, 6310.6529140895855, 6357.332480089524, 6365.267994180728, 6368.331325210786, 6073.453389194994, 6200.596961197508, 6225.8132256032395, 6227.314995350598, 6233.75064997395], "value": 4741.481679114449, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [780.0171783552726, 786.4534148766606, 810.8013536683511, 814.672084502262, 835.6114406800837, 14225.43098276069, 14654.926725366358, 14658.560243192722, 14675.192864392455, 14683.33924973376, 12673.936630316859, 12959.93520032401, 12965.351732413388, 13012.869871301284, 13099.214047157153, 801.7594721583531, 808.7412028150994, 808.9635966381527, 814.6904176412954, 817.3216230528647, 681.2744427185057, 789.376392649806, 812.6708682983401, 813.0487329824091, 815.4943934760457, 845.3195177881803, 845.7251393297172, 847.516915358246, 849.087231226431, 851.0765819086299, 846.8475674378609, 849.6304107713164, 849.9065102838683, 850.3792231670853, 851.1531026628544, 616.9105479705418, 620.2959640807716, 621.3289647181034, 623.1462895832739, 624.0140577886928, 14101.083429577046, 14178.43286268548, 14182.361793719307, 14182.85817141836, 14204.147751134966, 13363.732725345535, 13448.260345680983, 13545.661358466019, 13667.726645467035, 13690.93154534221, 10239.18086553074, 10300.89699103007, 10343.0, 10460.581576736922, 10594.682159535227, 3626.0, 3690.1697118148472, 3694.556653201606, 3698.130939229279, 3731.2350968051483, 51695.22457163146, 52862.73568632132, 54525.72737136289, 54637.18044229379, 54642.180367294524, 10827.0, 10940.0, 11049.33703977764, 11196.832047519294, 11199.72000699989, 18061.458156255332, 18133.36533221331, 19181.61636767257, 19218.807811921703, 19256.614867702847, 8254.793630159294, 8305.294050005696, 8325.500469971821, 8472.830543389098, 8527.701530446404, 4783.976080119647, 4797.784099715521, 4818.68678535894, 4837.95162048382, 5038.874028149326, 3157.2896098377682, 3249.4800831866787, 3260.8858689945737, 3278.4098862205033, 3291.144302481372, 600.7266693654377, 604.1119554255238, 612.6691586543305, 642.0850288339099, 646.7865604350553, 561.469994265631, 611.6085705148708, 650.9707063182168, 667.3526679121245, 737.8893166025032, 9013.143751343612, 9293.67472138472, 9432.625528857634, 9444.244460443148, 9459.952700236454, 651.869626074787, 711.5339452658517, 718.2853061204136, 721.8700633885951, 765.8315170662445, 4350.630196433339, 4426.269665505156, 4431.756253406029, 4447.155040542287, 4515.277555591089, 66597.0, 67513.3248667507, 68590.65704671445, 68615.65692171507, 68707.65646171737, 58604.0, 59652.0, 60221.0, 60638.69680651568, 60854.0, 53591.73204133954, 53957.46042539524, 54240.45759542354, 54380.18429723557, 54536.0, 8417.452865563719, 8422.873656895274, 8543.743687689379, 8555.363970312468, 8574.742757717278, 33905.32189356248, 34070.31859362749, 34667.0, 34975.65024349724, 35056.47415288824, 45139.32291015703, 46769.766151170385, 48464.0, 48830.26754598613, 49548.25677614911, 11176.385298808644, 11179.66461006171, 11187.664370068911, 11338.263012904135, 11662.067034637379, 11797.764044718886, 11973.401329933295, 12373.62879113628, 12497.37513124322, 12552.372381381078, 11081.944590276997, 11283.66149015531, 11306.547738090714, 11562.76874462523, 11995.1003674723, 11685.883141168479, 11727.061835053346, 11735.765284694087, 12062.215955962834, 12184.390780460764, 11255.606053788406, 11473.942630286796, 11572.59495917639, 11579.0, 11658.53365865356, 9241.122093401116, 9317.86023209666, 9343.813123737624, 9467.952660236655, 9658.517074146404, 9609.099359326934, 9913.65302214419, 9993.900060999296, 10055.245856560641, 10062.195024398177], "value": 6616.525251126194, "unit": "score"}], "name": "dromaeo_css", "value": 7129.570927584934, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 106.0, 112.0, 111.0, 111.0, 126.0, 111.0, 112.0, 111.0, 112.0], "value": 112.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 127.0, 157.0, 183.0, 128.0, 156.0, 160.0, 127.0, 189.0, 130.0], "value": 151.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 163.0, 162.0, 161.0, 161.0, 165.0, 172.0, 164.0, 166.0, 162.0], "value": 164.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 161.0, 73.0, 77.0, 73.0, 76.0, 164.0, 77.0], "value": 92.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 91.0, 143.0, 92.0, 92.0, 92.0, 142.0, 92.0, 93.0, 152.0], "value": 108.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 118.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 148.0, 146.0, 146.0, 151.0, 150.0, 147.0, 146.0, 146.0, 147.0], "value": 147.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 57.0, 59.0, 58.0, 60.0, 59.0, 57.0, 76.0, 55.0, 58.0], "value": 59.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 61.0, 61.0, 61.0, 61.0, 61.0, 60.0, 61.0, 62.0], "value": 61.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 76.0, 77.0, 79.0, 85.0, 76.0, 77.0, 78.0, 78.0], "value": 79.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 123.0, 125.0, 130.0, 125.0, 122.0, 127.0, 129.0, 159.0, 127.0], "value": 129.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 163.0, 167.0, 165.0, 171.0, 165.0, 164.0, 170.0, 164.0], "value": 165.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 70.0, 72.0, 70.0, 70.0, 70.0, 68.0, 76.0, 70.0, 69.0], "value": 70.3, "unit": "score"}], "name": "kraken", "value": 1554.3000000000002, "alertThreshold": 2.0}]} 20:14:50 INFO - Return code: 0 20:14:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 20:14:50 ERROR - # TBPL SUCCESS # 20:14:50 INFO - Running post-action listener: _resource_record_post_action 20:14:50 INFO - Running post-run listener: _resource_record_post_run 20:14:51 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 0; Write bytes: 536850432; Read time: 0; Write time: 542420 20:14:51 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 244183040; Read time: 0; Write time: 340436 20:14:51 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 0; Write bytes: 292605952; Read time: 0; Write time: 201912 20:14:51 INFO - Running post-run listener: _upload_blobber_files 20:14:51 INFO - Blob upload gear active. 20:14:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:14:51 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 20:14:51 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'] 20:14:51 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 20:14:51 INFO - (blobuploader) - INFO - Open directory for files ... 20:14:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 20:14:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:14:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:14:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 20:14:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:14:52 INFO - (blobuploader) - INFO - Done attempting. 20:14:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 20:14:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:14:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:14:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 20:14:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:14:53 INFO - (blobuploader) - INFO - Done attempting. 20:14:53 INFO - (blobuploader) - INFO - Iteration through files over. 20:14:53 INFO - Return code: 0 20:14:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:14:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:14:53 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/48f93b4a63e8249a41ab5f9e4e6eb7c397b8a2d5330017fe9440fd4ae07f7200fe0c617cb98151521bab8748b181b870f08c4f1049c71a8b1e817e67738a0285", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2d8ded4a52f4455ccb7a689018d368726a84d49b8736dac474972cb6fa9081d6fa60647159538d2f46826e4f0f5cc93bf0e359f50dda3bebc67c1cf360d6f612"} 20:14:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:14:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:14:53 INFO - Contents: 20:14:53 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/48f93b4a63e8249a41ab5f9e4e6eb7c397b8a2d5330017fe9440fd4ae07f7200fe0c617cb98151521bab8748b181b870f08c4f1049c71a8b1e817e67738a0285", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2d8ded4a52f4455ccb7a689018d368726a84d49b8736dac474972cb6fa9081d6fa60647159538d2f46826e4f0f5cc93bf0e359f50dda3bebc67c1cf360d6f612"} 20:14:53 INFO - Running post-run listener: copy_logs_to_upload_dir 20:14:53 INFO - Copying logs to upload dir... 20:14:53 INFO - mkdir: /builds/slave/test/build/upload/logs 20:14:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.758545 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-04-15 20:14:53.775286) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-15 20:14:53.778438) ========= 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=0274524eba3bdaad075c2247000001d4-1460767739.655611-647564653 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/48f93b4a63e8249a41ab5f9e4e6eb7c397b8a2d5330017fe9440fd4ae07f7200fe0c617cb98151521bab8748b181b870f08c4f1049c71a8b1e817e67738a0285", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2d8ded4a52f4455ccb7a689018d368726a84d49b8736dac474972cb6fa9081d6fa60647159538d2f46826e4f0f5cc93bf0e359f50dda3bebc67c1cf360d6f612"} build_url:https://queue.taskcluster.net/v1/task/VZTDkKEnTuyduPyyDVXmtQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011424 build_url: 'https://queue.taskcluster.net/v1/task/VZTDkKEnTuyduPyyDVXmtQ/artifacts/public/build/firefox-48.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/48f93b4a63e8249a41ab5f9e4e6eb7c397b8a2d5330017fe9440fd4ae07f7200fe0c617cb98151521bab8748b181b870f08c4f1049c71a8b1e817e67738a0285", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2d8ded4a52f4455ccb7a689018d368726a84d49b8736dac474972cb6fa9081d6fa60647159538d2f46826e4f0f5cc93bf0e359f50dda3bebc67c1cf360d6f612"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-15 20:14:53.802450) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 20:14:53.802741) ========= 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=0274524eba3bdaad075c2247000001d4-1460767739.655611-647564653 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004349 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 20:14:53.887589) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-15 20:14:53.887891) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-15 20:14:53.888199) ========= ========= Total master_lag: 0.17 =========