builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-064 starttime: 1460775258.43 results: success (0) buildid: 20160415173001 builduid: c0811d795fc341f0a060638f98497c38 revision: 29782c3286ca0d496b16cd3a7a0edd0741641d99 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-15 19:54:18.429588) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-15 19:54:18.430599) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-15 19:54:18.431356) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-15 19:54:18.473689) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 19:54:18.474370) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1460768836.626605-369819058 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-15 19:54:19-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.2M=0s 2016-04-15 19:54:19 (46.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.122347 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 19:54:18.612152) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 19:54:18.612511) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1460768836.626605-369819058 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019488 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 19:54:18.665324) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 19:54:18.666156) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1460768836.626605-369819058 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-15 19:54:19,323 truncating revision to first 12 chars 2016-04-15 19:54:19,323 Setting DEBUG logging. 2016-04-15 19:54:19,323 attempt 1/10 2016-04-15 19:54:19,323 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:19,586 unpacking tar archive at: fx-team-29782c3286ca/testing/mozharness/ program finished with exit code 0 elapsedTime=0.579364 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 19:54:19.262549) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-15 19:54:19.262957) ========= script_repo_revision: 29782c3286ca0d496b16cd3a7a0edd0741641d99 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-15 19:54:19.263424) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-15 19:54:19.263761) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-15 19:54:19.274117) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-04-15 19:54:19.274473) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a12cd81e0ef515edd9e0d800000001bb-1460768836.626605-369819058 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:54:20 INFO - MultiFileLogger online at 20160415 19:54:20 in /builds/slave/test 19:54:20 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 19:54:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:54:20 INFO - {'append_to_log': False, 19:54:20 INFO - 'base_work_dir': '/builds/slave/test', 19:54:20 INFO - 'blob_upload_branch': 'Fx-Team', 19:54:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:54:20 INFO - 'branch': 'Fx-Team', 19:54:20 INFO - 'buildbot_json_path': 'buildprops.json', 19:54:20 INFO - 'config_files': ('talos/linux_config.py',), 19:54:20 INFO - 'default_actions': ('clobber', 19:54:20 INFO - 'read-buildbot-config', 19:54:20 INFO - 'download-and-extract', 19:54:20 INFO - 'populate-webroot', 19:54:20 INFO - 'create-virtualenv', 19:54:20 INFO - 'install', 19:54:20 INFO - 'run-tests'), 19:54:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:54:20 INFO - 'download_minidump_stackwalk': True, 19:54:20 INFO - 'download_symbols': 'ondemand', 19:54:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:54:20 INFO - 'tooltool.py': '/tools/tooltool.py', 19:54:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:54:20 INFO - '/tools/misc-python/virtualenv.py')}, 19:54:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:54:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:54:20 INFO - 'installer_path': 'installer.exe', 19:54:20 INFO - 'log_level': 'info', 19:54:20 INFO - 'log_name': 'talos', 19:54:20 INFO - 'log_to_console': True, 19:54:20 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:54:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:54:20 INFO - 'opt_config_files': (), 19:54:20 INFO - 'pip_index': False, 19:54:20 INFO - 'sps_profile': False, 19:54:20 INFO - 'sps_profile_interval': 0, 19:54:20 INFO - 'suite': 'dromaeojs', 19:54:20 INFO - 'system_bits': '32', 19:54:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:54:20 INFO - 'title': 'talos-linux64-ix-064', 19:54:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:54:20 INFO - 'use_talos_json': True, 19:54:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:54:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:54:20 INFO - 'work_dir': 'build'} 19:54:20 INFO - ##### 19:54:20 INFO - ##### Running clobber step. 19:54:20 INFO - ##### 19:54:20 INFO - Running pre-action listener: _resource_record_pre_action 19:54:20 INFO - Running main action method: clobber 19:54:20 INFO - rmtree: /builds/slave/test/build 19:54:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:54:20 INFO - Running post-action listener: _resource_record_post_action 19:54:20 INFO - ##### 19:54:20 INFO - ##### Running read-buildbot-config step. 19:54:20 INFO - ##### 19:54:20 INFO - Running pre-action listener: _resource_record_pre_action 19:54:20 INFO - Running main action method: read_buildbot_config 19:54:20 INFO - Using buildbot properties: 19:54:20 INFO - { 19:54:20 INFO - "project": "", 19:54:20 INFO - "product": "firefox", 19:54:20 INFO - "script_repo_revision": "production", 19:54:20 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 19:54:20 INFO - "repository": "", 19:54:20 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 19:54:20 INFO - "buildid": "20160415173001", 19:54:20 INFO - "pgo_build": "True", 19:54:20 INFO - "basedir": "/builds/slave/test", 19:54:20 INFO - "buildnumber": 33, 19:54:20 INFO - "slavename": "talos-linux64-ix-064", 19:54:20 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 19:54:20 INFO - "platform": "ubuntu64_hw", 19:54:20 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 19:54:20 INFO - "branch": "fx-team", 19:54:20 INFO - "repo_path": "integration/fx-team", 19:54:20 INFO - "revision": "29782c3286ca0d496b16cd3a7a0edd0741641d99", 19:54:20 INFO - "stage_platform": "linux64-pgo", 19:54:20 INFO - "builduid": "c0811d795fc341f0a060638f98497c38", 19:54:20 INFO - "slavebuilddir": "test" 19:54:20 INFO - } 19:54:20 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:20 INFO - Running post-action listener: _resource_record_post_action 19:54:20 INFO - ##### 19:54:20 INFO - ##### Running download-and-extract step. 19:54:20 INFO - ##### 19:54:20 INFO - Running pre-action listener: _resource_record_pre_action 19:54:20 INFO - Running main action method: download_and_extract 19:54:20 INFO - mkdir: /builds/slave/test/build/tests 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.test_packages.json 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.test_packages.json 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.test_packages.json 19:54:20 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:20 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:25 INFO - Downloaded 1361 bytes. 19:54:25 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 19:54:25 INFO - Using the following test package requirements: 19:54:25 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 19:54:25 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 19:54:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:54:25 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 19:54:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 19:54:25 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 19:54:25 INFO - u'jsshell-linux-x86_64.zip'], 19:54:25 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 19:54:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:54:25 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 19:54:25 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 19:54:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:54:25 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 19:54:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:54:25 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 19:54:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:54:25 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 19:54:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:54:25 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:54:25 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:25 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:25 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:25 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:25 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:25 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:28 INFO - Downloaded 23774974 bytes. 19:54:28 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:28 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:29 INFO - Return code: 0 19:54:29 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:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:54:29 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:29 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:29 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:29 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:29 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:31 INFO - Downloaded 23774974 bytes. 19:54:31 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:31 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:33 INFO - Return code: 0 19:54:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:54:33 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:33 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:33 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:33 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:33 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:34 INFO - Downloaded 10841076 bytes. 19:54:34 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:34 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: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.tar.bz2 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.tar.bz2 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.tar.bz2 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.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 19:54:34 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 0x7f5b41f53f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27fe9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x288d810>, '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 0x288e710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x288eba0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1460768836.626605-369819058', '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': 'a12cd81e0ef515edd9e0d800000001bb-1460768836.626605-369819058', 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 0x7f5b41f53f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27fe9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x288d810>, '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 0x288e710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x288eba0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1460768836.626605-369819058', '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': 'a12cd81e0ef515edd9e0d800000001bb-1460768836.626605-369819058', 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 0x7f5b41f53f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27fe9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x288d810>, '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 0x288e710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x288eba0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1460768836.626605-369819058', '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': 'a12cd81e0ef515edd9e0d800000001bb-1460768836.626605-369819058', 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 0x7f5b41f53f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27fe9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x288d810>, '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 0x288e710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x288eba0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1460768836.626605-369819058', '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': 'a12cd81e0ef515edd9e0d800000001bb-1460768836.626605-369819058', 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:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:54:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:54:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:54:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:54:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:54:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:54:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 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 0x7f5b41f53f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27fe9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x288d810>, '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 0x288e710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x288eba0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1460768836.626605-369819058', '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': 'a12cd81e0ef515edd9e0d800000001bb-1460768836.626605-369819058', 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-pOxUkF-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-g59H31-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-oPCCol-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-nRwsgf-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-z6SOVT-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-_byuHz-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-SxsjJB-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-45ZLKR-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-CrH4MY-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-cS6FwW-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-xnlamF-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-n7k6RX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:54:50 INFO - Running setup.py (path:/tmp/pip-RYybz5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:54:50 INFO - Running setup.py (path:/tmp/pip-i6C88J-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-23t4Fc-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-c1gVKO-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-Z7nG1z-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:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:54:51 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:52 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 0x7f5b41f53f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27fe9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x288d810>, '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 0x288e710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x288eba0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1460768836.626605-369819058', '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': 'a12cd81e0ef515edd9e0d800000001bb-1460768836.626605-369819058', 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-dr_omY-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-8yXbtW-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-9euWqT-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-5Unhi8-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-4lfanB-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-EICyJr-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-1qhczF-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-MiMmdT-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-OX5546-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:54:53 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:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:54:53 INFO - Running setup.py (path:/tmp/pip-0u8Dm5-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-oUgZRl-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-gYoHzx-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-wHOAOV-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-PCZKwR-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-k5qPYC-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-9Y1aM9-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-ZzJQ6S-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 0x7f5b41f53f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27fe9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x288d810>, '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 0x288e710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x288eba0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1460768836.626605-369819058', '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': 'a12cd81e0ef515edd9e0d800000001bb-1460768836.626605-369819058', 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 0x7f5b41f53f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27fe9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x288d810>, '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 0x288e710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x288eba0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1460768836.626605-369819058', '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': 'a12cd81e0ef515edd9e0d800000001bb-1460768836.626605-369819058', 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 0x7f5b41f53f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27fe9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x288d810>, '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 0x288e710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x288eba0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1460768836.626605-369819058', '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': 'a12cd81e0ef515edd9e0d800000001bb-1460768836.626605-369819058', 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:02 INFO - Reading from file tmpfile_stdout 19:55:02 INFO - Output received: 19:55:02 INFO - Usage: mozinstall [options] installer 19:55:02 INFO - Options: 19:55:02 INFO - -h, --help show this help message and exit 19:55:02 INFO - -d DEST, --destination=DEST 19:55:02 INFO - Directory to install application into. [default: 19:55:02 INFO - "/builds/slave/test"] 19:55:02 INFO - --app=APP Application being installed. [default: firefox] 19:55:02 INFO - mkdir: /builds/slave/test/build/application 19:55:02 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:02 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 0x288d810>, '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 0x288e710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x288eba0>, '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', '--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-064', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 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 --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-064 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 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': 'a12cd81e0ef515edd9e0d800000001bb-1460768836.626605-369819058', 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', '--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-064', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 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:44832' 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 26175 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfkfDxm/profile http://localhost:44832/getInfo.html) 19:55:24 INFO - PROCESS | 26175 | __metrics Screen width/height:1600/1200 19:55:24 INFO - PROCESS | 26175 | colorDepth:24 19:55:24 INFO - PROCESS | 26175 | Browser inner width/height: 1024/697 19:55:24 INFO - PROCESS | 26175 | __metrics 19:55:25 ERROR - PROCESS | 26175 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 19:55:26 INFO - TEST-INFO | 26175: exit 0 19:55:26 INFO - Browser initialized. 19:55:26 INFO - Running cycle 1/1 for dromaeo_css test... 19:55:26 INFO - TEST-INFO | started process 26259 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfkfDxm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:55:38 INFO - PROCESS | 26259 | RSS: Main: 152596480 19:55:38 INFO - PROCESS | 26259 | 19:56:28 INFO - PROCESS | 26259 | 1460775388818 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:36 INFO - PROCESS | 26259 | Cycle 1(1): loaded http://localhost:44832/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44832/tests/dromaeo/cssquery-ext.html) 19:58:37 INFO - PROCESS | 26259 | RSS: Main: 248266752 19:58:37 INFO - PROCESS | 26259 | 20:01:40 INFO - PROCESS | 26259 | Cycle 1(1): loaded http://localhost:44832/tests/dromaeo/cssquery-ext.html (next: http://localhost:44832/tests/dromaeo/cssquery-jquery.html) 20:01:40 INFO - PROCESS | 26259 | RSS: Main: 241065984 20:01:40 INFO - PROCESS | 26259 | 20:04:42 INFO - PROCESS | 26259 | Cycle 1(1): loaded http://localhost:44832/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44832/tests/dromaeo/cssquery-mootools.html) 20:04:43 INFO - PROCESS | 26259 | RSS: Main: 241885184 20:04:43 INFO - PROCESS | 26259 | 20:07:45 INFO - PROCESS | 26259 | Cycle 1(1): loaded http://localhost:44832/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44832/tests/dromaeo/cssquery-prototype.html) 20:07:45 INFO - PROCESS | 26259 | RSS: Main: 229814272 20:07:45 INFO - PROCESS | 26259 | 20:10:48 INFO - PROCESS | 26259 | Cycle 1(1): loaded http://localhost:44832/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44832/tests/dromaeo/cssquery-yui.html) 20:10:49 INFO - PROCESS | 26259 | RSS: Main: 224018432 20:10:49 INFO - PROCESS | 26259 | 20:13:51 INFO - PROCESS | 26259 | Cycle 1(1): loaded http://localhost:44832/tests/dromaeo/cssquery-yui.html (next: http://localhost:44832/tests/dromaeo/cssquery-dojo.html) 20:13:51 INFO - PROCESS | 26259 | RSS: Main: 267292672 20:13:51 INFO - PROCESS | 26259 | 20:13:51 INFO - PROCESS | 26259 | __start_tp_report 20:13:51 INFO - PROCESS | 26259 | _x_x_mozilla_page_load 20:13:51 INFO - PROCESS | 26259 | _x_x_mozilla_page_load_details 20:13:51 INFO - PROCESS | 26259 | |i|pagename|runs| 20:13:51 INFO - PROCESS | 26259 | |0;dojo.html;3032.1206850013496;3088.66024737279;3110.9688903110978;3125.1405863387567;3152.7320177784895;5226.7647955841985;5263.184206447997;5268.4731526847345;5299.60252981026;5316.946830531693;5257.631965762398;5328.706921119337;5378.112611419121;5404.081306177949;5429.918551221735;4737.478877323491;4759.524047595248;4774.7612619369065;4780.832670856521;4860.878478038042;4866.197077482228;4872.3422337984275;4913.680610760289;4918.262260660912;4942.15983282841;4679.719216847;4762.666613337068;4765.0946320199055;4843.515648435164;4867.1725806612785;4828.0585285869265;4843.321934929113;4848.151573474663;4855.732934688591;4859.82990595331;4783.880402989918;4805.327254184417;4809.44691360491;4821.0357928414105;4827.637927155477;5262.210668399771;5265.605079619044;5286.259923610698;5287.101192797195;5288.65623734456;5636.577256705723;5674.319081710221;5674.404187560329;5679.886402271932;5682.488576028136;5501.944980550184;5613.298337707786;5692.260006199168;5713.3429655589725;5724.771009159628;5171.689698618095;5207.4792520748;5210.609204309654;5213.139831927728;5270.49930256625;5633.464820842013;5684.090545512699;5684.54523638108;5686.516646085046;5692.260006199168;5463.590230732711;5470.288862447856;5479.917801232905;5524.530414914697;5539.889202215933;5559.527440167551;5560.221568980346;5561.388247292794;5561.972190139023;5562.054450743383;5517.282753242052;5523.917141242885;5525.392206857243;5527.972360138174;5576.972115139399;5472.398036216013;5581.888362232733;5656.971715141398;5664.631798933056;5666;4245.660347172219;4250.426192463978;4250.559284116336;4260.275753121977;4290.184864875664;3820.503334566489;3828.655421012122;3841.7310788245113;3854.2291541691775;3858.3247931611854;5233.398159211663;5290.1800220965815;5332.360116786011;5370.113931201387;5373.435789242151;5601.411851755588;5616.6068375213345;5633.211350410946;5635.746391412396;5636.126400407943;5312.442193569696;5320.962412329559;5322;5327.573794096463;5375.1131063374105;4814.446338671028;4902.632302577321;4919.2129259318335;4952;4974.427940786856;5723.599348045597;5729.4843464088435;5731.484166424958;5733.569982251264;5802.47777700009;5474.315710536183;5545.057340252248;5594.9929012777275;5612.074007788832;5658.7736490541565;5810;5842.38654941225;5865.530757539302;5882;5912.49743771767;5521.69630670317;5529.4470552944385;5532.612717109763;5535.8892822142525;5537.750801214036;5535.308086489189;5624.818788054391;5634;5635.633683810704;5639.787445699194;5499.1476321170285;5535.169724541351;5537.529310008534;5557.221988921473;5583.720813959367;5436.3476382834315;5436.374816896107;5439.918401223906;5440.42875498067;5445.83662490126;5321.201819726917;5324.733763311897;5345.358556973188;5371.301730774974;5414.269073675004;5565.972170139124;5567.638103523258;5568.387477377566;5578.609497335147;5632.915506267491;5397.433269506645;5422.783088676409;5432.6468779529205;5441.945580544302;5464.098423760035 20:13:51 INFO - PROCESS | 26259 | |1;ext.html;595.365935278928;619.7118339971913;639.9824279395759;659.7031335898847;673.1820837682216;30282;37964.43053354202;38811;38901.8054909725;38931.22137557247;41161.382579261335;41757.7912110439;41903;41910.7904460478;42057.579424205825;7586;8441.704540341088;8629.95685021574;8633.95683021584;9905.257105717064;10009.899901001007;10127.037931396506;10152.441615711134;10157.339772914775;10157.593696252177;10136.391816491034;10261.743456413613;10262;10270.281080324381;10273.075423211909;7951.244631760002;10211.234157438184;10283.125934295595;10798.892011079868;10801.243912926098;10347.120494757955;10476.109530689824;10513.9474302628;10521.84217236742;10532.052115309581;40982.6968168344;41160.588394116276;41398.37902431466;41517.37723934143;41530.584694152974;3653.4337177737493;3688.8524459021605;3826.6364695353896;3924.2044051459798;4056.7971601419813;31972.680273197202;32095.197620059684;32339.83830080858;32445.67554324474;33756;4367.2575662137515;4380.78096095194;4392.648588112943;4522.733634582322;4571.725696458223;314436;314645;316092;316095;317978;35356.11609709726;36295.818520907225;36318.63681363205;36332.27335453329;59143.11285330723;33781.66218337785;34015.31969360599;34096.31807363839;34107;34215.31569368648;15004.474843380429;15097.094174349355;15135.167565783988;15268.3892644293;15321.770173447407;12496.187747796546;12558.748825023631;12584.622461326175;12607.432665530074;12763.042771792152;8581.141885811494;8635.179657932485;8669.609867555975;8698.217160455462;8698.34762392823;3067.647220569663;3083.691630836898;3273.8690452382116;3354.0608629583758;3370.4607262837826;1055.931364461323;1092.759592889563;1094.9890501095047;1125.9718507037226;1191.9046476281876;29163.708362916524;30315;30423.391532169233;30616.38767224643;30803.537946930814;1129.2998341028451;1135.494704856331;1186.7685801268842;1204.987950120505;1224.0330139189941;14689.77965330521;15176.165310908005;15369.923150384177;15449.691006180039;15605.297761600756;481253;481570;485324;485351;486150;56966;57629.423705762405;57662.42337576654;57672.71163644155;57969.42030579725;1358.1443690474937;1392.2551434982236;1396.406527225925;1407.7536431124718;1416.3767942105646;28356.291092722848;28892.133236002952;29484;29506;29868.70131298659;46807.68096306955;47722;47752;47758.283625746335;47759;400809;407742;408972;410122;410333;24991.87504062468;25774;27409.17772466829;27570.310742230802;27959.301017474725;41009.38485922654;41773.37339939964;41851.37222941719;42342;42491.7875410621;35010.29979400347;35271.294574108884;35317.82341088381;35621.10947226237;35984.460233096004;34008.48987265144;34201.65798341985;34217.65782342145;34235.315293693486;34431.311373772885;36623;38559.228815424096;39328.80335598304;39565.40651890166;39960.600393995686;32603.34793304073;34462.655373445945;34524.13689657779;34596.30807383889;34961.30077398387;26828;27056.729432705422;27238.319042023315;27271.318217044733;27280.72719272782 20:13:51 INFO - PROCESS | 26259 | |2;jquery.html;387.8293550837631;388.9436031775391;395.1169136978852;396.79168436570797;400.0997755051134;14417.78373324401;15274.541763747078;17435.65128697427;17998.640027199464;18014.099295035245;11637.243579167349;12067.094967877423;17177.141142942866;18015.279388824463;18031.27874885006;5037.471065538111;5103.2855400244;5161.458046905077;5178.430372659023;5189.377274727038;3871.748336358142;5041.420236672775;5090.592752579803;5509.696966666832;5806.883862322751;5713.942860571383;5780.1907732917425;5800.303963524383;5805.564582656297;5809.302883653967;5722.227499287585;5760.53915686744;5795.855103622422;5796.159556864273;5799.623024503436;5426.403095659474;5512.283403157604;5513.3108361454815;5521.834344969658;5524.171374293848;13555.864441355658;17043.062631555258;19880.502987425287;22808;22829.08683652652;2367.786899179065;2460.2619214235656;2462.790662793647;2766.1978026372326;2873.4971380008415;9546.713598592054;9692.273079519064;9741.464219467998;10053;10421.478926053744;1864.2915692037075;1896.0519740129935;1903.9238430462904;1952.511872031992;1976.3971988543487;77185.22814771892;77331;81439.18560814434;81627.5918620409;82383.17616823815;10910.672679819618;10956.780864382827;10975.926740512668;11018.944905275583;11046.834297485544;15064.698706025818;15102.244887755569;15120.168390738396;15155.924220378827;15164.317605707769;7875;8127.5123492589455;8207.343412526983;8259.917400825914;8316.209960053786;7686.116096648957;7702.9229707703325;7765.883511747328;7885.921140788519;7894.6842126314305;4612.400387949612;4637.443506779208;4652.116097941448;4655.301704744248;4691.695039822401;1826.2603645523584;1858.4982054845116;1872.419549939496;1875.8874467531991;1880.6050729346991;924.3668087360045;1027.7584767579613;1029.6447725534679;1052.095198129608;1084.262701363065;18079;19184.328548501013;19231.51921201953;19293.475564376084;19346;972.9270304727174;994.721477986165;1003.8845532763679;1030.4229631406286;1044.9268551201344;10283.43441110746;10685.465726713634;10774.353538787698;10775.245732798629;10811.18916081297;446417;464652;482265;485907;490807;88359.55820220987;89108;89541;89658;90985;1012.6050840172338;1022.1465076661071;1071.8124328242527;1091.1052936592077;1093.8359246112987;16353.754693679366;16475.258613362188;16790;16871;17015.149242537576;27285.59071613967;33754.66245337515;35968.10079748027;36492.635073648926;37140.44289335608;50390;52715;52720.73639631777;52722;52807.47192528025;8450.830983380421;8584.356173287153;8671.393002489765;8688.78278043054;8811.955940220258;9478.763030924281;12932.159409638343;13113.663665154085;13470.663233419244;13610.795838062239;11343.7270964107;11759.588414405454;11813.291202527877;11862.881371186179;11931.642050738492;11124.388158651029;11280.661580152608;11285.435728213391;11456.599019034627;11556.711082222675;11377.601783937853;11850.703732406759;11888.048956083665;12009.519619215484;12145.45345459474;8318.916810831814;8364.456310339809;8437.87343189865;8549.529775862387;8739.650413983369;10538.683839484827;11891.227070240408;11900.464479098635;11903.404829758305;11955.402229888645 20:13:51 INFO - PROCESS | 26259 | |3;mootools.html;1312.6718320419895;1347.211881049586;1441.8774404175645;1513.5156749840048;1765.011593507635;7999.560024198667;8293.751187464386;8296.004479462465;8297.626606802693;8308.459950103239;8005.3195478384405;8136.349092072634;8160.9591952040155;8172.509649421039;8178.141295163997;2020.101055030512;2250.8762018089083;2287.3938406322295;2317.2353123469215;2326.7440581536016;2251.718535183102;2300.0799680127916;2315.2822624986225;2318.420394901275;2320.8491448055825;2266.0256089881345;2308.134449581407;2310.8844557772127;2314.722233331994;2316.3051084674617;1976.6738488149438;2261.9095236190615;2308.7114110736156;2316.0504193280676;2318.397216723647;2198.703175071377;2200.922967696123;2210.635245184543;2217.0466699319286;2250.0999600159903;7896.368290536743;7909.129995700526;7942.801429964297;7947.642356093989;7965.163657815904;4840.443349014838;4998.375203099613;5006.073876332854;5009.398872135331;5088.592912567023;3188.98405507971;3262.363839051386;3314.685104915029;3336.666333366644;3343.6823501767294;1166.5392170092766;1176.4705882352976;1185.5672679472018;1203.8735932727025;1212.3453335198983;11461.255018423775;11463.254888432226;11580;11599.94200029003;11607.709807254718;4302;4405.823767049346;4518.43519560055;4544.431946006749;4553.612942899825;9694.466804325688;9762.072603102693;9800.705978820646;9802.5588848502;9804.852927206097;4499.932501012488;5054.039732450822;5060.392752869606;5064.063148317573;5081.339425874687;4499.257622492318;4582.106489234568;4582.908341833145;4589.724616522953;4614.261718125151;3861.6331448512346;3888.8833334999995;3951.05174758056;3980.7611543307494;3990.880273591797;1232.186756740547;1247.1020864977202;1254.140913474273;1261.0605099201155;1269.5620011096157;923.8798956135794;971.4802580619335;1004.9346792458467;1018.4551265073299;1023.7594165371132;5747.224124743189;5847.327557330961;5917.674527900921;5931.13998470228;6013.819585412444;409.57608874814423;410.1080150672276;426.09242313871255;426.22214458613155;431.6870269054973;3962.4254483100367;4102.528209255914;4109.732867363612;4112;4145.647619952278;10009.69970900874;10315.948420258;10332.896671033344;10333.534990925426;10345.74135646615;9891.258155638212;10160.441175735257;10255.128314093387;10259.28185027056;10309.329893556895;7565.394768418513;7608.277213664583;7642.541447513167;7644.503107298008;7679.923200768033;5400.918986215289;5667.744951477111;5730.369659337553;5917.970410147922;5926.555508336805;8893.110688931314;9232.907670923474;9346.626134954526;9360.625574976924;9370.34407591462;9224.631014759603;9499.335046546676;9508.239340852853;9556.713298601053;9600.135987760856;6528.281888992302;6918.688659010458;7029.578225306498;7061.258567850302;7238.963805180941;7742;7755.961220193863;7814.88277675824;7814.960925195565;7821.921780782347;6968.616726079911;7192.748253811092;7275.672594733144;7282.5994570297025;7362.963185184254;7204;7221.602811845399;7241.855162896818;7253.088732682847;7296.1974182838785;6508.446782023581;6567.310432404529;6578.210614726264;6583.670816459254;6588.374104460068;4981.178105612534;5114.053900028358;5125;5136.0241554104605;5146.665466744649;5017.724025178651;5106.872328191825;5110.182370820651;5146.356705411824;5266.868328291824 20:13:51 INFO - PROCESS | 26259 | |4;prototype.html;303.22072274255174;305.24451981346164;307.36375702296243;314.4308801070062;318.7290802817604;5525;5558.305211848519;5585.776568937237;5742.712864356781;5743.655380677163;5610.4670056344685;5651.689157096358;5654.349749778767;5655.660660360371;5709.257796486451;4345.239583072966;4356.019895523514;4363.650907927374;4376.627986621141;4382.9342559861625;4165.271747005701;4286.935695964563;4297.935530967023;4379.5182529921685;4380.605745482906;4245.2783026885345;4245.936310955338;4249.298865687158;4250.61744443;4257.552956939523;4237.915241695149;4238.279492486285;4239.10978694473;4246.447961764966;4248.978755106235;3528.2237907660274;3664.963350366489;3683.710701254566;3696.3346597612417;3698.3712768829364;5342.545883599899;5376.193570964348;5443.047466693313;5443.727813609304;5462.562994960394;4899.412070551557;4901.558859702608;4912.263160525914;4917.950820491785;4937.308776771255;5549.5005449509335;5834.474897259224;5842.591018628697;5865.530757539386;5894.204282421861;4092.3630547780826;4104.322786740185;4114.691398145121;4119.546849846514;4129.421880936671;6070.816190842787;6120.693965301717;6126.417990290915;6186.4741496972365;6190.2571691397325;4042.413849991735;4145.958540414557;4149.066460046526;4166.999920019173;4211.389348544505;4196.81114349855;4227.217964676544;4237.385579091015;4240.809163587646;4255.319148936155;4846.684965477232;4870.342503762017;4872.829450969199;4876.29293752411;4913.950860491349;5477.397486276506;5780;5837.540614846288;5908.527317814564;5910.822675319747;1453.9418423263162;1456.097219723778;1471.9852801472061;1472.874805641511;1475.7491226491522;946.5740416812462;950.382251536493;978.6379039755336;979.5787811241235;981.3277904635347;5724.198612194296;5737.311522617312;5743.655380677173;5766.135079737989;5784.913226301609;6097.725602347905;6121.693915304217;6132.846678832976;6144.477719393902;6160.10678451631;5609.663420194802;5776.566757493205;5777.88444231113;5784.132380142928;5797.304323481209;3255.186203449138;3272.3946069977133;3272.4927636216426;3275.836208189581;3285.7699961002977;6110.7861224856915;6313.179286692793;6315.431611154926;6332.68336583169;6348.650824204621;6294.307626161119;6300.621962682254;6313.147725057151;6325.082862984841;6330.746770129143;6264.874702506016;6351.396617321347;6391.680415979183;6395.712192951329;6454.548181627335;6160.7535698571555;6160.876782464236;6188.721507532082;6192.133101365723;6201.937980620136;5986.191864098291;6106.175666284995;6125.540584456095;6151.446369826737;6162.476189523941;6174.6912654368;6350.983842585164;6393.424591786761;6393.584417012879;6454.48364130859;4338;4359.389685444104;4369.71596846204;4371.235033868997;4375.934360984524;5915.40845915405;5949.553783466171;6165.071590994421;6173.382661733791;6174.166487524127;5806.5064469518875;5978.521718262442;5981;5991.850203744942;6010.849728756816;5908.291005079418;5952.285725712942;5990.820275391745;6022.789202377896;6025.307089684742;5651.886962260814;5837.416258374298;5882.911756323744;5886.970565147147;5893.381194974466;5903.586748927534;5944.375840536854;5957.434043765836;6000.5799594028;6010.939890601038;5728.570357223141;5802.085311847165;5871.970640146772;5873.2658417697785;5889.49939255151 20:13:51 INFO - PROCESS | 26259 | |5;yui.html;819.6229734322211;831.538496134645;844.168494033377;844.4553263145268;850.07766573268;13271.402786874589;13532;13737.31313434328;13959.79060314096;13965.650858728537;11977.880221197785;13186.142900711448;13200.603981880558;13270.93364533176;13276.668083297898;789.7749141494661;809.8663720486113;810.5501446697081;810.8459392715365;811.5495899775622;796.2674339607574;801.9037715474151;806.6289506826837;812.5733989655419;818.9344852411792;707.2008630247813;851.0043249398188;852.5098068610542;853.8847255620474;854.6666799947994;719.1118968074423;722.1947528505731;836.8368168207232;845.5729856422529;847.4618617178136;614.790971069834;614.9631022138686;615.9436566288836;624.3506752976898;629.7260691599168;13583.796243056362;13670;13679.658008549766;13686.452541898312;13696.863031369658;13127.212367257995;13296.867031329659;13307.933460332637;13416.195028298333;13760.93119534396;10864;11017.559297628086;11146.498407571678;11669.241499302603;12111.515539378413;3849.9230015399535;3850.306944749944;3889.8249578769023;3920.470736450571;3989.1024519482885;56103;58156.418435815525;58166.12750808741;58364;58458.707706461624;10693.625723099654;10809.189310801721;10834.729131771768;10886.129109671207;11279.605213817642;19944.33218431768;20139.697904531444;20345.186192552428;20366.287179948926;20626.07182676783;7993.6482255479295;7998.400119990907;8066.153053929253;8171.06032806223;8217.630206640715;4324.935125973113;4454.4654641442585;4525.479569849444;4640.83757068501;4696.976515117471;3338.4658454647138;3451.4822776583715;3451.516787649731;3454.531823974801;3456.2569047654874;630.9621422714652;634.8159033880215;640.6572483721187;642.1523588862657;648.2447948140364;565.5588640860136;621.0071028927463;638.6008744534665;666.9299723529057;760.81360066784;9032.774180645536;9096.408733432305;9184.311176661777;9411.670591529264;9573.28200384974;692.4910191009604;717.3113810741746;721.9711211551585;731.381982225019;736.3372964332037;4307.806148723253;4459.643228541709;4467.463904331501;4481.7983190756495;4522.3668686383935;64811.351886481476;66531.33468665348;66960;67096.32903670901;67098.66450667716;54029.1895621566;57135;57968;58182.70908645514;58588.707056464445;49441;49813.50186498161;50019.499805001484;50342.24486632703;51602.74198629058;8311.83376332458;8387.958060209903;8525.403221774664;8607.18231767981;8680.869786953075;33492.66507334895;33532.32935341328;34052.489212661334;34386.828065860514;34963.65036349604;42465.15069698651;44939.55060449354;46479.30281045719;47432.7628361856;47955;11640.417979100841;11885.34630595291;11990;12316.815247771112;12400.503979841065;13704.931475342559;13902.86097139056;14056.929715351358;14314.928425357806;14793.11241325524;9616.230701544;12925.935370323088;13103.2138071716;13854.238016908763;14148.292585370484;12641.620751377473;12957.870421295667;13097.869021310045;13210.603681889559;13229.404676789374;13359.575594697026;13447.46210151583;13474;13534.59396218115;13802.378892950042;9894.653687120915;10078.344907580984;10629.25595208328;10758.946205268923;10993.285436446606;10616.097631701392;10657.89342106569;10821.182654927345;10963.616273430393;10980.725481863017 20:13:51 INFO - PROCESS | 26259 | __end_tp_report 20:13:51 INFO - PROCESS | 26259 | __start_cc_report 20:13:51 INFO - PROCESS | 26259 | _x_x_mozilla_cycle_collect,787 20:13:51 INFO - PROCESS | 26259 | __end_cc_report 20:13:51 INFO - PROCESS | 26259 | __startTimestamp1460776431712__endTimestamp 20:13:51 INFO - PROCESS | 26259 | 20:13:51 INFO - PROCESS | 26259 | ------- Summary: start ------- 20:13:51 INFO - PROCESS | 26259 | Number of tests: 6 20:13:51 INFO - PROCESS | 26259 | 20:13:51 INFO - PROCESS | 26259 | [#0] dojo.html Cycles:165 Average:5227.84 Median:5432.65 stddev:576.57 (10.6%) stddev-sans-first:552.01 20:13:51 INFO - PROCESS | 26259 | Values: 3032.1 3088.7 3111.0 3125.1 3152.7 5226.8 5263.2 5268.5 5299.6 5316.9 5257.6 5328.7 5378.1 5404.1 5429.9 4737.5 4759.5 4774.8 4780.8 4860.9 4866.2 4872.3 4913.7 4918.3 4942.2 4679.7 4762.7 4765.1 4843.5 4867.2 4828.1 4843.3 4848.2 4855.7 4859.8 4783.9 4805.3 4809.4 4821.0 4827.6 5262.2 5265.6 5286.3 5287.1 5288.7 5636.6 5674.3 5674.4 5679.9 5682.5 5501.9 5613.3 5692.3 5713.3 5724.8 5171.7 5207.5 5210.6 5213.1 5270.5 5633.5 5684.1 5684.5 5686.5 5692.3 5463.6 5470.3 5479.9 5524.5 5539.9 5559.5 5560.2 5561.4 5562.0 5562.1 5517.3 5523.9 5525.4 5528.0 5577.0 5472.4 5581.9 5657.0 5664.6 5666.0 4245.7 4250.4 4250.6 4260.3 4290.2 3820.5 3828.7 3841.7 3854.2 3858.3 5233.4 5290.2 5332.4 5370.1 5373.4 5601.4 5616.6 5633.2 5635.7 5636.1 5312.4 5321.0 5322.0 5327.6 5375.1 4814.4 4902.6 4919.2 4952.0 4974.4 5723.6 5729.5 5731.5 5733.6 5802.5 5474.3 5545.1 5595.0 5612.1 5658.8 5810.0 5842.4 5865.5 5882.0 5912.5 5521.7 5529.4 5532.6 5535.9 5537.8 5535.3 5624.8 5634.0 5635.6 5639.8 5499.1 5535.2 5537.5 5557.2 5583.7 5436.3 5436.4 5439.9 5440.4 5445.8 5321.2 5324.7 5345.4 5371.3 5414.3 5566.0 5567.6 5568.4 5578.6 5632.9 5397.4 5422.8 5432.6 5441.9 5464.1 20:13:51 INFO - PROCESS | 26259 | 20:13:51 INFO - PROCESS | 26259 | [#1] ext.html Cycles:180 Average:54299.23 Median:34154.33 stddev:108268.41 (317.0%) stddev-sans-first:108497.05 20:13:51 INFO - PROCESS | 26259 | Values: 595.4 619.7 640.0 659.7 673.2 30282.0 37964.4 38811.0 38901.8 38931.2 41161.4 41757.8 41903.0 41910.8 42057.6 7586.0 8441.7 8630.0 8634.0 9905.3 10009.9 10127.0 10152.4 10157.3 10157.6 10136.4 10261.7 10262.0 10270.3 10273.1 7951.2 10211.2 10283.1 10798.9 10801.2 10347.1 10476.1 10513.9 10521.8 10532.1 40982.7 41160.6 41398.4 41517.4 41530.6 3653.4 3688.9 3826.6 3924.2 4056.8 31972.7 32095.2 32339.8 32445.7 33756.0 4367.3 4380.8 4392.6 4522.7 4571.7 314436.0 314645.0 316092.0 316095.0 317978.0 35356.1 36295.8 36318.6 36332.3 59143.1 33781.7 34015.3 34096.3 34107.0 34215.3 15004.5 15097.1 15135.2 15268.4 15321.8 12496.2 12558.7 12584.6 12607.4 12763.0 8581.1 8635.2 8669.6 8698.2 8698.3 3067.6 3083.7 3273.9 3354.1 3370.5 1055.9 1092.8 1095.0 1126.0 1191.9 29163.7 30315.0 30423.4 30616.4 30803.5 1129.3 1135.5 1186.8 1205.0 1224.0 14689.8 15176.2 15369.9 15449.7 15605.3 481253.0 481570.0 485324.0 485351.0 486150.0 56966.0 57629.4 57662.4 57672.7 57969.4 1358.1 1392.3 1396.4 1407.8 1416.4 28356.3 28892.1 29484.0 29506.0 29868.7 46807.7 47722.0 47752.0 47758.3 47759.0 400809.0 407742.0 408972.0 410122.0 410333.0 24991.9 25774.0 27409.2 27570.3 27959.3 41009.4 41773.4 41851.4 42342.0 42491.8 35010.3 35271.3 35317.8 35621.1 35984.5 34008.5 34201.7 34217.7 34235.3 34431.3 36623.0 38559.2 39328.8 39565.4 39960.6 32603.3 34462.7 34524.1 34596.3 34961.3 26828.0 27056.7 27238.3 27271.3 27280.7 20:13:51 INFO - PROCESS | 26259 | 20:13:51 INFO - PROCESS | 26259 | [#2] jquery.html Cycles:180 Average:27707.74 Median:14874.19 stddev:78198.86 (525.7%) stddev-sans-first:78391.32 20:13:51 INFO - PROCESS | 26259 | Values: 387.8 388.9 395.1 396.8 400.1 14417.8 15274.5 17435.7 17998.6 18014.1 11637.2 12067.1 17177.1 18015.3 18031.3 5037.5 5103.3 5161.5 5178.4 5189.4 3871.7 5041.4 5090.6 5509.7 5806.9 5713.9 5780.2 5800.3 5805.6 5809.3 5722.2 5760.5 5795.9 5796.2 5799.6 5426.4 5512.3 5513.3 5521.8 5524.2 13555.9 17043.1 19880.5 22808.0 22829.1 2367.8 2460.3 2462.8 2766.2 2873.5 9546.7 9692.3 9741.5 10053.0 10421.5 1864.3 1896.1 1903.9 1952.5 1976.4 77185.2 77331.0 81439.2 81627.6 82383.2 10910.7 10956.8 10975.9 11018.9 11046.8 15064.7 15102.2 15120.2 15155.9 15164.3 7875.0 8127.5 8207.3 8259.9 8316.2 7686.1 7702.9 7765.9 7885.9 7894.7 4612.4 4637.4 4652.1 4655.3 4691.7 1826.3 1858.5 1872.4 1875.9 1880.6 924.4 1027.8 1029.6 1052.1 1084.3 18079.0 19184.3 19231.5 19293.5 19346.0 972.9 994.7 1003.9 1030.4 1044.9 10283.4 10685.5 10774.4 10775.2 10811.2 446417.0 464652.0 482265.0 485907.0 490807.0 88359.6 89108.0 89541.0 89658.0 90985.0 1012.6 1022.1 1071.8 1091.1 1093.8 16353.8 16475.3 16790.0 16871.0 17015.1 27285.6 33754.7 35968.1 36492.6 37140.4 50390.0 52715.0 52720.7 52722.0 52807.5 8450.8 8584.4 8671.4 8688.8 8812.0 9478.8 12932.2 13113.7 13470.7 13610.8 11343.7 11759.6 11813.3 11862.9 11931.6 11124.4 11280.7 11285.4 11456.6 11556.7 11377.6 11850.7 11888.0 12009.5 12145.5 8318.9 8364.5 8437.9 8549.5 8739.7 10538.7 11891.2 11900.5 11903.4 11955.4 20:13:51 INFO - PROCESS | 26259 | 20:13:51 INFO - PROCESS | 26259 | [#3] mootools.html Cycles:180 Average:5470.57 Median:5002.22 stddev:3048.44 (60.9%) stddev-sans-first:3040.98 20:13:51 INFO - PROCESS | 26259 | Values: 1312.7 1347.2 1441.9 1513.5 1765.0 7999.6 8293.8 8296.0 8297.6 8308.5 8005.3 8136.3 8161.0 8172.5 8178.1 2020.1 2250.9 2287.4 2317.2 2326.7 2251.7 2300.1 2315.3 2318.4 2320.8 2266.0 2308.1 2310.9 2314.7 2316.3 1976.7 2261.9 2308.7 2316.1 2318.4 2198.7 2200.9 2210.6 2217.0 2250.1 7896.4 7909.1 7942.8 7947.6 7965.2 4840.4 4998.4 5006.1 5009.4 5088.6 3189.0 3262.4 3314.7 3336.7 3343.7 1166.5 1176.5 1185.6 1203.9 1212.3 11461.3 11463.3 11580.0 11599.9 11607.7 4302.0 4405.8 4518.4 4544.4 4553.6 9694.5 9762.1 9800.7 9802.6 9804.9 4499.9 5054.0 5060.4 5064.1 5081.3 4499.3 4582.1 4582.9 4589.7 4614.3 3861.6 3888.9 3951.1 3980.8 3990.9 1232.2 1247.1 1254.1 1261.1 1269.6 923.9 971.5 1004.9 1018.5 1023.8 5747.2 5847.3 5917.7 5931.1 6013.8 409.6 410.1 426.1 426.2 431.7 3962.4 4102.5 4109.7 4112.0 4145.6 10009.7 10315.9 10332.9 10333.5 10345.7 9891.3 10160.4 10255.1 10259.3 10309.3 7565.4 7608.3 7642.5 7644.5 7679.9 5400.9 5667.7 5730.4 5918.0 5926.6 8893.1 9232.9 9346.6 9360.6 9370.3 9224.6 9499.3 9508.2 9556.7 9600.1 6528.3 6918.7 7029.6 7061.3 7239.0 7742.0 7756.0 7814.9 7815.0 7821.9 6968.6 7192.7 7275.7 7282.6 7363.0 7204.0 7221.6 7241.9 7253.1 7296.2 6508.4 6567.3 6578.2 6583.7 6588.4 4981.2 5114.1 5125.0 5136.0 5146.7 5017.7 5106.9 5110.2 5146.4 5266.9 20:13:51 INFO - PROCESS | 26259 | 20:13:51 INFO - PROCESS | 26259 | [#4] prototype.html Cycles:180 Average:4965.70 Median:5743.18 stddev:1506.06 (26.2%) stddev-sans-first:1469.07 20:13:51 INFO - PROCESS | 26259 | Values: 303.2 305.2 307.4 314.4 318.7 5525.0 5558.3 5585.8 5742.7 5743.7 5610.5 5651.7 5654.3 5655.7 5709.3 4345.2 4356.0 4363.7 4376.6 4382.9 4165.3 4286.9 4297.9 4379.5 4380.6 4245.3 4245.9 4249.3 4250.6 4257.6 4237.9 4238.3 4239.1 4246.4 4249.0 3528.2 3665.0 3683.7 3696.3 3698.4 5342.5 5376.2 5443.0 5443.7 5462.6 4899.4 4901.6 4912.3 4918.0 4937.3 5549.5 5834.5 5842.6 5865.5 5894.2 4092.4 4104.3 4114.7 4119.5 4129.4 6070.8 6120.7 6126.4 6186.5 6190.3 4042.4 4146.0 4149.1 4167.0 4211.4 4196.8 4227.2 4237.4 4240.8 4255.3 4846.7 4870.3 4872.8 4876.3 4914.0 5477.4 5780.0 5837.5 5908.5 5910.8 1453.9 1456.1 1472.0 1472.9 1475.7 946.6 950.4 978.6 979.6 981.3 5724.2 5737.3 5743.7 5766.1 5784.9 6097.7 6121.7 6132.8 6144.5 6160.1 5609.7 5776.6 5777.9 5784.1 5797.3 3255.2 3272.4 3272.5 3275.8 3285.8 6110.8 6313.2 6315.4 6332.7 6348.7 6294.3 6300.6 6313.1 6325.1 6330.7 6264.9 6351.4 6391.7 6395.7 6454.5 6160.8 6160.9 6188.7 6192.1 6201.9 5986.2 6106.2 6125.5 6151.4 6162.5 6174.7 6351.0 6393.4 6393.6 6454.5 4338.0 4359.4 4369.7 4371.2 4375.9 5915.4 5949.6 6165.1 6173.4 6174.2 5806.5 5978.5 5981.0 5991.9 6010.8 5908.3 5952.3 5990.8 6022.8 6025.3 5651.9 5837.4 5882.9 5887.0 5893.4 5903.6 5944.4 5957.4 6000.6 6010.9 5728.6 5802.1 5872.0 5873.3 5889.5 20:13:51 INFO - PROCESS | 26259 | 20:13:51 INFO - PROCESS | 26259 | [#5] yui.html Cycles:180 Average:15100.00 Median:24730.96 stddev:17841.16 (72.1%) stddev-sans-first:17858.98 20:13:51 INFO - PROCESS | 26259 | Values: 819.6 831.5 844.2 844.5 850.1 13271.4 13532.0 13737.3 13959.8 13965.7 11977.9 13186.1 13200.6 13270.9 13276.7 789.8 809.9 810.6 810.8 811.5 796.3 801.9 806.6 812.6 818.9 707.2 851.0 852.5 853.9 854.7 719.1 722.2 836.8 845.6 847.5 614.8 615.0 615.9 624.4 629.7 13583.8 13670.0 13679.7 13686.5 13696.9 13127.2 13296.9 13307.9 13416.2 13760.9 10864.0 11017.6 11146.5 11669.2 12111.5 3849.9 3850.3 3889.8 3920.5 3989.1 56103.0 58156.4 58166.1 58364.0 58458.7 10693.6 10809.2 10834.7 10886.1 11279.6 19944.3 20139.7 20345.2 20366.3 20626.1 7993.6 7998.4 8066.2 8171.1 8217.6 4324.9 4454.5 4525.5 4640.8 4697.0 3338.5 3451.5 3451.5 3454.5 3456.3 631.0 634.8 640.7 642.2 648.2 565.6 621.0 638.6 666.9 760.8 9032.8 9096.4 9184.3 9411.7 9573.3 692.5 717.3 722.0 731.4 736.3 4307.8 4459.6 4467.5 4481.8 4522.4 64811.4 66531.3 66960.0 67096.3 67098.7 54029.2 57135.0 57968.0 58182.7 58588.7 49441.0 49813.5 50019.5 50342.2 51602.7 8311.8 8388.0 8525.4 8607.2 8680.9 33492.7 33532.3 34052.5 34386.8 34963.7 42465.2 44939.6 46479.3 47432.8 47955.0 11640.4 11885.3 11990.0 12316.8 12400.5 13704.9 13902.9 14056.9 14314.9 14793.1 9616.2 12925.9 13103.2 13854.2 14148.3 12641.6 12957.9 13097.9 13210.6 13229.4 13359.6 13447.5 13474.0 13534.6 13802.4 9894.7 10078.3 10629.3 10758.9 10993.3 10616.1 10657.9 10821.2 10963.6 10980.7 20:13:51 INFO - PROCESS | 26259 | -------- Summary: end -------- 20:13:51 INFO - PROCESS | 26259 | 20:13:52 INFO - TEST-INFO | 26259: exit 0 20:13:52 INFO - TEST-OK | dromaeo_css | took 1112458ms 20:13:52 INFO - TEST-START | kraken 20:13:52 INFO - operating with platform_type : linux_ 20:13:52 INFO - Initialising browser for kraken test... 20:13:52 INFO - TEST-INFO | started process 26439 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWDAQcS/profile http://localhost:44832/getInfo.html) 20:13:56 INFO - PROCESS | 26439 | __metrics Screen width/height:1600/1200 20:13:56 INFO - PROCESS | 26439 | colorDepth:24 20:13:56 INFO - PROCESS | 26439 | Browser inner width/height: 1024/697 20:13:56 INFO - PROCESS | 26439 | __metrics 20:13:57 ERROR - PROCESS | 26439 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 20:13:58 INFO - TEST-INFO | 26439: exit 0 20:13:58 INFO - Browser initialized. 20:13:58 INFO - Running cycle 1/1 for kraken test... 20:13:58 INFO - TEST-INFO | started process 26524 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWDAQcS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:14:10 INFO - PROCESS | 26524 | RSS: Main: 153411584 20:14:10 INFO - PROCESS | 26524 | 20:14:12 INFO - PROCESS | 26524 | Cycle 1(1): loaded http://localhost:44832/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44832/tests/kraken/driver.html?testName=audio-beat-detection) 20:14:13 INFO - PROCESS | 26524 | RSS: Main: 208924672 20:14:13 INFO - PROCESS | 26524 | 20:14:16 INFO - PROCESS | 26524 | Cycle 1(1): loaded http://localhost:44832/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44832/tests/kraken/driver.html?testName=audio-dft) 20:14:16 INFO - PROCESS | 26524 | RSS: Main: 193785856 20:14:16 INFO - PROCESS | 26524 | 20:14:20 INFO - PROCESS | 26524 | Cycle 1(1): loaded http://localhost:44832/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44832/tests/kraken/driver.html?testName=audio-fft) 20:14:20 INFO - PROCESS | 26524 | RSS: Main: 265789440 20:14:20 INFO - PROCESS | 26524 | 20:14:22 INFO - PROCESS | 26524 | Cycle 1(1): loaded http://localhost:44832/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44832/tests/kraken/driver.html?testName=audio-oscillator) 20:14:23 INFO - PROCESS | 26524 | RSS: Main: 173010944 20:14:23 INFO - PROCESS | 26524 | 20:14:25 INFO - PROCESS | 26524 | Cycle 1(1): loaded http://localhost:44832/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44832/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:14:26 INFO - PROCESS | 26524 | RSS: Main: 176926720 20:14:26 INFO - PROCESS | 26524 | 20:14:29 INFO - PROCESS | 26524 | Cycle 1(1): loaded http://localhost:44832/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44832/tests/kraken/driver.html?testName=imaging-darkroom) 20:14:29 INFO - PROCESS | 26524 | RSS: Main: 213299200 20:14:29 INFO - PROCESS | 26524 | 20:14:33 INFO - PROCESS | 26524 | Cycle 1(1): loaded http://localhost:44832/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44832/tests/kraken/driver.html?testName=imaging-desaturate) 20:14:33 INFO - PROCESS | 26524 | RSS: Main: 214552576 20:14:33 INFO - PROCESS | 26524 | 20:14:36 INFO - PROCESS | 26524 | Cycle 1(1): loaded http://localhost:44832/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44832/tests/kraken/driver.html?testName=json-parse-financial) 20:14:36 INFO - PROCESS | 26524 | RSS: Main: 214364160 20:14:36 INFO - PROCESS | 26524 | 20:14:38 INFO - PROCESS | 26524 | Cycle 1(1): loaded http://localhost:44832/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44832/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:14:39 INFO - PROCESS | 26524 | RSS: Main: 202326016 20:14:39 INFO - PROCESS | 26524 | 20:14:40 INFO - PROCESS | 26524 | Cycle 1(1): loaded http://localhost:44832/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44832/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:14:41 INFO - PROCESS | 26524 | RSS: Main: 202170368 20:14:41 INFO - PROCESS | 26524 | 20:14:43 INFO - PROCESS | 26524 | Cycle 1(1): loaded http://localhost:44832/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44832/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:14:44 INFO - PROCESS | 26524 | RSS: Main: 218284032 20:14:44 INFO - PROCESS | 26524 | 20:14:46 INFO - PROCESS | 26524 | Cycle 1(1): loaded http://localhost:44832/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44832/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:14:47 INFO - PROCESS | 26524 | RSS: Main: 222294016 20:14:47 INFO - PROCESS | 26524 | 20:14:49 INFO - PROCESS | 26524 | Cycle 1(1): loaded http://localhost:44832/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44832/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:14:50 INFO - PROCESS | 26524 | RSS: Main: 218300416 20:14:50 INFO - PROCESS | 26524 | 20:14:52 INFO - PROCESS | 26524 | Cycle 1(1): loaded http://localhost:44832/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44832/tests/kraken/driver.html?testName=ai-astar) 20:14:52 INFO - PROCESS | 26524 | RSS: Main: 282308608 20:14:52 INFO - PROCESS | 26524 | 20:14:52 INFO - PROCESS | 26524 | __start_tp_report 20:14:52 INFO - PROCESS | 26524 | _x_x_mozilla_page_load 20:14:52 INFO - PROCESS | 26524 | _x_x_mozilla_page_load_details 20:14:52 INFO - PROCESS | 26524 | |i|pagename|runs| 20:14:52 INFO - PROCESS | 26524 | |0;ai-astar;111;115;109;114;112;111;100;112;111;113 20:14:52 INFO - PROCESS | 26524 | |1;audio-beat-detection;162;128;161;192;129;164;160;130;191;138 20:14:52 INFO - PROCESS | 26524 | |2;audio-dft;162;161;161;162;161;162;163;164;163;161 20:14:52 INFO - PROCESS | 26524 | |3;audio-fft;76;76;105;116;76;76;72;118;104;78 20:14:52 INFO - PROCESS | 26524 | |4;audio-oscillator;91;92;153;92;92;94;155;92;92;155 20:14:52 INFO - PROCESS | 26524 | |5;imaging-gaussian-blur;116;117;117;117;118;117;116;116;117;117 20:14:52 INFO - PROCESS | 26524 | |6;imaging-darkroom;146;145;146;145;146;145;145;145;145;145 20:14:52 INFO - PROCESS | 26524 | |7;imaging-desaturate;95;94;94;94;95;95;94;95;94;95 20:14:52 INFO - PROCESS | 26524 | |8;json-parse-financial;56;56;55;56;55;57;55;74;55;53 20:14:52 INFO - PROCESS | 26524 | |9;json-stringify-tinderbox;61;61;61;61;61;64;62;62;62;61 20:14:52 INFO - PROCESS | 26524 | |10;stanford-crypto-aes;75;77;76;76;77;76;76;76;78;76 20:14:52 INFO - PROCESS | 26524 | |11;stanford-crypto-ccm;126;125;123;138;125;124;132;123;152;128 20:14:52 INFO - PROCESS | 26524 | |12;stanford-crypto-pbkdf2;163;161;162;162;162;163;161;163;162;162 20:14:52 INFO - PROCESS | 26524 | |13;stanford-crypto-sha256-iterative;69;70;70;71;68;66;69;67;68;66 20:14:52 INFO - PROCESS | 26524 | __end_tp_report 20:14:52 INFO - PROCESS | 26524 | __start_cc_report 20:14:52 INFO - PROCESS | 26524 | _x_x_mozilla_cycle_collect,1616 20:14:52 INFO - PROCESS | 26524 | __end_cc_report 20:14:52 INFO - PROCESS | 26524 | __startTimestamp1460776492480__endTimestamp 20:14:52 INFO - PROCESS | 26524 | 20:14:52 INFO - PROCESS | 26524 | ------- Summary: start ------- 20:14:52 INFO - PROCESS | 26524 | Number of tests: 14 20:14:52 INFO - PROCESS | 26524 | 20:14:52 INFO - PROCESS | 26524 | [#0] ai-astar Cycles:10 Average:110.80 Median:112.00 stddev:4.16 (3.7%) stddev-sans-first:4.41 20:14:52 INFO - PROCESS | 26524 | Values: 111.0 115.0 109.0 114.0 112.0 111.0 100.0 112.0 111.0 113.0 20:14:52 INFO - PROCESS | 26524 | 20:14:52 INFO - PROCESS | 26524 | [#1] audio-beat-detection Cycles:10 Average:155.50 Median:161.50 stddev:23.97 (14.8%) stddev-sans-first:25.31 20:14:52 INFO - PROCESS | 26524 | Values: 162.0 128.0 161.0 192.0 129.0 164.0 160.0 130.0 191.0 138.0 20:14:52 INFO - PROCESS | 26524 | 20:14:52 INFO - PROCESS | 26524 | [#2] audio-dft Cycles:10 Average:162.00 Median:162.00 stddev:1.05 (0.7%) stddev-sans-first:1.12 20:14:52 INFO - PROCESS | 26524 | Values: 162.0 161.0 161.0 162.0 161.0 162.0 163.0 164.0 163.0 161.0 20:14:52 INFO - PROCESS | 26524 | 20:14:52 INFO - PROCESS | 26524 | [#3] audio-fft Cycles:10 Average:89.70 Median:76.00 stddev:18.66 (24.5%) stddev-sans-first:19.12 20:14:52 INFO - PROCESS | 26524 | Values: 76.0 76.0 105.0 116.0 76.0 76.0 72.0 118.0 104.0 78.0 20:14:52 INFO - PROCESS | 26524 | 20:14:52 INFO - PROCESS | 26524 | [#4] audio-oscillator Cycles:10 Average:110.80 Median:92.00 stddev:30.05 (32.7%) stddev-sans-first:31.01 20:14:52 INFO - PROCESS | 26524 | Values: 91.0 92.0 153.0 92.0 92.0 94.0 155.0 92.0 92.0 155.0 20:14:52 INFO - PROCESS | 26524 | 20:14:52 INFO - PROCESS | 26524 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.60 20:14:52 INFO - PROCESS | 26524 | Values: 116.0 117.0 117.0 117.0 118.0 117.0 116.0 116.0 117.0 117.0 20:14:52 INFO - PROCESS | 26524 | 20:14:52 INFO - PROCESS | 26524 | [#6] imaging-darkroom Cycles:10 Average:145.30 Median:145.00 stddev:0.48 (0.3%) stddev-sans-first:0.44 20:14:52 INFO - PROCESS | 26524 | Values: 146.0 145.0 146.0 145.0 146.0 145.0 145.0 145.0 145.0 145.0 20:14:52 INFO - PROCESS | 26524 | 20:14:52 INFO - PROCESS | 26524 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:95.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 20:14:52 INFO - PROCESS | 26524 | Values: 95.0 94.0 94.0 94.0 95.0 95.0 94.0 95.0 94.0 95.0 20:14:52 INFO - PROCESS | 26524 | 20:14:52 INFO - PROCESS | 26524 | [#8] json-parse-financial Cycles:10 Average:57.20 Median:56.00 stddev:6.00 (10.7%) stddev-sans-first:6.34 20:14:52 INFO - PROCESS | 26524 | Values: 56.0 56.0 55.0 56.0 55.0 57.0 55.0 74.0 55.0 53.0 20:14:52 INFO - PROCESS | 26524 | 20:14:52 INFO - PROCESS | 26524 | [#9] json-stringify-tinderbox Cycles:10 Average:61.60 Median:61.50 stddev:0.97 (1.6%) stddev-sans-first:1.00 20:14:52 INFO - PROCESS | 26524 | Values: 61.0 61.0 61.0 61.0 61.0 64.0 62.0 62.0 62.0 61.0 20:14:52 INFO - PROCESS | 26524 | 20:14:52 INFO - PROCESS | 26524 | [#10] stanford-crypto-aes Cycles:10 Average:76.30 Median:76.00 stddev:0.82 (1.1%) stddev-sans-first:0.73 20:14:52 INFO - PROCESS | 26524 | Values: 75.0 77.0 76.0 76.0 77.0 76.0 76.0 76.0 78.0 76.0 20:14:52 INFO - PROCESS | 26524 | 20:14:52 INFO - PROCESS | 26524 | [#11] stanford-crypto-ccm Cycles:10 Average:129.60 Median:127.00 stddev:9.16 (7.2%) stddev-sans-first:9.62 20:14:52 INFO - PROCESS | 26524 | Values: 126.0 125.0 123.0 138.0 125.0 124.0 132.0 123.0 152.0 128.0 20:14:52 INFO - PROCESS | 26524 | 20:14:52 INFO - PROCESS | 26524 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.10 Median:162.00 stddev:0.74 (0.5%) stddev-sans-first:0.71 20:14:52 INFO - PROCESS | 26524 | Values: 163.0 161.0 162.0 162.0 162.0 163.0 161.0 163.0 162.0 162.0 20:14:52 INFO - PROCESS | 26524 | 20:14:52 INFO - PROCESS | 26524 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.40 Median:69.00 stddev:1.71 (2.5%) stddev-sans-first:1.80 20:14:52 INFO - PROCESS | 26524 | Values: 69.0 70.0 70.0 71.0 68.0 66.0 69.0 67.0 68.0 66.0 20:14:52 INFO - PROCESS | 26524 | -------- Summary: end -------- 20:14:52 INFO - PROCESS | 26524 | 20:14:53 INFO - TEST-INFO | 26524: exit 0 20:14:53 INFO - TEST-OK | kraken | took 61043ms 20:14:53 INFO - SUITE-END | took 1173s 20:14:53 INFO - Completed test suite (00:19:33) 20:14:53 INFO - javascript benchmark 20:14:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3032.1206850013496, 3088.66024737279, 3110.9688903110978, 3125.1405863387567, 3152.7320177784895, 5226.7647955841985, 5263.184206447997, 5268.4731526847345, 5299.60252981026, 5316.946830531693, 5257.631965762398, 5328.706921119337, 5378.112611419121, 5404.081306177949, 5429.918551221735, 4737.478877323491, 4759.524047595248, 4774.7612619369065, 4780.832670856521, 4860.878478038042, 4866.197077482228, 4872.3422337984275, 4913.680610760289, 4918.262260660912, 4942.15983282841, 4679.719216847, 4762.666613337068, 4765.0946320199055, 4843.515648435164, 4867.1725806612785, 4828.0585285869265, 4843.321934929113, 4848.151573474663, 4855.732934688591, 4859.82990595331, 4783.880402989918, 4805.327254184417, 4809.44691360491, 4821.0357928414105, 4827.637927155477, 5262.210668399771, 5265.605079619044, 5286.259923610698, 5287.101192797195, 5288.65623734456, 5636.577256705723, 5674.319081710221, 5674.404187560329, 5679.886402271932, 5682.488576028136, 5501.944980550184, 5613.298337707786, 5692.260006199168, 5713.3429655589725, 5724.771009159628, 5171.689698618095, 5207.4792520748, 5210.609204309654, 5213.139831927728, 5270.49930256625, 5633.464820842013, 5684.090545512699, 5684.54523638108, 5686.516646085046, 5692.260006199168, 5463.590230732711, 5470.288862447856, 5479.917801232905, 5524.530414914697, 5539.889202215933, 5559.527440167551, 5560.221568980346, 5561.388247292794, 5561.972190139023, 5562.054450743383, 5517.282753242052, 5523.917141242885, 5525.392206857243, 5527.972360138174, 5576.972115139399, 5472.398036216013, 5581.888362232733, 5656.971715141398, 5664.631798933056, 5666.0, 4245.660347172219, 4250.426192463978, 4250.559284116336, 4260.275753121977, 4290.184864875664, 3820.503334566489, 3828.655421012122, 3841.7310788245113, 3854.2291541691775, 3858.3247931611854, 5233.398159211663, 5290.1800220965815, 5332.360116786011, 5370.113931201387, 5373.435789242151, 5601.411851755588, 5616.6068375213345, 5633.211350410946, 5635.746391412396, 5636.126400407943, 5312.442193569696, 5320.962412329559, 5322.0, 5327.573794096463, 5375.1131063374105, 4814.446338671028, 4902.632302577321, 4919.2129259318335, 4952.0, 4974.427940786856, 5723.599348045597, 5729.4843464088435, 5731.484166424958, 5733.569982251264, 5802.47777700009, 5474.315710536183, 5545.057340252248, 5594.9929012777275, 5612.074007788832, 5658.7736490541565, 5810.0, 5842.38654941225, 5865.530757539302, 5882.0, 5912.49743771767, 5521.69630670317, 5529.4470552944385, 5532.612717109763, 5535.8892822142525, 5537.750801214036, 5535.308086489189, 5624.818788054391, 5634.0, 5635.633683810704, 5639.787445699194, 5499.1476321170285, 5535.169724541351, 5537.529310008534, 5557.221988921473, 5583.720813959367, 5436.3476382834315, 5436.374816896107, 5439.918401223906, 5440.42875498067, 5445.83662490126, 5321.201819726917, 5324.733763311897, 5345.358556973188, 5371.301730774974, 5414.269073675004, 5565.972170139124, 5567.638103523258, 5568.387477377566, 5578.609497335147, 5632.915506267491, 5397.433269506645, 5422.783088676409, 5432.6468779529205, 5441.945580544302, 5464.098423760035], "value": 5189.955344788073, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [595.365935278928, 619.7118339971913, 639.9824279395759, 659.7031335898847, 673.1820837682216, 30282.0, 37964.43053354202, 38811.0, 38901.8054909725, 38931.22137557247, 41161.382579261335, 41757.7912110439, 41903.0, 41910.7904460478, 42057.579424205825, 7586.0, 8441.704540341088, 8629.95685021574, 8633.95683021584, 9905.257105717064, 10009.899901001007, 10127.037931396506, 10152.441615711134, 10157.339772914775, 10157.593696252177, 10136.391816491034, 10261.743456413613, 10262.0, 10270.281080324381, 10273.075423211909, 7951.244631760002, 10211.234157438184, 10283.125934295595, 10798.892011079868, 10801.243912926098, 10347.120494757955, 10476.109530689824, 10513.9474302628, 10521.84217236742, 10532.052115309581, 40982.6968168344, 41160.588394116276, 41398.37902431466, 41517.37723934143, 41530.584694152974, 3653.4337177737493, 3688.8524459021605, 3826.6364695353896, 3924.2044051459798, 4056.7971601419813, 31972.680273197202, 32095.197620059684, 32339.83830080858, 32445.67554324474, 33756.0, 4367.2575662137515, 4380.78096095194, 4392.648588112943, 4522.733634582322, 4571.725696458223, 314436.0, 314645.0, 316092.0, 316095.0, 317978.0, 35356.11609709726, 36295.818520907225, 36318.63681363205, 36332.27335453329, 59143.11285330723, 33781.66218337785, 34015.31969360599, 34096.31807363839, 34107.0, 34215.31569368648, 15004.474843380429, 15097.094174349355, 15135.167565783988, 15268.3892644293, 15321.770173447407, 12496.187747796546, 12558.748825023631, 12584.622461326175, 12607.432665530074, 12763.042771792152, 8581.141885811494, 8635.179657932485, 8669.609867555975, 8698.217160455462, 8698.34762392823, 3067.647220569663, 3083.691630836898, 3273.8690452382116, 3354.0608629583758, 3370.4607262837826, 1055.931364461323, 1092.759592889563, 1094.9890501095047, 1125.9718507037226, 1191.9046476281876, 29163.708362916524, 30315.0, 30423.391532169233, 30616.38767224643, 30803.537946930814, 1129.2998341028451, 1135.494704856331, 1186.7685801268842, 1204.987950120505, 1224.0330139189941, 14689.77965330521, 15176.165310908005, 15369.923150384177, 15449.691006180039, 15605.297761600756, 481253.0, 481570.0, 485324.0, 485351.0, 486150.0, 56966.0, 57629.423705762405, 57662.42337576654, 57672.71163644155, 57969.42030579725, 1358.1443690474937, 1392.2551434982236, 1396.406527225925, 1407.7536431124718, 1416.3767942105646, 28356.291092722848, 28892.133236002952, 29484.0, 29506.0, 29868.70131298659, 46807.68096306955, 47722.0, 47752.0, 47758.283625746335, 47759.0, 400809.0, 407742.0, 408972.0, 410122.0, 410333.0, 24991.87504062468, 25774.0, 27409.17772466829, 27570.310742230802, 27959.301017474725, 41009.38485922654, 41773.37339939964, 41851.37222941719, 42342.0, 42491.7875410621, 35010.29979400347, 35271.294574108884, 35317.82341088381, 35621.10947226237, 35984.460233096004, 34008.48987265144, 34201.65798341985, 34217.65782342145, 34235.315293693486, 34431.311373772885, 36623.0, 38559.228815424096, 39328.80335598304, 39565.40651890166, 39960.600393995686, 32603.34793304073, 34462.655373445945, 34524.13689657779, 34596.30807383889, 34961.30077398387, 26828.0, 27056.729432705422, 27238.319042023315, 27271.318217044733, 27280.72719272782], "value": 18372.14732884185, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [387.8293550837631, 388.9436031775391, 395.1169136978852, 396.79168436570797, 400.0997755051134, 14417.78373324401, 15274.541763747078, 17435.65128697427, 17998.640027199464, 18014.099295035245, 11637.243579167349, 12067.094967877423, 17177.141142942866, 18015.279388824463, 18031.27874885006, 5037.471065538111, 5103.2855400244, 5161.458046905077, 5178.430372659023, 5189.377274727038, 3871.748336358142, 5041.420236672775, 5090.592752579803, 5509.696966666832, 5806.883862322751, 5713.942860571383, 5780.1907732917425, 5800.303963524383, 5805.564582656297, 5809.302883653967, 5722.227499287585, 5760.53915686744, 5795.855103622422, 5796.159556864273, 5799.623024503436, 5426.403095659474, 5512.283403157604, 5513.3108361454815, 5521.834344969658, 5524.171374293848, 13555.864441355658, 17043.062631555258, 19880.502987425287, 22808.0, 22829.08683652652, 2367.786899179065, 2460.2619214235656, 2462.790662793647, 2766.1978026372326, 2873.4971380008415, 9546.713598592054, 9692.273079519064, 9741.464219467998, 10053.0, 10421.478926053744, 1864.2915692037075, 1896.0519740129935, 1903.9238430462904, 1952.511872031992, 1976.3971988543487, 77185.22814771892, 77331.0, 81439.18560814434, 81627.5918620409, 82383.17616823815, 10910.672679819618, 10956.780864382827, 10975.926740512668, 11018.944905275583, 11046.834297485544, 15064.698706025818, 15102.244887755569, 15120.168390738396, 15155.924220378827, 15164.317605707769, 7875.0, 8127.5123492589455, 8207.343412526983, 8259.917400825914, 8316.209960053786, 7686.116096648957, 7702.9229707703325, 7765.883511747328, 7885.921140788519, 7894.6842126314305, 4612.400387949612, 4637.443506779208, 4652.116097941448, 4655.301704744248, 4691.695039822401, 1826.2603645523584, 1858.4982054845116, 1872.419549939496, 1875.8874467531991, 1880.6050729346991, 924.3668087360045, 1027.7584767579613, 1029.6447725534679, 1052.095198129608, 1084.262701363065, 18079.0, 19184.328548501013, 19231.51921201953, 19293.475564376084, 19346.0, 972.9270304727174, 994.721477986165, 1003.8845532763679, 1030.4229631406286, 1044.9268551201344, 10283.43441110746, 10685.465726713634, 10774.353538787698, 10775.245732798629, 10811.18916081297, 446417.0, 464652.0, 482265.0, 485907.0, 490807.0, 88359.55820220987, 89108.0, 89541.0, 89658.0, 90985.0, 1012.6050840172338, 1022.1465076661071, 1071.8124328242527, 1091.1052936592077, 1093.8359246112987, 16353.754693679366, 16475.258613362188, 16790.0, 16871.0, 17015.149242537576, 27285.59071613967, 33754.66245337515, 35968.10079748027, 36492.635073648926, 37140.44289335608, 50390.0, 52715.0, 52720.73639631777, 52722.0, 52807.47192528025, 8450.830983380421, 8584.356173287153, 8671.393002489765, 8688.78278043054, 8811.955940220258, 9478.763030924281, 12932.159409638343, 13113.663665154085, 13470.663233419244, 13610.795838062239, 11343.7270964107, 11759.588414405454, 11813.291202527877, 11862.881371186179, 11931.642050738492, 11124.388158651029, 11280.661580152608, 11285.435728213391, 11456.599019034627, 11556.711082222675, 11377.601783937853, 11850.703732406759, 11888.048956083665, 12009.519619215484, 12145.45345459474, 8318.916810831814, 8364.456310339809, 8437.87343189865, 8549.529775862387, 8739.650413983369, 10538.683839484827, 11891.227070240408, 11900.464479098635, 11903.404829758305, 11955.402229888645], "value": 8911.353499124843, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1312.6718320419895, 1347.211881049586, 1441.8774404175645, 1513.5156749840048, 1765.011593507635, 7999.560024198667, 8293.751187464386, 8296.004479462465, 8297.626606802693, 8308.459950103239, 8005.3195478384405, 8136.349092072634, 8160.9591952040155, 8172.509649421039, 8178.141295163997, 2020.101055030512, 2250.8762018089083, 2287.3938406322295, 2317.2353123469215, 2326.7440581536016, 2251.718535183102, 2300.0799680127916, 2315.2822624986225, 2318.420394901275, 2320.8491448055825, 2266.0256089881345, 2308.134449581407, 2310.8844557772127, 2314.722233331994, 2316.3051084674617, 1976.6738488149438, 2261.9095236190615, 2308.7114110736156, 2316.0504193280676, 2318.397216723647, 2198.703175071377, 2200.922967696123, 2210.635245184543, 2217.0466699319286, 2250.0999600159903, 7896.368290536743, 7909.129995700526, 7942.801429964297, 7947.642356093989, 7965.163657815904, 4840.443349014838, 4998.375203099613, 5006.073876332854, 5009.398872135331, 5088.592912567023, 3188.98405507971, 3262.363839051386, 3314.685104915029, 3336.666333366644, 3343.6823501767294, 1166.5392170092766, 1176.4705882352976, 1185.5672679472018, 1203.8735932727025, 1212.3453335198983, 11461.255018423775, 11463.254888432226, 11580.0, 11599.94200029003, 11607.709807254718, 4302.0, 4405.823767049346, 4518.43519560055, 4544.431946006749, 4553.612942899825, 9694.466804325688, 9762.072603102693, 9800.705978820646, 9802.5588848502, 9804.852927206097, 4499.932501012488, 5054.039732450822, 5060.392752869606, 5064.063148317573, 5081.339425874687, 4499.257622492318, 4582.106489234568, 4582.908341833145, 4589.724616522953, 4614.261718125151, 3861.6331448512346, 3888.8833334999995, 3951.05174758056, 3980.7611543307494, 3990.880273591797, 1232.186756740547, 1247.1020864977202, 1254.140913474273, 1261.0605099201155, 1269.5620011096157, 923.8798956135794, 971.4802580619335, 1004.9346792458467, 1018.4551265073299, 1023.7594165371132, 5747.224124743189, 5847.327557330961, 5917.674527900921, 5931.13998470228, 6013.819585412444, 409.57608874814423, 410.1080150672276, 426.09242313871255, 426.22214458613155, 431.6870269054973, 3962.4254483100367, 4102.528209255914, 4109.732867363612, 4112.0, 4145.647619952278, 10009.69970900874, 10315.948420258, 10332.896671033344, 10333.534990925426, 10345.74135646615, 9891.258155638212, 10160.441175735257, 10255.128314093387, 10259.28185027056, 10309.329893556895, 7565.394768418513, 7608.277213664583, 7642.541447513167, 7644.503107298008, 7679.923200768033, 5400.918986215289, 5667.744951477111, 5730.369659337553, 5917.970410147922, 5926.555508336805, 8893.110688931314, 9232.907670923474, 9346.626134954526, 9360.625574976924, 9370.34407591462, 9224.631014759603, 9499.335046546676, 9508.239340852853, 9556.713298601053, 9600.135987760856, 6528.281888992302, 6918.688659010458, 7029.578225306498, 7061.258567850302, 7238.963805180941, 7742.0, 7755.961220193863, 7814.88277675824, 7814.960925195565, 7821.921780782347, 6968.616726079911, 7192.748253811092, 7275.672594733144, 7282.5994570297025, 7362.963185184254, 7204.0, 7221.602811845399, 7241.855162896818, 7253.088732682847, 7296.1974182838785, 6508.446782023581, 6567.310432404529, 6578.210614726264, 6583.670816459254, 6588.374104460068, 4981.178105612534, 5114.053900028358, 5125.0, 5136.0241554104605, 5146.665466744649, 5017.724025178651, 5106.872328191825, 5110.182370820651, 5146.356705411824, 5266.868328291824], "value": 4352.763534823887, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [303.22072274255174, 305.24451981346164, 307.36375702296243, 314.4308801070062, 318.7290802817604, 5525.0, 5558.305211848519, 5585.776568937237, 5742.712864356781, 5743.655380677163, 5610.4670056344685, 5651.689157096358, 5654.349749778767, 5655.660660360371, 5709.257796486451, 4345.239583072966, 4356.019895523514, 4363.650907927374, 4376.627986621141, 4382.9342559861625, 4165.271747005701, 4286.935695964563, 4297.935530967023, 4379.5182529921685, 4380.605745482906, 4245.2783026885345, 4245.936310955338, 4249.298865687158, 4250.61744443, 4257.552956939523, 4237.915241695149, 4238.279492486285, 4239.10978694473, 4246.447961764966, 4248.978755106235, 3528.2237907660274, 3664.963350366489, 3683.710701254566, 3696.3346597612417, 3698.3712768829364, 5342.545883599899, 5376.193570964348, 5443.047466693313, 5443.727813609304, 5462.562994960394, 4899.412070551557, 4901.558859702608, 4912.263160525914, 4917.950820491785, 4937.308776771255, 5549.5005449509335, 5834.474897259224, 5842.591018628697, 5865.530757539386, 5894.204282421861, 4092.3630547780826, 4104.322786740185, 4114.691398145121, 4119.546849846514, 4129.421880936671, 6070.816190842787, 6120.693965301717, 6126.417990290915, 6186.4741496972365, 6190.2571691397325, 4042.413849991735, 4145.958540414557, 4149.066460046526, 4166.999920019173, 4211.389348544505, 4196.81114349855, 4227.217964676544, 4237.385579091015, 4240.809163587646, 4255.319148936155, 4846.684965477232, 4870.342503762017, 4872.829450969199, 4876.29293752411, 4913.950860491349, 5477.397486276506, 5780.0, 5837.540614846288, 5908.527317814564, 5910.822675319747, 1453.9418423263162, 1456.097219723778, 1471.9852801472061, 1472.874805641511, 1475.7491226491522, 946.5740416812462, 950.382251536493, 978.6379039755336, 979.5787811241235, 981.3277904635347, 5724.198612194296, 5737.311522617312, 5743.655380677173, 5766.135079737989, 5784.913226301609, 6097.725602347905, 6121.693915304217, 6132.846678832976, 6144.477719393902, 6160.10678451631, 5609.663420194802, 5776.566757493205, 5777.88444231113, 5784.132380142928, 5797.304323481209, 3255.186203449138, 3272.3946069977133, 3272.4927636216426, 3275.836208189581, 3285.7699961002977, 6110.7861224856915, 6313.179286692793, 6315.431611154926, 6332.68336583169, 6348.650824204621, 6294.307626161119, 6300.621962682254, 6313.147725057151, 6325.082862984841, 6330.746770129143, 6264.874702506016, 6351.396617321347, 6391.680415979183, 6395.712192951329, 6454.548181627335, 6160.7535698571555, 6160.876782464236, 6188.721507532082, 6192.133101365723, 6201.937980620136, 5986.191864098291, 6106.175666284995, 6125.540584456095, 6151.446369826737, 6162.476189523941, 6174.6912654368, 6350.983842585164, 6393.424591786761, 6393.584417012879, 6454.48364130859, 4338.0, 4359.389685444104, 4369.71596846204, 4371.235033868997, 4375.934360984524, 5915.40845915405, 5949.553783466171, 6165.071590994421, 6173.382661733791, 6174.166487524127, 5806.5064469518875, 5978.521718262442, 5981.0, 5991.850203744942, 6010.849728756816, 5908.291005079418, 5952.285725712942, 5990.820275391745, 6022.789202377896, 6025.307089684742, 5651.886962260814, 5837.416258374298, 5882.911756323744, 5886.970565147147, 5893.381194974466, 5903.586748927534, 5944.375840536854, 5957.434043765836, 6000.5799594028, 6010.939890601038, 5728.570357223141, 5802.085311847165, 5871.970640146772, 5873.2658417697785, 5889.49939255151], "value": 4469.792604691009, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [819.6229734322211, 831.538496134645, 844.168494033377, 844.4553263145268, 850.07766573268, 13271.402786874589, 13532.0, 13737.31313434328, 13959.79060314096, 13965.650858728537, 11977.880221197785, 13186.142900711448, 13200.603981880558, 13270.93364533176, 13276.668083297898, 789.7749141494661, 809.8663720486113, 810.5501446697081, 810.8459392715365, 811.5495899775622, 796.2674339607574, 801.9037715474151, 806.6289506826837, 812.5733989655419, 818.9344852411792, 707.2008630247813, 851.0043249398188, 852.5098068610542, 853.8847255620474, 854.6666799947994, 719.1118968074423, 722.1947528505731, 836.8368168207232, 845.5729856422529, 847.4618617178136, 614.790971069834, 614.9631022138686, 615.9436566288836, 624.3506752976898, 629.7260691599168, 13583.796243056362, 13670.0, 13679.658008549766, 13686.452541898312, 13696.863031369658, 13127.212367257995, 13296.867031329659, 13307.933460332637, 13416.195028298333, 13760.93119534396, 10864.0, 11017.559297628086, 11146.498407571678, 11669.241499302603, 12111.515539378413, 3849.9230015399535, 3850.306944749944, 3889.8249578769023, 3920.470736450571, 3989.1024519482885, 56103.0, 58156.418435815525, 58166.12750808741, 58364.0, 58458.707706461624, 10693.625723099654, 10809.189310801721, 10834.729131771768, 10886.129109671207, 11279.605213817642, 19944.33218431768, 20139.697904531444, 20345.186192552428, 20366.287179948926, 20626.07182676783, 7993.6482255479295, 7998.400119990907, 8066.153053929253, 8171.06032806223, 8217.630206640715, 4324.935125973113, 4454.4654641442585, 4525.479569849444, 4640.83757068501, 4696.976515117471, 3338.4658454647138, 3451.4822776583715, 3451.516787649731, 3454.531823974801, 3456.2569047654874, 630.9621422714652, 634.8159033880215, 640.6572483721187, 642.1523588862657, 648.2447948140364, 565.5588640860136, 621.0071028927463, 638.6008744534665, 666.9299723529057, 760.81360066784, 9032.774180645536, 9096.408733432305, 9184.311176661777, 9411.670591529264, 9573.28200384974, 692.4910191009604, 717.3113810741746, 721.9711211551585, 731.381982225019, 736.3372964332037, 4307.806148723253, 4459.643228541709, 4467.463904331501, 4481.7983190756495, 4522.3668686383935, 64811.351886481476, 66531.33468665348, 66960.0, 67096.32903670901, 67098.66450667716, 54029.1895621566, 57135.0, 57968.0, 58182.70908645514, 58588.707056464445, 49441.0, 49813.50186498161, 50019.499805001484, 50342.24486632703, 51602.74198629058, 8311.83376332458, 8387.958060209903, 8525.403221774664, 8607.18231767981, 8680.869786953075, 33492.66507334895, 33532.32935341328, 34052.489212661334, 34386.828065860514, 34963.65036349604, 42465.15069698651, 44939.55060449354, 46479.30281045719, 47432.7628361856, 47955.0, 11640.417979100841, 11885.34630595291, 11990.0, 12316.815247771112, 12400.503979841065, 13704.931475342559, 13902.86097139056, 14056.929715351358, 14314.928425357806, 14793.11241325524, 9616.230701544, 12925.935370323088, 13103.2138071716, 13854.238016908763, 14148.292585370484, 12641.620751377473, 12957.870421295667, 13097.869021310045, 13210.603681889559, 13229.404676789374, 13359.575594697026, 13447.46210151583, 13474.0, 13534.59396218115, 13802.378892950042, 9894.653687120915, 10078.344907580984, 10629.25595208328, 10758.946205268923, 10993.285436446606, 10616.097631701392, 10657.89342106569, 10821.182654927345, 10963.616273430393, 10980.725481863017], "value": 6746.0048703359835, "unit": "score"}], "name": "dromaeo_css", "value": 6938.006163597807, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 115.0, 109.0, 114.0, 112.0, 111.0, 100.0, 112.0, 111.0, 113.0], "value": 110.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 128.0, 161.0, 192.0, 129.0, 164.0, 160.0, 130.0, 191.0, 138.0], "value": 155.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 161.0, 162.0, 161.0, 162.0, 163.0, 164.0, 163.0, 161.0], "value": 162.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 105.0, 116.0, 76.0, 76.0, 72.0, 118.0, 104.0, 78.0], "value": 89.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 92.0, 153.0, 92.0, 92.0, 94.0, 155.0, 92.0, 92.0, 155.0], "value": 110.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 118.0, 117.0, 116.0, 116.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 146.0, 145.0, 146.0, 145.0, 145.0, 145.0, 145.0, 145.0], "value": 145.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 94.0, 95.0, 95.0, 94.0, 95.0, 94.0, 95.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 55.0, 56.0, 55.0, 57.0, 55.0, 74.0, 55.0, 53.0], "value": 57.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 61.0, 61.0, 61.0, 64.0, 62.0, 62.0, 62.0, 61.0], "value": 61.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 76.0, 76.0, 77.0, 76.0, 76.0, 76.0, 78.0, 76.0], "value": 76.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 125.0, 123.0, 138.0, 125.0, 124.0, 132.0, 123.0, 152.0, 128.0], "value": 129.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 162.0, 162.0, 162.0, 163.0, 161.0, 163.0, 162.0, 162.0], "value": 162.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 70.0, 70.0, 71.0, 68.0, 66.0, 69.0, 67.0, 68.0, 66.0], "value": 68.4, "unit": "score"}], "name": "kraken", "value": 1540.5999999999997, "alertThreshold": 2.0}]} 20:14:53 INFO - Return code: 0 20:14:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 20:14:53 ERROR - # TBPL SUCCESS # 20:14:53 INFO - Running post-action listener: _resource_record_post_action 20:14:53 INFO - Running post-run listener: _resource_record_post_run 20:14:54 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 533200896; Read time: 12; Write time: 521464 20:14:54 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 244244480; Read time: 0; Write time: 367312 20:14:54 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 288956416; Read time: 12; Write time: 154152 20:14:54 INFO - Running post-run listener: _upload_blobber_files 20:14:54 INFO - Blob upload gear active. 20:14:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:14:54 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:54 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:54 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:55 INFO - (blobuploader) - INFO - Open directory for files ... 20:14:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:14:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:14:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:14:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:14:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:14:56 INFO - (blobuploader) - INFO - Done attempting. 20:14:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:14:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:14:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:14:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:14:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:14:56 INFO - (blobuploader) - INFO - Done attempting. 20:14:56 INFO - (blobuploader) - INFO - Iteration through files over. 20:14:56 INFO - Return code: 0 20:14:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:14:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:14:56 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5a75b9ec5a8262573e9d969ecba9bccf035ffc5f782b87ca77eed538ad789f9591f5fe6ff55f71f07d6c7f1adf29f1ceb486bab3a60501a5a9f8ecd14a29ddb0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/85d7e918d526fe5c7d27abd0283a0b74d3b7299d71f3444a031ff690be83a3eec4a3225f0f0e20692b2556f3883c17f237c0ea7b554a2602dae7ab6cdd5ca4cb"} 20:14:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:14:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:14:56 INFO - Contents: 20:14:56 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5a75b9ec5a8262573e9d969ecba9bccf035ffc5f782b87ca77eed538ad789f9591f5fe6ff55f71f07d6c7f1adf29f1ceb486bab3a60501a5a9f8ecd14a29ddb0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/85d7e918d526fe5c7d27abd0283a0b74d3b7299d71f3444a031ff690be83a3eec4a3225f0f0e20692b2556f3883c17f237c0ea7b554a2602dae7ab6cdd5ca4cb"} 20:14:56 INFO - Running post-run listener: copy_logs_to_upload_dir 20:14:56 INFO - Copying logs to upload dir... 20:14:56 INFO - mkdir: /builds/slave/test/build/upload/logs 20:14:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.118401 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-04-15 20:14:56.387746) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-15 20:14:56.391555) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1460768836.626605-369819058 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5a75b9ec5a8262573e9d969ecba9bccf035ffc5f782b87ca77eed538ad789f9591f5fe6ff55f71f07d6c7f1adf29f1ceb486bab3a60501a5a9f8ecd14a29ddb0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/85d7e918d526fe5c7d27abd0283a0b74d3b7299d71f3444a031ff690be83a3eec4a3225f0f0e20692b2556f3883c17f237c0ea7b554a2602dae7ab6cdd5ca4cb"} 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.011196 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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5a75b9ec5a8262573e9d969ecba9bccf035ffc5f782b87ca77eed538ad789f9591f5fe6ff55f71f07d6c7f1adf29f1ceb486bab3a60501a5a9f8ecd14a29ddb0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/85d7e918d526fe5c7d27abd0283a0b74d3b7299d71f3444a031ff690be83a3eec4a3225f0f0e20692b2556f3883c17f237c0ea7b554a2602dae7ab6cdd5ca4cb"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-15 20:14:56.417545) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 20:14:56.417854) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1460768836.626605-369819058 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004438 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 20:14:56.504302) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-15 20:14:56.504834) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-15 20:14:56.505450) ========= ========= Total master_lag: 0.16 =========