builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-042 starttime: 1464792738.2 results: success (0) buildid: 20160601050353 builduid: 1b865cf5cc7d41a7a85f37d3a9881a42 revision: bf4d710c80531aa2c170f076716513e69206b05d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-01 07:52:18.199613) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-01 07:52:18.200115) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-01 07:52:18.200434) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-01 07:52:18.215209) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 07:52:18.215525) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1464792736.64267-48109578 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-01 07:52:18-- 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% 40.5M=0s 2016-06-01 07:52:18 (40.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.084668 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 07:52:18.318211) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 07:52:18.318955) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1464792736.64267-48109578 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020261 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 07:52:18.372244) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 07:52:18.372631) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev bf4d710c80531aa2c170f076716513e69206b05d --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev bf4d710c80531aa2c170f076716513e69206b05d --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=74d6aec007b0fa31a864ebd7000001f8-1464792736.64267-48109578 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-01 07:52:18,607 truncating revision to first 12 chars 2016-06-01 07:52:18,607 Setting DEBUG logging. 2016-06-01 07:52:18,607 attempt 1/10 2016-06-01 07:52:18,607 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/bf4d710c8053?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-01 07:52:18,935 unpacking tar archive at: mozilla-aurora-bf4d710c8053/testing/mozharness/ program finished with exit code 0 elapsedTime=0.643062 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 07:52:19.029414) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-01 07:52:19.029778) ========= script_repo_revision: bf4d710c80531aa2c170f076716513e69206b05d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-01 07:52:19.030252) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-01 07:52:19.030558) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-01 07:52:19.041779) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-06-01 07:52:19.042098) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=74d6aec007b0fa31a864ebd7000001f8-1464792736.64267-48109578 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:52:19 INFO - MultiFileLogger online at 20160601 07:52:19 in /builds/slave/test 07:52:19 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 07:52:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:52:19 INFO - {'append_to_log': False, 07:52:19 INFO - 'base_work_dir': '/builds/slave/test', 07:52:19 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 07:52:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:52:19 INFO - 'branch': 'Mozilla-Aurora', 07:52:19 INFO - 'buildbot_json_path': 'buildprops.json', 07:52:19 INFO - 'config_files': ('talos/linux_config.py',), 07:52:19 INFO - 'default_actions': ('clobber', 07:52:19 INFO - 'read-buildbot-config', 07:52:19 INFO - 'download-and-extract', 07:52:19 INFO - 'populate-webroot', 07:52:19 INFO - 'create-virtualenv', 07:52:19 INFO - 'install', 07:52:19 INFO - 'run-tests'), 07:52:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:52:19 INFO - 'download_minidump_stackwalk': True, 07:52:19 INFO - 'download_symbols': 'ondemand', 07:52:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:52:19 INFO - 'tooltool.py': '/tools/tooltool.py', 07:52:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:52:19 INFO - '/tools/misc-python/virtualenv.py')}, 07:52:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:52:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:52:19 INFO - 'installer_path': 'installer.exe', 07:52:19 INFO - 'log_level': 'info', 07:52:19 INFO - 'log_name': 'talos', 07:52:19 INFO - 'log_to_console': True, 07:52:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:52:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:52:19 INFO - 'opt_config_files': (), 07:52:19 INFO - 'pip_index': False, 07:52:19 INFO - 'sps_profile': False, 07:52:19 INFO - 'sps_profile_interval': 0, 07:52:19 INFO - 'suite': 'dromaeojs', 07:52:19 INFO - 'system_bits': '32', 07:52:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:52:19 INFO - 'title': 'talos-linux64-ix-042', 07:52:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:52:19 INFO - 'use_talos_json': True, 07:52:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:52:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:52:19 INFO - 'work_dir': 'build'} 07:52:19 INFO - ##### 07:52:19 INFO - ##### Running clobber step. 07:52:19 INFO - ##### 07:52:19 INFO - Running pre-action listener: _resource_record_pre_action 07:52:19 INFO - Running main action method: clobber 07:52:19 INFO - rmtree: /builds/slave/test/build 07:52:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:52:20 INFO - Running post-action listener: _resource_record_post_action 07:52:20 INFO - ##### 07:52:20 INFO - ##### Running read-buildbot-config step. 07:52:20 INFO - ##### 07:52:20 INFO - Running pre-action listener: _resource_record_pre_action 07:52:20 INFO - Running main action method: read_buildbot_config 07:52:20 INFO - Using buildbot properties: 07:52:20 INFO - { 07:52:20 INFO - "project": "", 07:52:20 INFO - "product": "firefox", 07:52:20 INFO - "script_repo_revision": "production", 07:52:20 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 07:52:20 INFO - "repository": "", 07:52:20 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 07:52:20 INFO - "buildid": "20160601050353", 07:52:20 INFO - "pgo_build": "True", 07:52:20 INFO - "basedir": "/builds/slave/test", 07:52:20 INFO - "buildnumber": 544, 07:52:20 INFO - "slavename": "talos-linux64-ix-042", 07:52:20 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 07:52:20 INFO - "platform": "ubuntu64_hw", 07:52:20 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 07:52:20 INFO - "branch": "mozilla-aurora", 07:52:20 INFO - "repo_path": "releases/mozilla-aurora", 07:52:20 INFO - "revision": "bf4d710c80531aa2c170f076716513e69206b05d", 07:52:20 INFO - "stage_platform": "linux64-pgo", 07:52:20 INFO - "builduid": "1b865cf5cc7d41a7a85f37d3a9881a42", 07:52:20 INFO - "slavebuilddir": "test" 07:52:20 INFO - } 07:52:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/I4a8ImCbQICdwTo_0ZpYoA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 07:52:20 INFO - Running post-action listener: _resource_record_post_action 07:52:20 INFO - ##### 07:52:20 INFO - ##### Running download-and-extract step. 07:52:20 INFO - ##### 07:52:20 INFO - Running pre-action listener: _resource_record_pre_action 07:52:20 INFO - Running main action method: download_and_extract 07:52:20 INFO - mkdir: /builds/slave/test/build/tests 07:52: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')]} 07:52:20 INFO - https://queue.taskcluster.net/v1/task/I4a8ImCbQICdwTo_0ZpYoA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:52:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I4a8ImCbQICdwTo_0ZpYoA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 07:52:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I4a8ImCbQICdwTo_0ZpYoA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 07:52:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I4a8ImCbQICdwTo_0ZpYoA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 07:52:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I4a8ImCbQICdwTo_0ZpYoA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 07:52:21 INFO - Downloaded 1361 bytes. 07:52:21 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 07:52:21 INFO - Using the following test package requirements: 07:52:21 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 07:52:21 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 07:52:21 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 07:52:21 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 07:52:21 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 07:52:21 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 07:52:21 INFO - u'jsshell-linux-x86_64.zip'], 07:52:21 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 07:52:21 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 07:52:21 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 07:52:21 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 07:52:21 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 07:52:21 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 07:52:21 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 07:52:21 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 07:52:21 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 07:52:21 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 07:52:21 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 07:52:21 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:52:21 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')]} 07:52:21 INFO - https://queue.taskcluster.net/v1/task/I4a8ImCbQICdwTo_0ZpYoA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:52:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I4a8ImCbQICdwTo_0ZpYoA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 07:52:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I4a8ImCbQICdwTo_0ZpYoA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 07:52:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I4a8ImCbQICdwTo_0ZpYoA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 07:52:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I4a8ImCbQICdwTo_0ZpYoA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:52:22 INFO - Downloaded 24173199 bytes. 07:52:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:52:22 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:52:23 INFO - Return code: 0 07:52:23 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 07:52:23 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')]} 07:52:23 INFO - https://queue.taskcluster.net/v1/task/I4a8ImCbQICdwTo_0ZpYoA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:52:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I4a8ImCbQICdwTo_0ZpYoA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 07:52:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I4a8ImCbQICdwTo_0ZpYoA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 07:52:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I4a8ImCbQICdwTo_0ZpYoA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 07:52:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I4a8ImCbQICdwTo_0ZpYoA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:52:25 INFO - Downloaded 24173199 bytes. 07:52:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:52:25 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:52:26 INFO - Return code: 0 07:52:26 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')]} 07:52:26 INFO - https://queue.taskcluster.net/v1/task/I4a8ImCbQICdwTo_0ZpYoA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:52:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I4a8ImCbQICdwTo_0ZpYoA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 07:52:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I4a8ImCbQICdwTo_0ZpYoA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 07:52:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I4a8ImCbQICdwTo_0ZpYoA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 07:52:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I4a8ImCbQICdwTo_0ZpYoA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:52:27 INFO - Downloaded 10840145 bytes. 07:52:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:52:27 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 07:52:27 INFO - Return code: 0 07:52:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:52:27 INFO - https://queue.taskcluster.net/v1/task/I4a8ImCbQICdwTo_0ZpYoA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:52:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I4a8ImCbQICdwTo_0ZpYoA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 07:52:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I4a8ImCbQICdwTo_0ZpYoA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 07:52:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I4a8ImCbQICdwTo_0ZpYoA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 07:52:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I4a8ImCbQICdwTo_0ZpYoA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 07:52:31 INFO - Downloaded 62797569 bytes. 07:52:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/I4a8ImCbQICdwTo_0ZpYoA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 07:52:31 INFO - mkdir: /builds/slave/test/properties 07:52:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:52:31 INFO - Writing to file /builds/slave/test/properties/build_url 07:52:31 INFO - Contents: 07:52:31 INFO - build_url:https://queue.taskcluster.net/v1/task/I4a8ImCbQICdwTo_0ZpYoA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 07:52:32 INFO - Running post-action listener: _resource_record_post_action 07:52:32 INFO - Running post-action listener: set_extra_try_arguments 07:52:32 INFO - ##### 07:52:32 INFO - ##### Running populate-webroot step. 07:52:32 INFO - ##### 07:52:32 INFO - Running pre-action listener: _resource_record_pre_action 07:52:32 INFO - Running main action method: populate_webroot 07:52:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:52:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:52:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:52:32 INFO - '--tppagecycles', 07:52:32 INFO - '7'], 07:52:32 INFO - 'tests': ['tsvgm']}}, 07:52:32 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:52:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:52:32 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:52:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:52:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:52:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:52:32 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:52:32 INFO - 'talos_options': ['--disable-e10s'], 07:52:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:52:32 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:52:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:52:32 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:52:32 INFO - 'talos_options': ['--disable-e10s'], 07:52:32 INFO - 'tests': ['damp', 'tps']}, 07:52:32 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:52:32 INFO - 'tests': ['damp', 'tps']}, 07:52:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:52:32 INFO - 'tests': ['dromaeo_dom']}, 07:52:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:52:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:52:32 INFO - 'tests': ['a11yr', 07:52:32 INFO - 'ts_paint', 07:52:32 INFO - 'tpaint', 07:52:32 INFO - 'sessionrestore', 07:52:32 INFO - 'sessionrestore_no_auto_restore', 07:52:32 INFO - 'tabpaint']}, 07:52:32 INFO - 'other-e10s': {'tests': ['a11yr', 07:52:32 INFO - 'ts_paint', 07:52:32 INFO - 'tpaint', 07:52:32 INFO - 'sessionrestore', 07:52:32 INFO - 'sessionrestore_no_auto_restore', 07:52:32 INFO - 'tabpaint']}, 07:52:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:52:32 INFO - 'ts_paint', 07:52:32 INFO - 'tpaint', 07:52:32 INFO - 'sessionrestore', 07:52:32 INFO - 'sessionrestore_no_auto_restore', 07:52:32 INFO - 'tabpaint']}, 07:52:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:52:32 INFO - 'ts_paint', 07:52:32 INFO - 'tpaint', 07:52:32 INFO - 'sessionrestore', 07:52:32 INFO - 'sessionrestore_no_auto_restore', 07:52:32 INFO - 'tabpaint']}, 07:52:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:52:32 INFO - 'tests': ['a11yr', 07:52:32 INFO - 'ts_paint', 07:52:32 INFO - 'tpaint', 07:52:32 INFO - 'sessionrestore', 07:52:32 INFO - 'sessionrestore_no_auto_restore', 07:52:32 INFO - 'tabpaint']}, 07:52:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:52:32 INFO - 'tests': ['a11yr', 07:52:32 INFO - 'ts_paint', 07:52:32 INFO - 'tpaint', 07:52:32 INFO - 'sessionrestore', 07:52:32 INFO - 'sessionrestore_no_auto_restore', 07:52:32 INFO - 'tabpaint']}, 07:52:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:52:32 INFO - 'tests': ['tsvgx', 07:52:32 INFO - 'tsvgr_opacity', 07:52:32 INFO - 'tart', 07:52:32 INFO - 'tscrollx', 07:52:32 INFO - 'cart']}, 07:52:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:52:32 INFO - 'tsvgr_opacity', 07:52:32 INFO - 'tart', 07:52:32 INFO - 'tscrollx', 07:52:32 INFO - 'cart']}, 07:52:32 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:52:32 INFO - 'talos_options': ['--disable-e10s'], 07:52:32 INFO - 'tests': ['tp5o']}, 07:52:32 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:52:32 INFO - 'tests': ['tp5o']}, 07:52:32 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:52:32 INFO - 'talos_options': ['--disable-e10s', 07:52:32 INFO - '--xperf_path', 07:52:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:52:32 INFO - 'tests': ['tp5n']}, 07:52:32 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:52:32 INFO - 'talos_options': ['--xperf_path', 07:52:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:52:32 INFO - 'tests': ['tp5n']}}, 07:52:32 INFO - 'talos.zip': {'path': '', 07:52:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:52:32 INFO - Running post-action listener: _resource_record_post_action 07:52:32 INFO - ##### 07:52:32 INFO - ##### Running create-virtualenv step. 07:52:32 INFO - ##### 07:52:32 INFO - Running pre-action listener: _resource_record_pre_action 07:52:32 INFO - Running main action method: create_virtualenv 07:52:32 INFO - Creating virtualenv /builds/slave/test/build/venv 07:52:32 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 07:52:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:52:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:52:32 INFO - Using real prefix '/usr' 07:52:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:52:32 INFO - Installing distribute.............................................................................................................................................................................................done. 07:52:34 INFO - Installing pip.................done. 07:52:34 INFO - Return code: 0 07:52:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:52: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')]} 07:52:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:52:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52: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')]} 07:52:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:52:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:34 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 0x7f38ace98f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fbd7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x204c640>, '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 0x204d540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x204d9d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1464792736.64267-48109578', '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 07:52:34 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 07:52:34 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 07:52:34 INFO - Using env: {'DISPLAY': ':0', 07:52:34 INFO - 'HOME': '/home/cltbld', 07:52:34 INFO - 'LANG': 'en_US.UTF-8', 07:52:34 INFO - 'LANGUAGE': 'en_US:en', 07:52:34 INFO - 'LOGNAME': 'cltbld', 07:52:34 INFO - 'MAIL': '/var/mail/cltbld', 07:52:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:52:34 INFO - 'MOZ_NO_REMOTE': '1', 07:52:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:52:34 INFO - 'NO_EM_RESTART': '1', 07:52:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:52:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:52:34 INFO - 'PWD': '/builds/slave/test', 07:52:34 INFO - 'SHELL': '/bin/bash', 07:52:34 INFO - 'SHLVL': '1', 07:52:34 INFO - 'TERM': 'linux', 07:52:34 INFO - 'TMOUT': '86400', 07:52:34 INFO - 'USER': 'cltbld', 07:52:34 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1464792736.64267-48109578', 07:52:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:52:34 INFO - '_': '/tools/buildbot/bin/python'} 07:52:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:52:35 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 07:52:35 INFO - Cleaning up... 07:52:35 INFO - Return code: 0 07:52:35 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 07:52:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:52:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:52:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:52:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:52:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f38ace98f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fbd7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x204c640>, '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 0x204d540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x204d9d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1464792736.64267-48109578', '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 07:52:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 07:52:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 07:52:35 INFO - Using env: {'DISPLAY': ':0', 07:52:35 INFO - 'HOME': '/home/cltbld', 07:52:35 INFO - 'LANG': 'en_US.UTF-8', 07:52:35 INFO - 'LANGUAGE': 'en_US:en', 07:52:35 INFO - 'LOGNAME': 'cltbld', 07:52:35 INFO - 'MAIL': '/var/mail/cltbld', 07:52:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:52:35 INFO - 'MOZ_NO_REMOTE': '1', 07:52:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:52:35 INFO - 'NO_EM_RESTART': '1', 07:52:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:52:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:52:35 INFO - 'PWD': '/builds/slave/test', 07:52:35 INFO - 'SHELL': '/bin/bash', 07:52:35 INFO - 'SHLVL': '1', 07:52:35 INFO - 'TERM': 'linux', 07:52:35 INFO - 'TMOUT': '86400', 07:52:35 INFO - 'USER': 'cltbld', 07:52:35 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1464792736.64267-48109578', 07:52:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:52:35 INFO - '_': '/tools/buildbot/bin/python'} 07:52:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:52:35 INFO - Downloading/unpacking psutil>=0.7.1 07:52:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:52:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:52:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:52:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:52:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:52:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:52:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:52:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:52:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:52:37 INFO - Installing collected packages: psutil 07:52:37 INFO - Running setup.py install for psutil 07:52:37 INFO - building 'psutil._psutil_linux' extension 07:52:37 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 07:52:37 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 07:52:37 INFO - building 'psutil._psutil_posix' extension 07:52:37 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 07:52:37 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 07:52:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:52:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:52:37 INFO - Successfully installed psutil 07:52:37 INFO - Cleaning up... 07:52:37 INFO - Return code: 0 07:52:37 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 07:52:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:52:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:52:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:52:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:52:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f38ace98f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fbd7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x204c640>, '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 0x204d540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x204d9d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1464792736.64267-48109578', '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 07:52:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 07:52:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 07:52:37 INFO - Using env: {'DISPLAY': ':0', 07:52:37 INFO - 'HOME': '/home/cltbld', 07:52:37 INFO - 'LANG': 'en_US.UTF-8', 07:52:37 INFO - 'LANGUAGE': 'en_US:en', 07:52:37 INFO - 'LOGNAME': 'cltbld', 07:52:37 INFO - 'MAIL': '/var/mail/cltbld', 07:52:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:52:37 INFO - 'MOZ_NO_REMOTE': '1', 07:52:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:52:37 INFO - 'NO_EM_RESTART': '1', 07:52:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:52:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:52:37 INFO - 'PWD': '/builds/slave/test', 07:52:37 INFO - 'SHELL': '/bin/bash', 07:52:37 INFO - 'SHLVL': '1', 07:52:37 INFO - 'TERM': 'linux', 07:52:37 INFO - 'TMOUT': '86400', 07:52:37 INFO - 'USER': 'cltbld', 07:52:37 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1464792736.64267-48109578', 07:52:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:52:37 INFO - '_': '/tools/buildbot/bin/python'} 07:52:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:52:38 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:52:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:52:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:52:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:52:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:52:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:52:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:52:39 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:52:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:52:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:52:39 INFO - Installing collected packages: mozsystemmonitor 07:52:39 INFO - Running setup.py install for mozsystemmonitor 07:52:40 INFO - Successfully installed mozsystemmonitor 07:52:40 INFO - Cleaning up... 07:52:40 INFO - Return code: 0 07:52:40 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:52: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')]} 07:52:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:52:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52: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')]} 07:52:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:52:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52: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', '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 0x7f38ace98f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fbd7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x204c640>, '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 0x204d540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x204d9d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1464792736.64267-48109578', '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 07:52: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:52: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 blobuploader==1.2.4 07:52:40 INFO - Using env: {'DISPLAY': ':0', 07:52:40 INFO - 'HOME': '/home/cltbld', 07:52:40 INFO - 'LANG': 'en_US.UTF-8', 07:52:40 INFO - 'LANGUAGE': 'en_US:en', 07:52:40 INFO - 'LOGNAME': 'cltbld', 07:52:40 INFO - 'MAIL': '/var/mail/cltbld', 07:52:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:52:40 INFO - 'MOZ_NO_REMOTE': '1', 07:52:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:52:40 INFO - 'NO_EM_RESTART': '1', 07:52:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:52:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:52:40 INFO - 'PWD': '/builds/slave/test', 07:52:40 INFO - 'SHELL': '/bin/bash', 07:52:40 INFO - 'SHLVL': '1', 07:52:40 INFO - 'TERM': 'linux', 07:52:40 INFO - 'TMOUT': '86400', 07:52:40 INFO - 'USER': 'cltbld', 07:52:40 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1464792736.64267-48109578', 07:52:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:52:40 INFO - '_': '/tools/buildbot/bin/python'} 07:52:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:52:40 INFO - Downloading/unpacking blobuploader==1.2.4 07:52: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 07:52: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 07:52: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 07:52: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 07:52: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 07:52: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 07:52:42 INFO - Downloading blobuploader-1.2.4.tar.gz 07:52:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:52:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:52:42 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 07:52:42 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 07:52:42 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 07:52:42 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 07:52:42 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 07:52:42 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 07:52:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:52:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:52:42 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 07:52:42 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 07:52:42 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 07:52:42 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 07:52:42 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 07:52:42 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 07:52:42 INFO - Downloading docopt-0.6.1.tar.gz 07:52:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:52:42 INFO - Installing collected packages: blobuploader, requests, docopt 07:52:42 INFO - Running setup.py install for blobuploader 07:52:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:52:43 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:52:43 INFO - Running setup.py install for requests 07:52:43 INFO - Running setup.py install for docopt 07:52:43 INFO - Successfully installed blobuploader requests docopt 07:52:43 INFO - Cleaning up... 07:52:43 INFO - Return code: 0 07:52:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:52: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')]} 07:52:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:52:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52: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')]} 07:52:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:52:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:43 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 0x7f38ace98f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fbd7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x204c640>, '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 0x204d540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x204d9d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1464792736.64267-48109578', '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 07:52:43 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 07:52:43 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 07:52:43 INFO - Using env: {'DISPLAY': ':0', 07:52:43 INFO - 'HOME': '/home/cltbld', 07:52:43 INFO - 'LANG': 'en_US.UTF-8', 07:52:43 INFO - 'LANGUAGE': 'en_US:en', 07:52:43 INFO - 'LOGNAME': 'cltbld', 07:52:43 INFO - 'MAIL': '/var/mail/cltbld', 07:52:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:52:43 INFO - 'MOZ_NO_REMOTE': '1', 07:52:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:52:43 INFO - 'NO_EM_RESTART': '1', 07:52:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:52:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:52:43 INFO - 'PWD': '/builds/slave/test', 07:52:43 INFO - 'SHELL': '/bin/bash', 07:52:43 INFO - 'SHLVL': '1', 07:52:43 INFO - 'TERM': 'linux', 07:52:43 INFO - 'TMOUT': '86400', 07:52:43 INFO - 'USER': 'cltbld', 07:52:43 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1464792736.64267-48109578', 07:52:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:52:43 INFO - '_': '/tools/buildbot/bin/python'} 07:52:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:52:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:52:43 INFO - Running setup.py (path:/tmp/pip-2ZJLuf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:52:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:52:43 INFO - Running setup.py (path:/tmp/pip-wIBGkJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:52:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:52:43 INFO - Running setup.py (path:/tmp/pip-ESPz06-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:52:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:52:43 INFO - Running setup.py (path:/tmp/pip-hU6GIU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:52:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:52:44 INFO - Running setup.py (path:/tmp/pip-T3hVGA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:52:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:52:44 INFO - Running setup.py (path:/tmp/pip-dPGrAA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:52:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:52:44 INFO - Running setup.py (path:/tmp/pip-C0vsQJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:52:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:52:44 INFO - Running setup.py (path:/tmp/pip-wUjPBN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:52:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:52:44 INFO - Running setup.py (path:/tmp/pip-Aon4ns-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:52:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:52:44 INFO - Running setup.py (path:/tmp/pip-mp3Gyo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:52:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:52:44 INFO - Running setup.py (path:/tmp/pip-__VAo7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:52:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:52:44 INFO - Running setup.py (path:/tmp/pip-hPb5PD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:52:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:52:44 INFO - Running setup.py (path:/tmp/pip-eUBGpl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:52:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:52:44 INFO - Running setup.py (path:/tmp/pip-atQXAw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:52:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:52:44 INFO - Running setup.py (path:/tmp/pip-I4KrgE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:52:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:52:44 INFO - Running setup.py (path:/tmp/pip-ofpFF4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:52:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:52:44 INFO - Running setup.py (path:/tmp/pip-DmDqp6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:52:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:52:44 INFO - Running setup.py install for manifestparser 07:52:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:52:45 INFO - Running setup.py install for mozcrash 07:52:45 INFO - Running setup.py install for mozdebug 07:52:45 INFO - Running setup.py install for mozdevice 07:52:45 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:52:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:52:45 INFO - Running setup.py install for mozfile 07:52:45 INFO - Running setup.py install for mozhttpd 07:52:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:52:45 INFO - Running setup.py install for mozinfo 07:52:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:52:45 INFO - Running setup.py install for mozInstall 07:52:45 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:52:45 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:52:45 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:52:45 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:52:45 INFO - Running setup.py install for mozleak 07:52:45 INFO - Running setup.py install for mozlog 07:52:45 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:52:46 INFO - Running setup.py install for moznetwork 07:52:46 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:52:46 INFO - Running setup.py install for mozprocess 07:52:46 INFO - Running setup.py install for mozprofile 07:52:46 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:52:46 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:52:46 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:52:46 INFO - Running setup.py install for mozrunner 07:52:46 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:52:46 INFO - Running setup.py install for mozscreenshot 07:52:46 INFO - Running setup.py install for moztest 07:52:46 INFO - Running setup.py install for mozversion 07:52:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:52:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:52:46 INFO - Cleaning up... 07:52:46 INFO - Return code: 0 07:52:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:52:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:52:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:52:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:52:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:52:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:46 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 0x7f38ace98f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fbd7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x204c640>, '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 0x204d540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x204d9d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1464792736.64267-48109578', '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 07:52:46 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 07:52:46 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 07:52:46 INFO - Using env: {'DISPLAY': ':0', 07:52:46 INFO - 'HOME': '/home/cltbld', 07:52:46 INFO - 'LANG': 'en_US.UTF-8', 07:52:46 INFO - 'LANGUAGE': 'en_US:en', 07:52:46 INFO - 'LOGNAME': 'cltbld', 07:52:46 INFO - 'MAIL': '/var/mail/cltbld', 07:52:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:52:46 INFO - 'MOZ_NO_REMOTE': '1', 07:52:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:52:46 INFO - 'NO_EM_RESTART': '1', 07:52:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:52:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:52:46 INFO - 'PWD': '/builds/slave/test', 07:52:46 INFO - 'SHELL': '/bin/bash', 07:52:46 INFO - 'SHLVL': '1', 07:52:46 INFO - 'TERM': 'linux', 07:52:46 INFO - 'TMOUT': '86400', 07:52:46 INFO - 'USER': 'cltbld', 07:52:46 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1464792736.64267-48109578', 07:52:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:52:46 INFO - '_': '/tools/buildbot/bin/python'} 07:52:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:52:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:52:46 INFO - Running setup.py (path:/tmp/pip-ISFd6h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:52:47 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)) 07:52:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:52:47 INFO - Running setup.py (path:/tmp/pip-4NbT78-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:52:47 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)) 07:52:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:52:47 INFO - Running setup.py (path:/tmp/pip-oaLrfT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:52:47 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)) 07:52:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:52:47 INFO - Running setup.py (path:/tmp/pip-nKQCag-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:52:47 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)) 07:52:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:52:47 INFO - Running setup.py (path:/tmp/pip-cPPO3w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:52:47 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)) 07:52:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:52:47 INFO - Running setup.py (path:/tmp/pip-bUYKzM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:52:47 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)) 07:52:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:52:47 INFO - Running setup.py (path:/tmp/pip-_UnTOA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:52:47 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)) 07:52:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:52:47 INFO - Running setup.py (path:/tmp/pip-bMZEM4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:52:47 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)) 07:52:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:52:47 INFO - Running setup.py (path:/tmp/pip-_0r7N2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:52:47 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)) 07:52:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:52:47 INFO - Running setup.py (path:/tmp/pip-c0FA9I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:52:47 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)) 07:52:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:52:47 INFO - Running setup.py (path:/tmp/pip-6xnrVG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:52:47 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)) 07:52:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:52:47 INFO - Running setup.py (path:/tmp/pip-LH2Tza-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:52:47 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)) 07:52:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:52:47 INFO - Running setup.py (path:/tmp/pip-fK5ZU5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:52:47 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)) 07:52:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:52:47 INFO - Running setup.py (path:/tmp/pip-7R_2kn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:52:47 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)) 07:52:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:52:47 INFO - Running setup.py (path:/tmp/pip-K_aH0p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:52:48 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)) 07:52:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:52:48 INFO - Running setup.py (path:/tmp/pip-VeOLTe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:52:48 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)) 07:52:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:52:48 INFO - Running setup.py (path:/tmp/pip-uxB2oc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:52:48 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)) 07:52:48 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)) 07:52:48 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)) 07:52:48 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)) 07:52:48 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)) 07:52:48 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)) 07:52:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:52: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 07:52: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 07:52: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 07:52: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 07:52: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 07:52: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 07:52:50 INFO - Downloading blessings-1.6.tar.gz 07:52:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:52:50 INFO - Installing collected packages: blessings 07:52:50 INFO - Running setup.py install for blessings 07:52:50 INFO - Successfully installed blessings 07:52:50 INFO - Cleaning up... 07:52:50 INFO - Return code: 0 07:52:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:52:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:52:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:52:50 INFO - Reading from file tmpfile_stdout 07:52:50 INFO - Current package versions: 07:52:50 INFO - argparse == 1.2.1 07:52:50 INFO - blessings == 1.6 07:52:50 INFO - blobuploader == 1.2.4 07:52:50 INFO - docopt == 0.6.1 07:52:50 INFO - manifestparser == 1.1 07:52:50 INFO - mozInstall == 1.12 07:52:50 INFO - mozcrash == 0.17 07:52:50 INFO - mozdebug == 0.1 07:52:50 INFO - mozdevice == 0.48 07:52:50 INFO - mozfile == 1.2 07:52:50 INFO - mozhttpd == 0.7 07:52:50 INFO - mozinfo == 0.9 07:52:50 INFO - mozleak == 0.1 07:52:50 INFO - mozlog == 3.1 07:52:50 INFO - moznetwork == 0.27 07:52:50 INFO - mozprocess == 0.22 07:52:50 INFO - mozprofile == 0.28 07:52:50 INFO - mozrunner == 6.11 07:52:50 INFO - mozscreenshot == 0.1 07:52:50 INFO - mozsystemmonitor == 0.0 07:52:50 INFO - moztest == 0.7 07:52:50 INFO - mozversion == 1.4 07:52:50 INFO - psutil == 3.1.1 07:52:50 INFO - requests == 1.2.3 07:52:50 INFO - wsgiref == 0.1.2 07:52:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:52:50 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')]} 07:52:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:52:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:50 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')]} 07:52:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:52:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:50 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 0x7f38ace98f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fbd7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x204c640>, '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 0x204d540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x204d9d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1464792736.64267-48109578', '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 07:52:50 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 07:52:50 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 07:52:50 INFO - Using env: {'DISPLAY': ':0', 07:52:50 INFO - 'HOME': '/home/cltbld', 07:52:50 INFO - 'LANG': 'en_US.UTF-8', 07:52:50 INFO - 'LANGUAGE': 'en_US:en', 07:52:50 INFO - 'LOGNAME': 'cltbld', 07:52:50 INFO - 'MAIL': '/var/mail/cltbld', 07:52:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:52:50 INFO - 'MOZ_NO_REMOTE': '1', 07:52:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:52:50 INFO - 'NO_EM_RESTART': '1', 07:52:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:52:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:52:50 INFO - 'PWD': '/builds/slave/test', 07:52:50 INFO - 'SHELL': '/bin/bash', 07:52:50 INFO - 'SHLVL': '1', 07:52:50 INFO - 'TERM': 'linux', 07:52:50 INFO - 'TMOUT': '86400', 07:52:50 INFO - 'USER': 'cltbld', 07:52:50 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1464792736.64267-48109578', 07:52:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:52:50 INFO - '_': '/tools/buildbot/bin/python'} 07:52:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:52:50 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)) 07:52:50 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)) 07:52:50 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)) 07:52:50 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)) 07:52:50 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)) 07:52:50 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)) 07:52:50 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)) 07:52:50 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)) 07:52:50 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)) 07:52:50 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)) 07:52:50 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)) 07:52:50 INFO - Cleaning up... 07:52:50 INFO - Return code: 0 07:52:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:52:50 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')]} 07:52:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:52:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:50 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')]} 07:52:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:52:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:50 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 0x7f38ace98f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fbd7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x204c640>, '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 0x204d540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x204d9d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1464792736.64267-48109578', '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 07:52:50 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 07:52:50 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 07:52:50 INFO - Using env: {'DISPLAY': ':0', 07:52:50 INFO - 'HOME': '/home/cltbld', 07:52:50 INFO - 'LANG': 'en_US.UTF-8', 07:52:50 INFO - 'LANGUAGE': 'en_US:en', 07:52:50 INFO - 'LOGNAME': 'cltbld', 07:52:50 INFO - 'MAIL': '/var/mail/cltbld', 07:52:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:52:50 INFO - 'MOZ_NO_REMOTE': '1', 07:52:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:52:50 INFO - 'NO_EM_RESTART': '1', 07:52:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:52:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:52:50 INFO - 'PWD': '/builds/slave/test', 07:52:50 INFO - 'SHELL': '/bin/bash', 07:52:50 INFO - 'SHLVL': '1', 07:52:50 INFO - 'TERM': 'linux', 07:52:50 INFO - 'TMOUT': '86400', 07:52:50 INFO - 'USER': 'cltbld', 07:52:50 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1464792736.64267-48109578', 07:52:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:52:50 INFO - '_': '/tools/buildbot/bin/python'} 07:52:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:52:50 INFO - Downloading/unpacking jsonschema 07:52:50 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 07:52:50 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 07:52:50 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 07:52:50 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 07:52:50 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 07:52:50 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 07:52:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:52:52 INFO - Downloading/unpacking functools32 (from jsonschema) 07:52:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:52:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:52:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:52:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:52:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:52:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:52:53 INFO - Downloading functools32-3.2.3-2.tar.gz 07:52:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:52:53 INFO - warning: no files found matching '*.txt' 07:52:53 INFO - no previously-included directories found matching 'build' 07:52:53 INFO - no previously-included directories found matching 'dist' 07:52:53 INFO - no previously-included directories found matching '.git*' 07:52:53 INFO - Installing collected packages: jsonschema, functools32 07:52:53 INFO - Running setup.py install for functools32 07:52:53 INFO - warning: no files found matching '*.txt' 07:52:53 INFO - no previously-included directories found matching 'build' 07:52:53 INFO - no previously-included directories found matching 'dist' 07:52:53 INFO - no previously-included directories found matching '.git*' 07:52:53 INFO - Successfully installed jsonschema functools32 07:52:53 INFO - Cleaning up... 07:52:53 INFO - Return code: 0 07:52:53 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:52:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:52:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:52:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:52:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:52:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f38ace98f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fbd7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x204c640>, '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 0x204d540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x204d9d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1464792736.64267-48109578', '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 07:52:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 07:52:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 07:52:53 INFO - Using env: {'DISPLAY': ':0', 07:52:53 INFO - 'HOME': '/home/cltbld', 07:52:53 INFO - 'LANG': 'en_US.UTF-8', 07:52:53 INFO - 'LANGUAGE': 'en_US:en', 07:52:53 INFO - 'LOGNAME': 'cltbld', 07:52:53 INFO - 'MAIL': '/var/mail/cltbld', 07:52:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:52:53 INFO - 'MOZ_NO_REMOTE': '1', 07:52:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:52:53 INFO - 'NO_EM_RESTART': '1', 07:52:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:52:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:52:53 INFO - 'PWD': '/builds/slave/test', 07:52:53 INFO - 'SHELL': '/bin/bash', 07:52:53 INFO - 'SHLVL': '1', 07:52:53 INFO - 'TERM': 'linux', 07:52:53 INFO - 'TMOUT': '86400', 07:52:53 INFO - 'USER': 'cltbld', 07:52:53 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1464792736.64267-48109578', 07:52:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:52:53 INFO - '_': '/tools/buildbot/bin/python'} 07:52:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:52:53 INFO - Downloading/unpacking flake8 07:52: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 07:52: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 07:52: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 07:52: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 07:52: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 07:52: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 07:52:55 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:52:55 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:52:55 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 07:52:55 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 07:52:55 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 07:52:55 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 07:52:55 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 07:52:55 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 07:52:55 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:52:55 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:52:55 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 07:52:55 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 07:52:55 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 07:52:55 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 07:52:55 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 07:52:55 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 07:52:55 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:52:55 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 07:52:55 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 07:52:55 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 07:52:55 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 07:52:55 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 07:52:55 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 07:52:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:52:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:52:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:52:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:52:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:52:56 INFO - no previously-included directories found matching 'docs/_build' 07:52:56 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:52:56 INFO - Running setup.py install for pep8 07:52:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:52:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:52:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:52:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:52:56 INFO - no previously-included directories found matching 'docs/_build' 07:52:56 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:52:56 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:52:56 INFO - Cleaning up... 07:52:56 INFO - Return code: 0 07:52:56 INFO - Running post-action listener: _resource_record_post_action 07:52:56 INFO - Running post-action listener: _start_resource_monitoring 07:52:56 INFO - Starting resource monitoring. 07:52:56 INFO - ##### 07:52:56 INFO - ##### Running install step. 07:52:56 INFO - ##### 07:52:56 INFO - Running pre-action listener: _resource_record_pre_action 07:52:56 INFO - Running main action method: install 07:52:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:52:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:52:56 INFO - Reading from file tmpfile_stdout 07:52:56 INFO - Detecting whether we're running mozinstall >=1.0... 07:52:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:52:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:52:56 INFO - Reading from file tmpfile_stdout 07:52:56 INFO - Output received: 07:52:56 INFO - Usage: mozinstall [options] installer 07:52:56 INFO - Options: 07:52:56 INFO - -h, --help show this help message and exit 07:52:56 INFO - -d DEST, --destination=DEST 07:52:56 INFO - Directory to install application into. [default: 07:52:56 INFO - "/builds/slave/test"] 07:52:56 INFO - --app=APP Application being installed. [default: firefox] 07:52:56 INFO - mkdir: /builds/slave/test/build/application 07:52:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 07:52:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 07:53:12 INFO - Reading from file tmpfile_stdout 07:53:12 INFO - Output received: 07:53:12 INFO - /builds/slave/test/build/application/firefox/firefox 07:53:12 INFO - Running post-action listener: _resource_record_post_action 07:53:12 INFO - ##### 07:53:12 INFO - ##### Running run-tests step. 07:53:12 INFO - ##### 07:53:12 INFO - Running pre-action listener: _resource_record_pre_action 07:53:12 INFO - Running main action method: run_tests 07:53:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:53:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:53:12 INFO - Python 2.7.3 07:53:12 INFO - Return code: 0 07:53:12 INFO - grabbing minidump binary from tooltool 07:53:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:53:12 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 0x204c640>, '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 0x204d540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x204d9d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:53:12 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 07:53:12 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 07:53:12 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:53:12 INFO - Return code: 0 07:53:12 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:53:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:53:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:53:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:53:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:53:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:53:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:53:13 INFO - Return code: 0 07:53:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/I4a8ImCbQICdwTo_0ZpYoA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--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 07:53:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/I4a8ImCbQICdwTo_0ZpYoA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-042 --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 07:53:13 INFO - Using env: {'DISPLAY': ':0', 07:53:13 INFO - 'HOME': '/home/cltbld', 07:53:13 INFO - 'LANG': 'en_US.UTF-8', 07:53:13 INFO - 'LANGUAGE': 'en_US:en', 07:53:13 INFO - 'LOGNAME': 'cltbld', 07:53:13 INFO - 'MAIL': '/var/mail/cltbld', 07:53:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:53:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:53:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:53:13 INFO - 'MOZ_NO_REMOTE': '1', 07:53:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:53:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:53:13 INFO - 'NO_EM_RESTART': '1', 07:53:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:53:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:53:13 INFO - 'PWD': '/builds/slave/test', 07:53:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:53:13 INFO - 'SHELL': '/bin/bash', 07:53:13 INFO - 'SHLVL': '1', 07:53:13 INFO - 'TERM': 'linux', 07:53:13 INFO - 'TMOUT': '86400', 07:53:13 INFO - 'USER': 'cltbld', 07:53:13 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1464792736.64267-48109578', 07:53:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:53:13 INFO - '_': '/tools/buildbot/bin/python'} 07:53:13 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/I4a8ImCbQICdwTo_0ZpYoA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--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 07:53:13 INFO - mozversion application_buildid: 20160601050353 07:53:13 INFO - mozversion application_changeset: bf4d710c80531aa2c170f076716513e69206b05d 07:53:13 INFO - mozversion application_display_name: FirefoxDeveloperEdition 07:53:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:53:13 INFO - mozversion application_name: Firefox 07:53:13 INFO - mozversion application_remotingname: firefox-dev 07:53:13 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:53:13 INFO - mozversion application_vendor: Mozilla 07:53:13 INFO - mozversion application_version: 48.0a2 07:53:13 INFO - mozversion platform_buildid: 20160601050353 07:53:13 INFO - mozversion platform_changeset: bf4d710c80531aa2c170f076716513e69206b05d 07:53:13 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:53:13 INFO - mozversion platform_version: 48.0a2 07:53:13 INFO - using testdate: 1464792793 07:53:13 INFO - actual date: 1464792793 07:53:13 INFO - starting webserver on 'localhost:51933' 07:53:13 INFO - SUITE-START | Running 2 tests 07:53:13 INFO - TEST-START | dromaeo_css 07:53:13 INFO - operating with platform_type : linux_ 07:53:13 INFO - Initialising browser for dromaeo_css test... 07:53:13 INFO - TEST-INFO | started process 27030 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmxp5ND/profile http://localhost:51933/getInfo.html) 07:53:17 INFO - PROCESS | 27030 | __metrics Screen width/height:1600/1200 07:53:17 INFO - PROCESS | 27030 | colorDepth:24 07:53:17 INFO - PROCESS | 27030 | Browser inner width/height: 1024/697 07:53:17 INFO - PROCESS | 27030 | __metrics 07:53:18 ERROR - PROCESS | 27030 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:53:19 INFO - TEST-INFO | 27030: exit 0 07:53:19 INFO - Browser initialized. 07:53:19 INFO - Running cycle 1/1 for dromaeo_css test... 07:53:19 INFO - TEST-INFO | started process 27122 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmxp5ND/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:53:31 INFO - PROCESS | 27122 | RSS: Main: 141860864 07:53:31 INFO - PROCESS | 27122 | 07:54:22 INFO - PROCESS | 27122 | 1464792862475 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] 07:56:30 INFO - PROCESS | 27122 | Cycle 1(1): loaded http://localhost:51933/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51933/tests/dromaeo/cssquery-ext.html) 07:56:31 INFO - PROCESS | 27122 | RSS: Main: 251588608 07:56:31 INFO - PROCESS | 27122 | 07:59:33 INFO - PROCESS | 27122 | Cycle 1(1): loaded http://localhost:51933/tests/dromaeo/cssquery-ext.html (next: http://localhost:51933/tests/dromaeo/cssquery-jquery.html) 07:59:33 INFO - PROCESS | 27122 | RSS: Main: 232955904 07:59:33 INFO - PROCESS | 27122 | 08:02:35 INFO - PROCESS | 27122 | Cycle 1(1): loaded http://localhost:51933/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51933/tests/dromaeo/cssquery-mootools.html) 08:02:36 INFO - PROCESS | 27122 | RSS: Main: 220196864 08:02:36 INFO - PROCESS | 27122 | 08:05:38 INFO - PROCESS | 27122 | Cycle 1(1): loaded http://localhost:51933/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51933/tests/dromaeo/cssquery-prototype.html) 08:05:38 INFO - PROCESS | 27122 | RSS: Main: 220016640 08:05:38 INFO - PROCESS | 27122 | 08:08:41 INFO - PROCESS | 27122 | Cycle 1(1): loaded http://localhost:51933/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51933/tests/dromaeo/cssquery-yui.html) 08:08:41 INFO - PROCESS | 27122 | RSS: Main: 210141184 08:08:41 INFO - PROCESS | 27122 | 08:11:44 INFO - PROCESS | 27122 | Cycle 1(1): loaded http://localhost:51933/tests/dromaeo/cssquery-yui.html (next: http://localhost:51933/tests/dromaeo/cssquery-dojo.html) 08:11:44 INFO - PROCESS | 27122 | RSS: Main: 259768320 08:11:44 INFO - PROCESS | 27122 | 08:11:44 INFO - PROCESS | 27122 | __start_tp_report 08:11:44 INFO - PROCESS | 27122 | _x_x_mozilla_page_load 08:11:44 INFO - PROCESS | 27122 | _x_x_mozilla_page_load_details 08:11:44 INFO - PROCESS | 27122 | |i|pagename|runs| 08:11:44 INFO - PROCESS | 27122 | |0;dojo.html;3328.8002719836804;3368.3263347330508;3376.6960973512378;3387.9153021174466;3429.1598558353207;5524.779008839641;5527.309086364205;5542.584306177037;5577.470140336662;5582.246396736435;5538.252335934648;5590.580706447013;5591.30108736408;5605.579581531381;5645.745941432635;4882.462929077798;4970.801167953277;5089.949100508985;5131.512506311894;5153.871153221181;4961.553460188582;5042.596592272627;5045.949540504603;5046.44489106198;5047.873803154932;4979.402471703401;5037.1940489521685;5039.949600504003;5042.495750424947;5061.19020956647;5086.186210206368;5124.92312615311;5132.666376685504;5142.665726727751;5168.793248270046;4912.680675756064;4923.876903077416;5003.699778013294;5007.574356179729;5012.348394708701;5389.649672771257;5431.348238211401;5449.04641687703;5463.726813659301;5467;5914.142449344821;5950.196723442323;5951.613145145551;5951.970240148771;5954.583179177459;5944.167816505693;5978.312494063195;6060.30306514752;6060.545727852834;6088.208532890696;5534.723263836792;5579.832605021856;5583.776648934037;5584.720763961745;5609.411011843738;5908.409159084057;6092.177556029879;6092.3603021682975;6093.786717464867;6133.846653833601;5803.390643982321;5884.529237660977;5888.5289176865745;5902.498287645512;5904.852378690567;5926.940730592725;5927.73325200367;5933.643981361132;5936.050231962951;5937.614055086406;5724.026915424388;5870.442307980735;5881.264841894763;5882.411758824083;5901.114832775118;5922.970385148133;5937.821865344046;5959.195508606369;5980.581359304807;5982.551308651869;4553.430821147356;4565.771711414416;4577.3362862384765;4583.449986001701;4609.861704148881;3984.561698213194;4045.231406032903;4098.180363927167;4113.321301985139;4142.171565686875;5730.169125476783;5750.539956803445;5758.913616295759;5762.164486149569;5764.164196191528;6044.546659000593;6055.666938318434;6056.939430605726;6058.061000544834;6062.242219722535;5585.162225666182;5609.80365687199;5653.123765816305;5669.886602267931;5744.597878148489;5186.611004174702;5190.844274671766;5193.169092945111;5193.350831146106;5198.376194856642;6273.309935907047;6275.3724627536885;6278.4035516625845;6283.05754136874;6284.088807123033;5861;5966.582339236385;6028.819135426032;6083.574149809471;6089.5432842537875;6238.344973777688;6251.9687401562705;6278.434940855345;6323.798478289111;6327.272363678236;5952.077427998667;5961.850953726018;5964.314103877936;5966.910496342472;6008.519318454426;5890.204822348928;5962.046072628359;6024.277086749618;6065.3934606539;6067.817965461043;5890.293164820249;5917.437843404869;5923;5925.348211696796;5925.614835035709;5739.770409183586;5850.444207800252;5878.059510478303;5908.675022873783;5913.763449462145;5715.085586306171;5781.653100813965;5785.623934444247;5806.44838740319;5822.214001109796;5862.355140934408;5896.174535564938;5901.114832775118;5906.438888305604;5917.171595976481;5539.196816461671;5657.915131272952;5736.053551164178;5747.683877386617;5774.249347584787 08:11:44 INFO - PROCESS | 27122 | |1;ext.html;628.2712054017338;656.1437324291799;680.9387155156035;684.7192651013085;687.9518433709642;32693.50959735606;33265.66734332656;33271.33457330855;33342;39864.60135398645;43992;44496.3325550117;44558.777206113926;44587.77706111465;44692.10615787682;8638.524881131536;8836.160564746338;8884.555772211395;8904.287656987457;8905.376623636348;8735.650573977066;8831.60257788401;8849.867251991225;8851.77870553235;8851.822963540726;8850.468971861677;9155;9167;9167.174954254117;9170.954145229298;9021;9038.231750301233;9076.727698169032;9077.36458447909;9099.454032758023;8972.371933964625;9088.363814532986;9096.317776166748;9101.7269481915;9105.63577456901;43983.78008109971;44548;44677.3298400521;44709.32936005962;44735;3920.0983773731914;3987.2424239394422;4081.1837632473625;4104.753714777123;4708.4349878014855;30182.245443864078;30567.541486877715;30973.69026309753;31603;31805;4551.544845515455;4572.314152877062;4595.195840727893;4615.284630882219;4689.366935463703;289669;289708;290043;290787.54606227047;292022;39923.40114898279;62888.37111628916;64392.35607643957;64402.677986609764;64640.353596464374;38185.42721859174;38262.2347553053;38549;38551.61448385537;38575.807120964215;16223.594410139842;16512.25694843735;16513.752293715603;16529.917350413412;16534.6693066138;13470.326483675777;13493.797593036112;13505.189688618715;13506.257155856325;13515.932420337835;9214.539273036322;9333;9397.76505587352;9402.858957115648;9473.573689184002;3591.94612080819;3631.8547258109907;3652.817359132033;3661.56061272649;3669.3945498992366;1101.0365929811414;1103.8454616353717;1112.5216157052546;1169.2808922512763;1238.133306685324;34483.31033379318;34716.826415867756;34873.65126348755;35135.4729679055;35531.82234088813;1193.9701507462382;1212.4719958885821;1230.7661544306552;1241.8509778826417;1267.4106540458547;17294.567635809206;17464.47606571805;17987.550311242325;18174.727379089323;18308.359207427675;483107;495951;496193;497071;497209;64402.677986609764;65013.349866501674;65130.674346627966;65146;65159.34840651628;1510.4033906607049;1535.055940596525;1586.6112802363496;1587.5475489485673;1598.688255790133;33485.49771753377;34977.30045399027;35475.82262088776;35655.28689426249;35925.820370899026;57368.42631573631;58207;58448;58485.415145848;58516;452579;463556;464219;465311;465450;41888.162236754484;43435.34846977235;43552.34671479867;46579.767101164274;49365.75317123535;49441;49520.50479495303;49752;50020.74989625029;54389.45610543844;44683.55316446924;45176.32235516536;45660;45769.04466160827;46608.30087548622;43119.35320970125;43935.12129757451;44117.11765764731;44318.77840610776;45258;44915.55084449244;45488.31767523423;45778.54221457876;46181.76909115433;46318.30522542097;36501.45247821338;39018.80490597529;39637.80181099076;39764.602353976086;39889.601103988585;29507;29697.40605187841;29708.257293567833;29771.404571908875;29850.253743656584 08:11:44 INFO - PROCESS | 27122 | |2;jquery.html;429.7335651895825;429.8624440179142;435.5383293708669;437.1104801728483;441.6130812955973;18562.35031773888;18763.71854422183;19331;19497.317593884218;19535.316263930767;18509.074546272666;20042.79957200431;20985;21029.47426314339;21106.683399749018;5506.972465137669;5657.434256574341;5739.339975902762;5748.338941021794;5751.971240143815;5606.579506537006;5747.0517364635;5759.712014399284;5762.4525670061485;5959.642421454727;5906.232189815318;5914.733836977325;5943.762249510036;5948.613340132899;5955.047192449209;5701.116326969326;5916.615419997708;5919.792807251747;5925.911111333334;5979.431953964367;5757.798477053283;5790.7973220937065;5805.3323867755325;5840.561957853136;5852.15143804146;22458.887705561367;23172;23208;23275.883620581957;24367.512649747085;2411.0837881605053;2448.7183973843057;2599.974000260011;2676.879540420666;2980.807676929224;10521.368717876876;10661.413622250773;10685.358878467317;10768.676939691823;10874.130069594492;2068.700038494425;2150.6773983902385;2152.300502336747;2164.718586583734;2198.7251593550805;57825.71087144579;73496.6325168376;74078.25921740767;76596.61701691456;82275.17724822735;10585.523651435704;10734.355938643706;10892.183086268562;11076.335419874833;11205.831912521318;15132.319045642973;15847;16419.58951026234;16447.342106315853;16458.917705411397;8200.630971606291;8366.07973122956;8419.115992820789;8511.914880851236;8711.433756805787;8313;8324.375671824637;8332.916670833336;8392.118827523022;8424.747257582283;4648;4870.5388383484815;4877.3903262092235;4882.170031094723;4905.460399356068;2074.620541833867;2089.4149638101358;2107.7259956205594;2163.718716566836;2176.7823217678106;1050.432766306186;1106.0598491282506;1125.0156113400774;1146.266389510714;1149.270213414471;19956;19996;20094.69857952132;20381;20390.286339978327;1066.3335415365398;1076.3004047369272;1081.6646839479786;1097.2757979733497;1171.4318555500574;11332.6033588824;11430.1998860079;11519.963203311741;11541.480633371519;11613.3612651305;554074;561243;574813;575422;584053;93014.53492732493;93298;93394.53302733443;93436;93633.5318323404;1087.4617064553097;1090.9345439273668;1111.6887271563976;1114.9777004459866;1115.2583531951161;17361.739573906652;17523.036233007308;17756.644867102328;17815.821841781417;18364.357247496275;26114.73885261123;37223.62776372202;39380.606193937696;40150.27540512479;40542.1891562173;56767.432325677866;56880.43119568751;57254;57582.424175757704;57671.1349329752;8670.393072484865;8793.65396128507;8861.73414797557;8899.243564297107;9120.087991200828;9061.912570491582;10218.795624087625;12694.809577856524;13919.582412527641;14217.146971181763;11479.25384849982;11536.884631153916;12477.875221247672;12635.87364126347;12649.810252846031;10938.343699377745;11140.387278699749;11896.524139034342;12364.938175309066;12615.621531354074;12488.25070495773;12586.748265034832;12736.61790146297;12763.170393924365;13015.414306356426;8888.511131887808;8954.731358059269;8977.640894364413;9018.86471702938;9199.218066464426;11512.654620361403;12280.938595306967;12354.876451235732;12365.75268494643;12376.319302438093 08:11:44 INFO - PROCESS | 27122 | |3;mootools.html;1405.2973513243378;1500.669852632421;1576.8344323846;1809.375765360951;1951.3365455745043;8234.75295741128;8421.70524031659;8427.494350338977;8436.325093992482;8445.873311900326;8348.081711011799;8436.15638436156;8483.490990540571;8507.829843403128;8517.446365986207;2130.9893450532727;2424.406020524974;2470.419451428913;2492.9002839886384;2497.5504409206337;2456.533258680845;2503.1864643990684;2511.3972646564785;2511.8744062796877;2515.55977703902;2417.721961974369;2438.5001074779716;2444.2667199840066;2448.1186772761794;2448.52253810507;2121.3847984084596;2437.244454219189;2499.200255918107;2503.486785209037;2507.4734305795805;2225.2100504320897;2226.4545186429427;2227.042371780134;2288.302067869299;2370.8340416170877;8241.381896357798;8279.296259817922;8288.378371622153;8295;8299.419040667155;5354.946450535484;5395.946040539584;5438.564914806845;5457.536109430703;5535.114381698909;3713.3687273163628;3770.9825243494874;3830.9042273943096;3837.347650899326;3862.748921320105;1246.7818131826984;1254.1597129922973;1256.9685757856034;1287.2405280884323;1317.426919290112;12275.140740148105;12291.446884890202;12313.199642023239;12319.322437265946;12331.753364932742;4828.537445902615;4936.925946110811;4973.950260497349;4975.5819591416275;5002.849914502571;10343.94828025855;10380.221483388625;10435.321704089361;10446.63436779709;10459.424731639832;4653.488116307203;5527.834164975057;5582.665040097607;5591.888162236733;5594.272744543184;4957.677750946177;4967.577755890789;5007;5009.7244651544515;5040.49595040493;4208.705390622688;4227.450431443954;4246.787660616957;4378.934315985262;4426.181156485996;1325.7414804113105;1374.0656353679394;1382.9075030725614;1399.4961813747043;1414.1232435889815;978.3885071830106;1094.6934858239547;1104.0780947908586;1106.9335839849634;1113.2708076210095;5982.581219314693;6048.818535443944;6087.482563982023;6098.908516372258;6168.259808822881;503.19237623614305;503.91603387269413;506.3619839002883;513.3224144129713;517.5212928041547;4060.4315395844606;4061.7156799024374;4062.959370406258;4113.197926404322;4134.276501612266;10611.25721199524;10742.946285268523;10773.946130269298;10911.236213464981;10914.945425272823;10587.258891877495;10747.83878241827;10753.032227099442;10794.730131746612;10808.513616887101;8064.354851611857;8372.413931024892;8411.495310281403;8432;8441.66233350659;6003.519718422603;6040.395960403925;6058.182145410313;6063.605865618721;6233.314335423191;9528.904710952802;9536.713898583053;9656.034396560288;9757.756056098655;9768.07203315684;9592.184664303333;9635.855462167932;9789.314747967574;9844.310898237054;10058;6892.896606550806;7393.704251829867;7641.312281894656;7858.44990850635;7934.642941067781;8408.663653453794;8500.36247281444;8516.40385173032;8548.786280343042;8552.828943421222;7536.284053014955;7792.376609871083;7797.337226335825;7879.64541595641;7981.361491080584;7575.128860181149;7701.576413297323;7707.036620422447;7817.452778305464;7821.6089195541135;7208.387287080657;7279.59962202084;7279.636018198963;7285.526440781332;7297.124345078624;5364.919526207188;5368.785248590013;5410.296661433988;5430.42980487059;5488.807891723771;5339.599530035341;5364.846557990051;5486.204500347507;5533.667979921218;5647.3505546861 08:11:44 INFO - PROCESS | 27122 | |4;prototype.html;356.5080189338712;358.7972795370615;364.6280793590538;375.8665673685843;381.862529489384;6146.8463288417815;6152.692365381736;6158.784442544512;6194.814155575329;6228.781992630259;6129.387061293868;6143.600665956721;6147.661878596676;6151.538634602401;6170.074488826678;4473.9552604473865;4604.608608268301;4686.765661716918;4688.226442636961;4699.201135806904;4709.340692303081;4712.458067322251;4739.218029025206;4752.572268495835;4763.880902977418;4444.111177764444;4708.340832283483;4714.4578373486975;4717.858464246078;4718.858434246961;4585.931211031837;4685.2269375553;4707.199776038047;4709.246520556729;4710.646701497367;4189.560096189917;4193.245215861144;4193.308104162809;4205.642520385771;4207;5926.111083337534;5928.733207005652;5936.317323507808;5940;5941.762329506814;5533.557315414798;5536.280283563111;5540.335159780852;5542.279503664538;5546.417626149237;6331.176946996907;6452.64510451925;6457.418832305115;6457.677116144221;6464.288928217892;4612.492625811158;4633.2818413146015;4642.837500687494;4645.117427688729;4650.581447669726;6690.966545167292;6716.865662686719;6734.46124310054;6736.46108311334;6739.764108256237;4739.928901066487;4746.311784791186;4754.809807607657;4757.881052973703;4758.381410416624;4802.975985120122;4804.807807687654;4807.278908163804;4810.735409552438;4826.493218212107;5466.508014278734;5472.835814925558;5479.726013699299;5479.917801232985;5483.643563168382;6290.182276304051;6481.157449531531;6508.934910650928;6515.902261466082;6516.120323756327;1619.1256721370564;1632.0697202594645;1638.852503274711;1644.7697322374877;1645.983540164607;1010.9039641234218;1048.9562884929392;1078.5200585739271;1088.6570730219955;1096.8519249901321;6247.875042499125;6264.780732674334;6328.11406403104;6335.271443784024;6344.968275158594;6663.233728121328;6666.933330666631;6677.098591690156;6677.599344039373;6680.565763225375;6322.33615470369;6325.304216536178;6337.809865704036;6341.985282354801;6345.175127233522;3545.663161999606;3581.426971684518;3585.4084076127147;3586.7130629549574;3589.4974703541525;6798.082258895085;6903.585784852925;6936.653167341613;6945.687444065029;6946.756863509753;6724.4284235840505;6746.561473504206;6746.898796518056;6759.391654751096;6761.830954226085;6893.034975103489;6895.965520172467;6908.861822763517;6922.342377474132;6945.236024037352;6646.036324732983;6650.501212409185;6657.900131497934;6662.06731057662;6666.066750654815;6409;6544.28012918569;6595.967020164869;6618.371254730793;6634.635095069818;6894.379505844498;6927.58434493932;6928.411085057625;6933;6939.097917270722;4593.724376537285;4595.770211489479;4601.44782626087;4602.148602508547;4605.217113090715;6605;6608.900866487103;6611.900821487586;6619.966900165468;6628.966855165693;6328;6451.935480645134;6454.128692626436;6527.412532872065;6534.117894084237;6400.743970241138;6420.935790642221;6448.484121270381;6472.902906456313;6483.124778154889;6272.717727702356;6287.528435367274;6292.905606415999;6297.307296197506;6304.117423560613;6446.904026315444;6448.645324507197;6462.127612772216;6471.255805582418;6523.282438931808;6086.908696369469;6095.146679464967;6149.954507733606;6251.156093927261;6300.2754683212015 08:11:44 INFO - PROCESS | 27122 | |5;yui.html;765.3991616580981;834.2283387866227;873.253368370044;876.2902049340037;910.2672348759248;15399.461018864342;15560.922195389006;15562.455314063996;15582.220888955564;15656.060636361812;13332.933335333333;13836.861631383683;13880.583582492542;13911.095778774372;13938.233397163178;770.1836053783007;924.560833604036;933.0669330669348;937.6718148647952;951.490952340498;929.066288380177;933.2300851797261;933.3653115881198;933.4725879877848;936.2229349639782;981.1218959031662;982.3271059324386;984.1142971325828;984.4437892590663;986.7829077602916;816.3754727633366;972.9318947673595;980.01998001998;985.5121714751173;988.6094992478003;714.0610097721479;717.5909731453074;718.6011763471271;719.4028955966587;723.4501778648213;15925.124118173495;15956.760648590165;15965.680686386324;15978.44075457365;15988.440404585785;14787.630309242248;15296.311665974947;15500.302486388027;15524.223788810514;15529.145896975662;12016.339101349422;12179.147459677826;12235.877641223651;12237.449314780857;12237.449314780857;4697.859064228079;4711.387519622427;4725.385699858996;4760.071786001731;4838.709677419366;54870.451295486935;55575.72212138913;60737;61123.69438152781;61269;11892.762144757056;12097.697557560956;12166.756664866652;12305.077119215915;12412.56556020553;20010.69983950242;20155.193792248145;20287.391378258675;20318.390448286576;20339.796602034086;8859;8899.33255005877;8903.777405564913;9234.122758337948;9256;5061.544460998528;5164.096283150434;5165.2149592455935;5245.842624721265;5321.86695332612;3597.4244120940525;3728.832202550892;3769.8313522808016;3818.427235914635;3820.2550502651716;685.3831551603597;702.8242939265184;705.1432509500981;707.345705222667;711.6477343714894;651.840299126717;679.751890559942;730.4010711216857;759.9430042746816;767.9539227646359;8473.449225800427;8584.699535516227;8698.33129590416;8755.212030917248;8916;716.3695947566108;725.2058995400029;738.9076365454318;741.6069483173926;770.1374460604159;4091.3044782387065;4241.554636763157;4357.629601483909;4380.551030879029;4475.060237350193;58501.70749146227;62686.0597091044;63560;63715;67045.66477167583;57831.71084144552;59362.70318648466;61184;61752.07371889425;61772.69113654403;53472;53983.46016539863;54575;54674.72662636741;55738.72130639402;9609.183219426428;9627.326087173831;9656.275779316438;9804.803903922024;9829.262805289774;39338.409923850595;39501.604983949794;40100.3984940232;40117;40151.59848401479;47458.76270618625;47465.76267118642;51658;52149;54169;12833.486660533474;12887.548935787578;12942.741145177231;13037.15258508194;13125;13921.234332111831;14621.561353159423;14818.851811481747;14872.851271487147;15221.315040822969;13190.73618527605;13226;13305.667358315732;13580.660483487993;14203.934704896967;13665.385057672229;13725.862741372857;13875.375608097862;13948.930255349063;14008.579742607739;13279.402426891007;13493.122947008413;13571.117877337942;13585.728285434037;13702.10936289138;10729;10831.458427078456;10857.40284284372;10948.726281843017;11067.72330691739;10772.515236814519;10813.760261911195;10882.78234435291;10924.235303528676;10938.507767150657 08:11:44 INFO - PROCESS | 27122 | __end_tp_report 08:11:44 INFO - PROCESS | 27122 | __start_cc_report 08:11:44 INFO - PROCESS | 27122 | _x_x_mozilla_cycle_collect,843 08:11:44 INFO - PROCESS | 27122 | __end_cc_report 08:11:44 INFO - PROCESS | 27122 | __startTimestamp1464793904314__endTimestamp 08:11:44 INFO - PROCESS | 27122 | 08:11:44 INFO - PROCESS | 27122 | ------- Summary: start ------- 08:11:44 INFO - PROCESS | 27122 | Number of tests: 6 08:11:44 INFO - PROCESS | 27122 | 08:11:44 INFO - PROCESS | 27122 | [#0] dojo.html Cycles:165 Average:5557.53 Median:5774.25 stddev:626.91 (10.9%) stddev-sans-first:603.96 08:11:44 INFO - PROCESS | 27122 | Values: 3328.8 3368.3 3376.7 3387.9 3429.2 5524.8 5527.3 5542.6 5577.5 5582.2 5538.3 5590.6 5591.3 5605.6 5645.7 4882.5 4970.8 5089.9 5131.5 5153.9 4961.6 5042.6 5045.9 5046.4 5047.9 4979.4 5037.2 5039.9 5042.5 5061.2 5086.2 5124.9 5132.7 5142.7 5168.8 4912.7 4923.9 5003.7 5007.6 5012.3 5389.6 5431.3 5449.0 5463.7 5467.0 5914.1 5950.2 5951.6 5952.0 5954.6 5944.2 5978.3 6060.3 6060.5 6088.2 5534.7 5579.8 5583.8 5584.7 5609.4 5908.4 6092.2 6092.4 6093.8 6133.8 5803.4 5884.5 5888.5 5902.5 5904.9 5926.9 5927.7 5933.6 5936.1 5937.6 5724.0 5870.4 5881.3 5882.4 5901.1 5923.0 5937.8 5959.2 5980.6 5982.6 4553.4 4565.8 4577.3 4583.4 4609.9 3984.6 4045.2 4098.2 4113.3 4142.2 5730.2 5750.5 5758.9 5762.2 5764.2 6044.5 6055.7 6056.9 6058.1 6062.2 5585.2 5609.8 5653.1 5669.9 5744.6 5186.6 5190.8 5193.2 5193.4 5198.4 6273.3 6275.4 6278.4 6283.1 6284.1 5861.0 5966.6 6028.8 6083.6 6089.5 6238.3 6252.0 6278.4 6323.8 6327.3 5952.1 5961.9 5964.3 5966.9 6008.5 5890.2 5962.0 6024.3 6065.4 6067.8 5890.3 5917.4 5923.0 5925.3 5925.6 5739.8 5850.4 5878.1 5908.7 5913.8 5715.1 5781.7 5785.6 5806.4 5822.2 5862.4 5896.2 5901.1 5906.4 5917.2 5539.2 5657.9 5736.1 5747.7 5774.2 08:11:44 INFO - PROCESS | 27122 | 08:11:44 INFO - PROCESS | 27122 | [#1] ext.html Cycles:180 Average:58633.05 Median:44553.39 stddev:112605.79 (252.7%) stddev-sans-first:112837.46 08:11:44 INFO - PROCESS | 27122 | Values: 628.3 656.1 680.9 684.7 688.0 32693.5 33265.7 33271.3 33342.0 39864.6 43992.0 44496.3 44558.8 44587.8 44692.1 8638.5 8836.2 8884.6 8904.3 8905.4 8735.7 8831.6 8849.9 8851.8 8851.8 8850.5 9155.0 9167.0 9167.2 9171.0 9021.0 9038.2 9076.7 9077.4 9099.5 8972.4 9088.4 9096.3 9101.7 9105.6 43983.8 44548.0 44677.3 44709.3 44735.0 3920.1 3987.2 4081.2 4104.8 4708.4 30182.2 30567.5 30973.7 31603.0 31805.0 4551.5 4572.3 4595.2 4615.3 4689.4 289669.0 289708.0 290043.0 290787.5 292022.0 39923.4 62888.4 64392.4 64402.7 64640.4 38185.4 38262.2 38549.0 38551.6 38575.8 16223.6 16512.3 16513.8 16529.9 16534.7 13470.3 13493.8 13505.2 13506.3 13515.9 9214.5 9333.0 9397.8 9402.9 9473.6 3591.9 3631.9 3652.8 3661.6 3669.4 1101.0 1103.8 1112.5 1169.3 1238.1 34483.3 34716.8 34873.7 35135.5 35531.8 1194.0 1212.5 1230.8 1241.9 1267.4 17294.6 17464.5 17987.6 18174.7 18308.4 483107.0 495951.0 496193.0 497071.0 497209.0 64402.7 65013.3 65130.7 65146.0 65159.3 1510.4 1535.1 1586.6 1587.5 1598.7 33485.5 34977.3 35475.8 35655.3 35925.8 57368.4 58207.0 58448.0 58485.4 58516.0 452579.0 463556.0 464219.0 465311.0 465450.0 41888.2 43435.3 43552.3 46579.8 49365.8 49441.0 49520.5 49752.0 50020.7 54389.5 44683.6 45176.3 45660.0 45769.0 46608.3 43119.4 43935.1 44117.1 44318.8 45258.0 44915.6 45488.3 45778.5 46181.8 46318.3 36501.5 39018.8 39637.8 39764.6 39889.6 29507.0 29697.4 29708.3 29771.4 29850.3 08:11:44 INFO - PROCESS | 27122 | 08:11:44 INFO - PROCESS | 27122 | [#2] jquery.html Cycles:180 Average:31110.96 Median:23190.00 stddev:93466.93 (403.0%) stddev-sans-first:93700.74 08:11:44 INFO - PROCESS | 27122 | Values: 429.7 429.9 435.5 437.1 441.6 18562.4 18763.7 19331.0 19497.3 19535.3 18509.1 20042.8 20985.0 21029.5 21106.7 5507.0 5657.4 5739.3 5748.3 5752.0 5606.6 5747.1 5759.7 5762.5 5959.6 5906.2 5914.7 5943.8 5948.6 5955.0 5701.1 5916.6 5919.8 5925.9 5979.4 5757.8 5790.8 5805.3 5840.6 5852.2 22458.9 23172.0 23208.0 23275.9 24367.5 2411.1 2448.7 2600.0 2676.9 2980.8 10521.4 10661.4 10685.4 10768.7 10874.1 2068.7 2150.7 2152.3 2164.7 2198.7 57825.7 73496.6 74078.3 76596.6 82275.2 10585.5 10734.4 10892.2 11076.3 11205.8 15132.3 15847.0 16419.6 16447.3 16458.9 8200.6 8366.1 8419.1 8511.9 8711.4 8313.0 8324.4 8332.9 8392.1 8424.7 4648.0 4870.5 4877.4 4882.2 4905.5 2074.6 2089.4 2107.7 2163.7 2176.8 1050.4 1106.1 1125.0 1146.3 1149.3 19956.0 19996.0 20094.7 20381.0 20390.3 1066.3 1076.3 1081.7 1097.3 1171.4 11332.6 11430.2 11520.0 11541.5 11613.4 554074.0 561243.0 574813.0 575422.0 584053.0 93014.5 93298.0 93394.5 93436.0 93633.5 1087.5 1090.9 1111.7 1115.0 1115.3 17361.7 17523.0 17756.6 17815.8 18364.4 26114.7 37223.6 39380.6 40150.3 40542.2 56767.4 56880.4 57254.0 57582.4 57671.1 8670.4 8793.7 8861.7 8899.2 9120.1 9061.9 10218.8 12694.8 13919.6 14217.1 11479.3 11536.9 12477.9 12635.9 12649.8 10938.3 11140.4 11896.5 12364.9 12615.6 12488.3 12586.7 12736.6 12763.2 13015.4 8888.5 8954.7 8977.6 9018.9 9199.2 11512.7 12280.9 12354.9 12365.8 12376.3 08:11:44 INFO - PROCESS | 27122 | 08:11:44 INFO - PROCESS | 27122 | [#3] mootools.html Cycles:180 Average:5830.85 Median:503.55 stddev:3202.78 (636.0%) stddev-sans-first:3194.49 08:11:44 INFO - PROCESS | 27122 | Values: 1405.3 1500.7 1576.8 1809.4 1951.3 8234.8 8421.7 8427.5 8436.3 8445.9 8348.1 8436.2 8483.5 8507.8 8517.4 2131.0 2424.4 2470.4 2492.9 2497.6 2456.5 2503.2 2511.4 2511.9 2515.6 2417.7 2438.5 2444.3 2448.1 2448.5 2121.4 2437.2 2499.2 2503.5 2507.5 2225.2 2226.5 2227.0 2288.3 2370.8 8241.4 8279.3 8288.4 8295.0 8299.4 5354.9 5395.9 5438.6 5457.5 5535.1 3713.4 3771.0 3830.9 3837.3 3862.7 1246.8 1254.2 1257.0 1287.2 1317.4 12275.1 12291.4 12313.2 12319.3 12331.8 4828.5 4936.9 4974.0 4975.6 5002.8 10343.9 10380.2 10435.3 10446.6 10459.4 4653.5 5527.8 5582.7 5591.9 5594.3 4957.7 4967.6 5007.0 5009.7 5040.5 4208.7 4227.5 4246.8 4378.9 4426.2 1325.7 1374.1 1382.9 1399.5 1414.1 978.4 1094.7 1104.1 1106.9 1113.3 5982.6 6048.8 6087.5 6098.9 6168.3 503.2 503.9 506.4 513.3 517.5 4060.4 4061.7 4063.0 4113.2 4134.3 10611.3 10742.9 10773.9 10911.2 10914.9 10587.3 10747.8 10753.0 10794.7 10808.5 8064.4 8372.4 8411.5 8432.0 8441.7 6003.5 6040.4 6058.2 6063.6 6233.3 9528.9 9536.7 9656.0 9757.8 9768.1 9592.2 9635.9 9789.3 9844.3 10058.0 6892.9 7393.7 7641.3 7858.4 7934.6 8408.7 8500.4 8516.4 8548.8 8552.8 7536.3 7792.4 7797.3 7879.6 7981.4 7575.1 7701.6 7707.0 7817.5 7821.6 7208.4 7279.6 7279.6 7285.5 7297.1 5364.9 5368.8 5410.3 5430.4 5488.8 5339.6 5364.8 5486.2 5533.7 5647.4 08:11:44 INFO - PROCESS | 27122 | 08:11:44 INFO - PROCESS | 27122 | [#4] prototype.html Cycles:180 Average:5436.70 Median:6182.44 stddev:1618.22 (26.2%) stddev-sans-first:1577.19 08:11:44 INFO - PROCESS | 27122 | Values: 356.5 358.8 364.6 375.9 381.9 6146.8 6152.7 6158.8 6194.8 6228.8 6129.4 6143.6 6147.7 6151.5 6170.1 4474.0 4604.6 4686.8 4688.2 4699.2 4709.3 4712.5 4739.2 4752.6 4763.9 4444.1 4708.3 4714.5 4717.9 4718.9 4585.9 4685.2 4707.2 4709.2 4710.6 4189.6 4193.2 4193.3 4205.6 4207.0 5926.1 5928.7 5936.3 5940.0 5941.8 5533.6 5536.3 5540.3 5542.3 5546.4 6331.2 6452.6 6457.4 6457.7 6464.3 4612.5 4633.3 4642.8 4645.1 4650.6 6691.0 6716.9 6734.5 6736.5 6739.8 4739.9 4746.3 4754.8 4757.9 4758.4 4803.0 4804.8 4807.3 4810.7 4826.5 5466.5 5472.8 5479.7 5479.9 5483.6 6290.2 6481.2 6508.9 6515.9 6516.1 1619.1 1632.1 1638.9 1644.8 1646.0 1010.9 1049.0 1078.5 1088.7 1096.9 6247.9 6264.8 6328.1 6335.3 6345.0 6663.2 6666.9 6677.1 6677.6 6680.6 6322.3 6325.3 6337.8 6342.0 6345.2 3545.7 3581.4 3585.4 3586.7 3589.5 6798.1 6903.6 6936.7 6945.7 6946.8 6724.4 6746.6 6746.9 6759.4 6761.8 6893.0 6896.0 6908.9 6922.3 6945.2 6646.0 6650.5 6657.9 6662.1 6666.1 6409.0 6544.3 6596.0 6618.4 6634.6 6894.4 6927.6 6928.4 6933.0 6939.1 4593.7 4595.8 4601.4 4602.1 4605.2 6605.0 6608.9 6611.9 6620.0 6629.0 6328.0 6451.9 6454.1 6527.4 6534.1 6400.7 6420.9 6448.5 6472.9 6483.1 6272.7 6287.5 6292.9 6297.3 6304.1 6446.9 6448.6 6462.1 6471.3 6523.3 6086.9 6095.1 6150.0 6251.2 6300.3 08:11:44 INFO - PROCESS | 27122 | 08:11:44 INFO - PROCESS | 27122 | [#5] yui.html Cycles:180 Average:15986.27 Median:4799.39 stddev:18430.38 (384.0%) stddev-sans-first:18446.64 08:11:44 INFO - PROCESS | 27122 | Values: 765.4 834.2 873.3 876.3 910.3 15399.5 15560.9 15562.5 15582.2 15656.1 13332.9 13836.9 13880.6 13911.1 13938.2 770.2 924.6 933.1 937.7 951.5 929.1 933.2 933.4 933.5 936.2 981.1 982.3 984.1 984.4 986.8 816.4 972.9 980.0 985.5 988.6 714.1 717.6 718.6 719.4 723.5 15925.1 15956.8 15965.7 15978.4 15988.4 14787.6 15296.3 15500.3 15524.2 15529.1 12016.3 12179.1 12235.9 12237.4 12237.4 4697.9 4711.4 4725.4 4760.1 4838.7 54870.5 55575.7 60737.0 61123.7 61269.0 11892.8 12097.7 12166.8 12305.1 12412.6 20010.7 20155.2 20287.4 20318.4 20339.8 8859.0 8899.3 8903.8 9234.1 9256.0 5061.5 5164.1 5165.2 5245.8 5321.9 3597.4 3728.8 3769.8 3818.4 3820.3 685.4 702.8 705.1 707.3 711.6 651.8 679.8 730.4 759.9 768.0 8473.4 8584.7 8698.3 8755.2 8916.0 716.4 725.2 738.9 741.6 770.1 4091.3 4241.6 4357.6 4380.6 4475.1 58501.7 62686.1 63560.0 63715.0 67045.7 57831.7 59362.7 61184.0 61752.1 61772.7 53472.0 53983.5 54575.0 54674.7 55738.7 9609.2 9627.3 9656.3 9804.8 9829.3 39338.4 39501.6 40100.4 40117.0 40151.6 47458.8 47465.8 51658.0 52149.0 54169.0 12833.5 12887.5 12942.7 13037.2 13125.0 13921.2 14621.6 14818.9 14872.9 15221.3 13190.7 13226.0 13305.7 13580.7 14203.9 13665.4 13725.9 13875.4 13948.9 14008.6 13279.4 13493.1 13571.1 13585.7 13702.1 10729.0 10831.5 10857.4 10948.7 11067.7 10772.5 10813.8 10882.8 10924.2 10938.5 08:11:44 INFO - PROCESS | 27122 | -------- Summary: end -------- 08:11:44 INFO - PROCESS | 27122 | 08:11:45 INFO - TEST-INFO | 27122: exit 0 08:11:45 INFO - TEST-OK | dromaeo_css | took 1111436ms 08:11:45 INFO - TEST-START | kraken 08:11:45 INFO - operating with platform_type : linux_ 08:11:45 INFO - Initialising browser for kraken test... 08:11:45 INFO - TEST-INFO | started process 27309 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_0WK8w/profile http://localhost:51933/getInfo.html) 08:11:49 INFO - PROCESS | 27309 | __metrics Screen width/height:1600/1200 08:11:49 INFO - PROCESS | 27309 | colorDepth:24 08:11:49 INFO - PROCESS | 27309 | Browser inner width/height: 1024/697 08:11:49 INFO - PROCESS | 27309 | __metrics 08:11:50 ERROR - PROCESS | 27309 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 08:11:50 INFO - TEST-INFO | 27309: exit 0 08:11:50 INFO - Browser initialized. 08:11:50 INFO - Running cycle 1/1 for kraken test... 08:11:50 INFO - TEST-INFO | started process 27399 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_0WK8w/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:12:02 INFO - PROCESS | 27399 | RSS: Main: 141742080 08:12:02 INFO - PROCESS | 27399 | 08:12:05 INFO - PROCESS | 27399 | Cycle 1(1): loaded http://localhost:51933/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51933/tests/kraken/driver.html?testName=audio-beat-detection) 08:12:05 INFO - PROCESS | 27399 | RSS: Main: 196448256 08:12:05 INFO - PROCESS | 27399 | 08:12:08 INFO - PROCESS | 27399 | Cycle 1(1): loaded http://localhost:51933/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51933/tests/kraken/driver.html?testName=audio-dft) 08:12:09 INFO - PROCESS | 27399 | RSS: Main: 181583872 08:12:09 INFO - PROCESS | 27399 | 08:12:12 INFO - PROCESS | 27399 | Cycle 1(1): loaded http://localhost:51933/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51933/tests/kraken/driver.html?testName=audio-fft) 08:12:12 INFO - PROCESS | 27399 | RSS: Main: 271507456 08:12:12 INFO - PROCESS | 27399 | 08:12:14 INFO - PROCESS | 27399 | Cycle 1(1): loaded http://localhost:51933/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51933/tests/kraken/driver.html?testName=audio-oscillator) 08:12:15 INFO - PROCESS | 27399 | RSS: Main: 178458624 08:12:15 INFO - PROCESS | 27399 | 08:12:17 INFO - PROCESS | 27399 | Cycle 1(1): loaded http://localhost:51933/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51933/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:12:18 INFO - PROCESS | 27399 | RSS: Main: 176422912 08:12:18 INFO - PROCESS | 27399 | 08:12:21 INFO - PROCESS | 27399 | Cycle 1(1): loaded http://localhost:51933/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51933/tests/kraken/driver.html?testName=imaging-darkroom) 08:12:21 INFO - PROCESS | 27399 | RSS: Main: 211304448 08:12:21 INFO - PROCESS | 27399 | 08:12:24 INFO - PROCESS | 27399 | Cycle 1(1): loaded http://localhost:51933/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51933/tests/kraken/driver.html?testName=imaging-desaturate) 08:12:25 INFO - PROCESS | 27399 | RSS: Main: 210620416 08:12:25 INFO - PROCESS | 27399 | 08:12:28 INFO - PROCESS | 27399 | Cycle 1(1): loaded http://localhost:51933/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51933/tests/kraken/driver.html?testName=json-parse-financial) 08:12:28 INFO - PROCESS | 27399 | RSS: Main: 211578880 08:12:28 INFO - PROCESS | 27399 | 08:12:30 INFO - PROCESS | 27399 | Cycle 1(1): loaded http://localhost:51933/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51933/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:12:31 INFO - PROCESS | 27399 | RSS: Main: 190644224 08:12:31 INFO - PROCESS | 27399 | 08:12:32 INFO - PROCESS | 27399 | Cycle 1(1): loaded http://localhost:51933/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51933/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:12:33 INFO - PROCESS | 27399 | RSS: Main: 196313088 08:12:33 INFO - PROCESS | 27399 | 08:12:35 INFO - PROCESS | 27399 | Cycle 1(1): loaded http://localhost:51933/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51933/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:12:35 INFO - PROCESS | 27399 | RSS: Main: 207544320 08:12:35 INFO - PROCESS | 27399 | 08:12:38 INFO - PROCESS | 27399 | Cycle 1(1): loaded http://localhost:51933/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51933/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:12:38 INFO - PROCESS | 27399 | RSS: Main: 212910080 08:12:38 INFO - PROCESS | 27399 | 08:12:41 INFO - PROCESS | 27399 | Cycle 1(1): loaded http://localhost:51933/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51933/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:12:42 INFO - PROCESS | 27399 | RSS: Main: 208437248 08:12:42 INFO - PROCESS | 27399 | 08:12:43 INFO - PROCESS | 27399 | Cycle 1(1): loaded http://localhost:51933/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51933/tests/kraken/driver.html?testName=ai-astar) 08:12:44 INFO - PROCESS | 27399 | RSS: Main: 271974400 08:12:44 INFO - PROCESS | 27399 | 08:12:44 INFO - PROCESS | 27399 | __start_tp_report 08:12:44 INFO - PROCESS | 27399 | _x_x_mozilla_page_load 08:12:44 INFO - PROCESS | 27399 | _x_x_mozilla_page_load_details 08:12:44 INFO - PROCESS | 27399 | |i|pagename|runs| 08:12:44 INFO - PROCESS | 27399 | |0;ai-astar;110;111;110;109;109;110;103;111;107;108 08:12:44 INFO - PROCESS | 27399 | |1;audio-beat-detection;160;128;152;169;134;154;157;128;178;126 08:12:44 INFO - PROCESS | 27399 | |2;audio-dft;161;162;161;162;161;160;162;161;162;160 08:12:44 INFO - PROCESS | 27399 | |3;audio-fft;77;75;75;178;75;77;75;75;166;75 08:12:44 INFO - PROCESS | 27399 | |4;audio-oscillator;92;92;161;92;93;93;151;92;94;150 08:12:44 INFO - PROCESS | 27399 | |5;imaging-gaussian-blur;116;116;117;116;116;116;116;117;117;116 08:12:44 INFO - PROCESS | 27399 | |6;imaging-darkroom;146;145;146;146;145;145;145;146;146;146 08:12:44 INFO - PROCESS | 27399 | |7;imaging-desaturate;95;95;94;94;95;94;95;95;94;95 08:12:44 INFO - PROCESS | 27399 | |8;json-parse-financial;52;54;53;54;53;55;56;73;52;52 08:12:44 INFO - PROCESS | 27399 | |9;json-stringify-tinderbox;61;58;58;57;58;58;58;57;58;57 08:12:44 INFO - PROCESS | 27399 | |10;stanford-crypto-aes;73;72;72;73;72;73;71;73;72;73 08:12:44 INFO - PROCESS | 27399 | |11;stanford-crypto-ccm;121;116;112;110;110;114;112;112;131;132 08:12:44 INFO - PROCESS | 27399 | |12;stanford-crypto-pbkdf2;157;153;158;157;154;157;158;159;153;159 08:12:44 INFO - PROCESS | 27399 | |13;stanford-crypto-sha256-iterative;68;66;66;66;68;65;64;68;66;61 08:12:44 INFO - PROCESS | 27399 | __end_tp_report 08:12:44 INFO - PROCESS | 27399 | __start_cc_report 08:12:44 INFO - PROCESS | 27399 | _x_x_mozilla_cycle_collect,1627 08:12:44 INFO - PROCESS | 27399 | __end_cc_report 08:12:44 INFO - PROCESS | 27399 | __startTimestamp1464793964108__endTimestamp 08:12:44 INFO - PROCESS | 27399 | 08:12:44 INFO - PROCESS | 27399 | ------- Summary: start ------- 08:12:44 INFO - PROCESS | 27399 | Number of tests: 14 08:12:44 INFO - PROCESS | 27399 | 08:12:44 INFO - PROCESS | 27399 | [#0] ai-astar Cycles:10 Average:108.80 Median:110.00 stddev:2.39 (2.2%) stddev-sans-first:2.50 08:12:44 INFO - PROCESS | 27399 | Values: 110.0 111.0 110.0 109.0 109.0 110.0 103.0 111.0 107.0 108.0 08:12:44 INFO - PROCESS | 27399 | 08:12:44 INFO - PROCESS | 27399 | [#1] audio-beat-detection Cycles:10 Average:148.60 Median:155.50 stddev:18.54 (11.9%) stddev-sans-first:19.20 08:12:44 INFO - PROCESS | 27399 | Values: 160.0 128.0 152.0 169.0 134.0 154.0 157.0 128.0 178.0 126.0 08:12:44 INFO - PROCESS | 27399 | 08:12:44 INFO - PROCESS | 27399 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.50 stddev:0.79 (0.5%) stddev-sans-first:0.83 08:12:44 INFO - PROCESS | 27399 | Values: 161.0 162.0 161.0 162.0 161.0 160.0 162.0 161.0 162.0 160.0 08:12:44 INFO - PROCESS | 27399 | 08:12:44 INFO - PROCESS | 27399 | [#3] audio-fft Cycles:10 Average:94.80 Median:75.00 stddev:40.79 (54.4%) stddev-sans-first:42.76 08:12:44 INFO - PROCESS | 27399 | Values: 77.0 75.0 75.0 178.0 75.0 77.0 75.0 75.0 166.0 75.0 08:12:44 INFO - PROCESS | 27399 | 08:12:44 INFO - PROCESS | 27399 | [#4] audio-oscillator Cycles:10 Average:111.00 Median:92.00 stddev:29.82 (32.4%) stddev-sans-first:30.82 08:12:44 INFO - PROCESS | 27399 | Values: 92.0 92.0 161.0 92.0 93.0 93.0 151.0 92.0 94.0 150.0 08:12:44 INFO - PROCESS | 27399 | 08:12:44 INFO - PROCESS | 27399 | [#5] imaging-gaussian-blur Cycles:10 Average:116.30 Median:116.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 08:12:44 INFO - PROCESS | 27399 | Values: 116.0 116.0 117.0 116.0 116.0 116.0 116.0 117.0 117.0 116.0 08:12:44 INFO - PROCESS | 27399 | 08:12:44 INFO - PROCESS | 27399 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 08:12:44 INFO - PROCESS | 27399 | Values: 146.0 145.0 146.0 146.0 145.0 145.0 145.0 146.0 146.0 146.0 08:12:44 INFO - PROCESS | 27399 | 08:12:44 INFO - PROCESS | 27399 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 08:12:44 INFO - PROCESS | 27399 | Values: 95.0 95.0 94.0 94.0 95.0 94.0 95.0 95.0 94.0 95.0 08:12:44 INFO - PROCESS | 27399 | 08:12:44 INFO - PROCESS | 27399 | [#8] json-parse-financial Cycles:10 Average:55.40 Median:54.00 stddev:6.33 (11.7%) stddev-sans-first:6.59 08:12:44 INFO - PROCESS | 27399 | Values: 52.0 54.0 53.0 54.0 53.0 55.0 56.0 73.0 52.0 52.0 08:12:44 INFO - PROCESS | 27399 | 08:12:44 INFO - PROCESS | 27399 | [#9] json-stringify-tinderbox Cycles:10 Average:58.00 Median:58.00 stddev:1.15 (2.0%) stddev-sans-first:0.50 08:12:44 INFO - PROCESS | 27399 | Values: 61.0 58.0 58.0 57.0 58.0 58.0 58.0 57.0 58.0 57.0 08:12:44 INFO - PROCESS | 27399 | 08:12:44 INFO - PROCESS | 27399 | [#10] stanford-crypto-aes Cycles:10 Average:72.40 Median:73.00 stddev:0.70 (1.0%) stddev-sans-first:0.71 08:12:44 INFO - PROCESS | 27399 | Values: 73.0 72.0 72.0 73.0 72.0 73.0 71.0 73.0 72.0 73.0 08:12:44 INFO - PROCESS | 27399 | 08:12:44 INFO - PROCESS | 27399 | [#11] stanford-crypto-ccm Cycles:10 Average:117.00 Median:115.00 stddev:8.30 (7.2%) stddev-sans-first:8.68 08:12:44 INFO - PROCESS | 27399 | Values: 121.0 116.0 112.0 110.0 110.0 114.0 112.0 112.0 131.0 132.0 08:12:44 INFO - PROCESS | 27399 | 08:12:44 INFO - PROCESS | 27399 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.50 Median:157.50 stddev:2.32 (1.5%) stddev-sans-first:2.46 08:12:44 INFO - PROCESS | 27399 | Values: 157.0 153.0 158.0 157.0 154.0 157.0 158.0 159.0 153.0 159.0 08:12:44 INFO - PROCESS | 27399 | 08:12:44 INFO - PROCESS | 27399 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.80 Median:66.00 stddev:2.15 (3.3%) stddev-sans-first:2.13 08:12:44 INFO - PROCESS | 27399 | Values: 68.0 66.0 66.0 66.0 68.0 65.0 64.0 68.0 66.0 61.0 08:12:44 INFO - PROCESS | 27399 | -------- Summary: end -------- 08:12:44 INFO - PROCESS | 27399 | 08:12:45 INFO - TEST-INFO | 27399: exit 0 08:12:45 INFO - TEST-OK | kraken | took 60092ms 08:12:45 INFO - SUITE-END | took 1171s 08:12:45 INFO - Completed test suite (00:19:31) 08:12:45 INFO - javascript benchmark 08:12:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3328.8002719836804, 3368.3263347330508, 3376.6960973512378, 3387.9153021174466, 3429.1598558353207, 5524.779008839641, 5527.309086364205, 5542.584306177037, 5577.470140336662, 5582.246396736435, 5538.252335934648, 5590.580706447013, 5591.30108736408, 5605.579581531381, 5645.745941432635, 4882.462929077798, 4970.801167953277, 5089.949100508985, 5131.512506311894, 5153.871153221181, 4961.553460188582, 5042.596592272627, 5045.949540504603, 5046.44489106198, 5047.873803154932, 4979.402471703401, 5037.1940489521685, 5039.949600504003, 5042.495750424947, 5061.19020956647, 5086.186210206368, 5124.92312615311, 5132.666376685504, 5142.665726727751, 5168.793248270046, 4912.680675756064, 4923.876903077416, 5003.699778013294, 5007.574356179729, 5012.348394708701, 5389.649672771257, 5431.348238211401, 5449.04641687703, 5463.726813659301, 5467.0, 5914.142449344821, 5950.196723442323, 5951.613145145551, 5951.970240148771, 5954.583179177459, 5944.167816505693, 5978.312494063195, 6060.30306514752, 6060.545727852834, 6088.208532890696, 5534.723263836792, 5579.832605021856, 5583.776648934037, 5584.720763961745, 5609.411011843738, 5908.409159084057, 6092.177556029879, 6092.3603021682975, 6093.786717464867, 6133.846653833601, 5803.390643982321, 5884.529237660977, 5888.5289176865745, 5902.498287645512, 5904.852378690567, 5926.940730592725, 5927.73325200367, 5933.643981361132, 5936.050231962951, 5937.614055086406, 5724.026915424388, 5870.442307980735, 5881.264841894763, 5882.411758824083, 5901.114832775118, 5922.970385148133, 5937.821865344046, 5959.195508606369, 5980.581359304807, 5982.551308651869, 4553.430821147356, 4565.771711414416, 4577.3362862384765, 4583.449986001701, 4609.861704148881, 3984.561698213194, 4045.231406032903, 4098.180363927167, 4113.321301985139, 4142.171565686875, 5730.169125476783, 5750.539956803445, 5758.913616295759, 5762.164486149569, 5764.164196191528, 6044.546659000593, 6055.666938318434, 6056.939430605726, 6058.061000544834, 6062.242219722535, 5585.162225666182, 5609.80365687199, 5653.123765816305, 5669.886602267931, 5744.597878148489, 5186.611004174702, 5190.844274671766, 5193.169092945111, 5193.350831146106, 5198.376194856642, 6273.309935907047, 6275.3724627536885, 6278.4035516625845, 6283.05754136874, 6284.088807123033, 5861.0, 5966.582339236385, 6028.819135426032, 6083.574149809471, 6089.5432842537875, 6238.344973777688, 6251.9687401562705, 6278.434940855345, 6323.798478289111, 6327.272363678236, 5952.077427998667, 5961.850953726018, 5964.314103877936, 5966.910496342472, 6008.519318454426, 5890.204822348928, 5962.046072628359, 6024.277086749618, 6065.3934606539, 6067.817965461043, 5890.293164820249, 5917.437843404869, 5923.0, 5925.348211696796, 5925.614835035709, 5739.770409183586, 5850.444207800252, 5878.059510478303, 5908.675022873783, 5913.763449462145, 5715.085586306171, 5781.653100813965, 5785.623934444247, 5806.44838740319, 5822.214001109796, 5862.355140934408, 5896.174535564938, 5901.114832775118, 5906.438888305604, 5917.171595976481, 5539.196816461671, 5657.915131272952, 5736.053551164178, 5747.683877386617, 5774.249347584787], "value": 5516.455885625084, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [628.2712054017338, 656.1437324291799, 680.9387155156035, 684.7192651013085, 687.9518433709642, 32693.50959735606, 33265.66734332656, 33271.33457330855, 33342.0, 39864.60135398645, 43992.0, 44496.3325550117, 44558.777206113926, 44587.77706111465, 44692.10615787682, 8638.524881131536, 8836.160564746338, 8884.555772211395, 8904.287656987457, 8905.376623636348, 8735.650573977066, 8831.60257788401, 8849.867251991225, 8851.77870553235, 8851.822963540726, 8850.468971861677, 9155.0, 9167.0, 9167.174954254117, 9170.954145229298, 9021.0, 9038.231750301233, 9076.727698169032, 9077.36458447909, 9099.454032758023, 8972.371933964625, 9088.363814532986, 9096.317776166748, 9101.7269481915, 9105.63577456901, 43983.78008109971, 44548.0, 44677.3298400521, 44709.32936005962, 44735.0, 3920.0983773731914, 3987.2424239394422, 4081.1837632473625, 4104.753714777123, 4708.4349878014855, 30182.245443864078, 30567.541486877715, 30973.69026309753, 31603.0, 31805.0, 4551.544845515455, 4572.314152877062, 4595.195840727893, 4615.284630882219, 4689.366935463703, 289669.0, 289708.0, 290043.0, 290787.54606227047, 292022.0, 39923.40114898279, 62888.37111628916, 64392.35607643957, 64402.677986609764, 64640.353596464374, 38185.42721859174, 38262.2347553053, 38549.0, 38551.61448385537, 38575.807120964215, 16223.594410139842, 16512.25694843735, 16513.752293715603, 16529.917350413412, 16534.6693066138, 13470.326483675777, 13493.797593036112, 13505.189688618715, 13506.257155856325, 13515.932420337835, 9214.539273036322, 9333.0, 9397.76505587352, 9402.858957115648, 9473.573689184002, 3591.94612080819, 3631.8547258109907, 3652.817359132033, 3661.56061272649, 3669.3945498992366, 1101.0365929811414, 1103.8454616353717, 1112.5216157052546, 1169.2808922512763, 1238.133306685324, 34483.31033379318, 34716.826415867756, 34873.65126348755, 35135.4729679055, 35531.82234088813, 1193.9701507462382, 1212.4719958885821, 1230.7661544306552, 1241.8509778826417, 1267.4106540458547, 17294.567635809206, 17464.47606571805, 17987.550311242325, 18174.727379089323, 18308.359207427675, 483107.0, 495951.0, 496193.0, 497071.0, 497209.0, 64402.677986609764, 65013.349866501674, 65130.674346627966, 65146.0, 65159.34840651628, 1510.4033906607049, 1535.055940596525, 1586.6112802363496, 1587.5475489485673, 1598.688255790133, 33485.49771753377, 34977.30045399027, 35475.82262088776, 35655.28689426249, 35925.820370899026, 57368.42631573631, 58207.0, 58448.0, 58485.415145848, 58516.0, 452579.0, 463556.0, 464219.0, 465311.0, 465450.0, 41888.162236754484, 43435.34846977235, 43552.34671479867, 46579.767101164274, 49365.75317123535, 49441.0, 49520.50479495303, 49752.0, 50020.74989625029, 54389.45610543844, 44683.55316446924, 45176.32235516536, 45660.0, 45769.04466160827, 46608.30087548622, 43119.35320970125, 43935.12129757451, 44117.11765764731, 44318.77840610776, 45258.0, 44915.55084449244, 45488.31767523423, 45778.54221457876, 46181.76909115433, 46318.30522542097, 36501.45247821338, 39018.80490597529, 39637.80181099076, 39764.602353976086, 39889.601103988585, 29507.0, 29697.40605187841, 29708.257293567833, 29771.404571908875, 29850.253743656584], "value": 20086.19226679012, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [429.7335651895825, 429.8624440179142, 435.5383293708669, 437.1104801728483, 441.6130812955973, 18562.35031773888, 18763.71854422183, 19331.0, 19497.317593884218, 19535.316263930767, 18509.074546272666, 20042.79957200431, 20985.0, 21029.47426314339, 21106.683399749018, 5506.972465137669, 5657.434256574341, 5739.339975902762, 5748.338941021794, 5751.971240143815, 5606.579506537006, 5747.0517364635, 5759.712014399284, 5762.4525670061485, 5959.642421454727, 5906.232189815318, 5914.733836977325, 5943.762249510036, 5948.613340132899, 5955.047192449209, 5701.116326969326, 5916.615419997708, 5919.792807251747, 5925.911111333334, 5979.431953964367, 5757.798477053283, 5790.7973220937065, 5805.3323867755325, 5840.561957853136, 5852.15143804146, 22458.887705561367, 23172.0, 23208.0, 23275.883620581957, 24367.512649747085, 2411.0837881605053, 2448.7183973843057, 2599.974000260011, 2676.879540420666, 2980.807676929224, 10521.368717876876, 10661.413622250773, 10685.358878467317, 10768.676939691823, 10874.130069594492, 2068.700038494425, 2150.6773983902385, 2152.300502336747, 2164.718586583734, 2198.7251593550805, 57825.71087144579, 73496.6325168376, 74078.25921740767, 76596.61701691456, 82275.17724822735, 10585.523651435704, 10734.355938643706, 10892.183086268562, 11076.335419874833, 11205.831912521318, 15132.319045642973, 15847.0, 16419.58951026234, 16447.342106315853, 16458.917705411397, 8200.630971606291, 8366.07973122956, 8419.115992820789, 8511.914880851236, 8711.433756805787, 8313.0, 8324.375671824637, 8332.916670833336, 8392.118827523022, 8424.747257582283, 4648.0, 4870.5388383484815, 4877.3903262092235, 4882.170031094723, 4905.460399356068, 2074.620541833867, 2089.4149638101358, 2107.7259956205594, 2163.718716566836, 2176.7823217678106, 1050.432766306186, 1106.0598491282506, 1125.0156113400774, 1146.266389510714, 1149.270213414471, 19956.0, 19996.0, 20094.69857952132, 20381.0, 20390.286339978327, 1066.3335415365398, 1076.3004047369272, 1081.6646839479786, 1097.2757979733497, 1171.4318555500574, 11332.6033588824, 11430.1998860079, 11519.963203311741, 11541.480633371519, 11613.3612651305, 554074.0, 561243.0, 574813.0, 575422.0, 584053.0, 93014.53492732493, 93298.0, 93394.53302733443, 93436.0, 93633.5318323404, 1087.4617064553097, 1090.9345439273668, 1111.6887271563976, 1114.9777004459866, 1115.2583531951161, 17361.739573906652, 17523.036233007308, 17756.644867102328, 17815.821841781417, 18364.357247496275, 26114.73885261123, 37223.62776372202, 39380.606193937696, 40150.27540512479, 40542.1891562173, 56767.432325677866, 56880.43119568751, 57254.0, 57582.424175757704, 57671.1349329752, 8670.393072484865, 8793.65396128507, 8861.73414797557, 8899.243564297107, 9120.087991200828, 9061.912570491582, 10218.795624087625, 12694.809577856524, 13919.582412527641, 14217.146971181763, 11479.25384849982, 11536.884631153916, 12477.875221247672, 12635.87364126347, 12649.810252846031, 10938.343699377745, 11140.387278699749, 11896.524139034342, 12364.938175309066, 12615.621531354074, 12488.25070495773, 12586.748265034832, 12736.61790146297, 12763.170393924365, 13015.414306356426, 8888.511131887808, 8954.731358059269, 8977.640894364413, 9018.86471702938, 9199.218066464426, 11512.654620361403, 12280.938595306967, 12354.876451235732, 12365.75268494643, 12376.319302438093], "value": 9555.382608336391, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1405.2973513243378, 1500.669852632421, 1576.8344323846, 1809.375765360951, 1951.3365455745043, 8234.75295741128, 8421.70524031659, 8427.494350338977, 8436.325093992482, 8445.873311900326, 8348.081711011799, 8436.15638436156, 8483.490990540571, 8507.829843403128, 8517.446365986207, 2130.9893450532727, 2424.406020524974, 2470.419451428913, 2492.9002839886384, 2497.5504409206337, 2456.533258680845, 2503.1864643990684, 2511.3972646564785, 2511.8744062796877, 2515.55977703902, 2417.721961974369, 2438.5001074779716, 2444.2667199840066, 2448.1186772761794, 2448.52253810507, 2121.3847984084596, 2437.244454219189, 2499.200255918107, 2503.486785209037, 2507.4734305795805, 2225.2100504320897, 2226.4545186429427, 2227.042371780134, 2288.302067869299, 2370.8340416170877, 8241.381896357798, 8279.296259817922, 8288.378371622153, 8295.0, 8299.419040667155, 5354.946450535484, 5395.946040539584, 5438.564914806845, 5457.536109430703, 5535.114381698909, 3713.3687273163628, 3770.9825243494874, 3830.9042273943096, 3837.347650899326, 3862.748921320105, 1246.7818131826984, 1254.1597129922973, 1256.9685757856034, 1287.2405280884323, 1317.426919290112, 12275.140740148105, 12291.446884890202, 12313.199642023239, 12319.322437265946, 12331.753364932742, 4828.537445902615, 4936.925946110811, 4973.950260497349, 4975.5819591416275, 5002.849914502571, 10343.94828025855, 10380.221483388625, 10435.321704089361, 10446.63436779709, 10459.424731639832, 4653.488116307203, 5527.834164975057, 5582.665040097607, 5591.888162236733, 5594.272744543184, 4957.677750946177, 4967.577755890789, 5007.0, 5009.7244651544515, 5040.49595040493, 4208.705390622688, 4227.450431443954, 4246.787660616957, 4378.934315985262, 4426.181156485996, 1325.7414804113105, 1374.0656353679394, 1382.9075030725614, 1399.4961813747043, 1414.1232435889815, 978.3885071830106, 1094.6934858239547, 1104.0780947908586, 1106.9335839849634, 1113.2708076210095, 5982.581219314693, 6048.818535443944, 6087.482563982023, 6098.908516372258, 6168.259808822881, 503.19237623614305, 503.91603387269413, 506.3619839002883, 513.3224144129713, 517.5212928041547, 4060.4315395844606, 4061.7156799024374, 4062.959370406258, 4113.197926404322, 4134.276501612266, 10611.25721199524, 10742.946285268523, 10773.946130269298, 10911.236213464981, 10914.945425272823, 10587.258891877495, 10747.83878241827, 10753.032227099442, 10794.730131746612, 10808.513616887101, 8064.354851611857, 8372.413931024892, 8411.495310281403, 8432.0, 8441.66233350659, 6003.519718422603, 6040.395960403925, 6058.182145410313, 6063.605865618721, 6233.314335423191, 9528.904710952802, 9536.713898583053, 9656.034396560288, 9757.756056098655, 9768.07203315684, 9592.184664303333, 9635.855462167932, 9789.314747967574, 9844.310898237054, 10058.0, 6892.896606550806, 7393.704251829867, 7641.312281894656, 7858.44990850635, 7934.642941067781, 8408.663653453794, 8500.36247281444, 8516.40385173032, 8548.786280343042, 8552.828943421222, 7536.284053014955, 7792.376609871083, 7797.337226335825, 7879.64541595641, 7981.361491080584, 7575.128860181149, 7701.576413297323, 7707.036620422447, 7817.452778305464, 7821.6089195541135, 7208.387287080657, 7279.59962202084, 7279.636018198963, 7285.526440781332, 7297.124345078624, 5364.919526207188, 5368.785248590013, 5410.296661433988, 5430.42980487059, 5488.807891723771, 5339.599530035341, 5364.846557990051, 5486.204500347507, 5533.667979921218, 5647.3505546861], "value": 4676.351406785154, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.5080189338712, 358.7972795370615, 364.6280793590538, 375.8665673685843, 381.862529489384, 6146.8463288417815, 6152.692365381736, 6158.784442544512, 6194.814155575329, 6228.781992630259, 6129.387061293868, 6143.600665956721, 6147.661878596676, 6151.538634602401, 6170.074488826678, 4473.9552604473865, 4604.608608268301, 4686.765661716918, 4688.226442636961, 4699.201135806904, 4709.340692303081, 4712.458067322251, 4739.218029025206, 4752.572268495835, 4763.880902977418, 4444.111177764444, 4708.340832283483, 4714.4578373486975, 4717.858464246078, 4718.858434246961, 4585.931211031837, 4685.2269375553, 4707.199776038047, 4709.246520556729, 4710.646701497367, 4189.560096189917, 4193.245215861144, 4193.308104162809, 4205.642520385771, 4207.0, 5926.111083337534, 5928.733207005652, 5936.317323507808, 5940.0, 5941.762329506814, 5533.557315414798, 5536.280283563111, 5540.335159780852, 5542.279503664538, 5546.417626149237, 6331.176946996907, 6452.64510451925, 6457.418832305115, 6457.677116144221, 6464.288928217892, 4612.492625811158, 4633.2818413146015, 4642.837500687494, 4645.117427688729, 4650.581447669726, 6690.966545167292, 6716.865662686719, 6734.46124310054, 6736.46108311334, 6739.764108256237, 4739.928901066487, 4746.311784791186, 4754.809807607657, 4757.881052973703, 4758.381410416624, 4802.975985120122, 4804.807807687654, 4807.278908163804, 4810.735409552438, 4826.493218212107, 5466.508014278734, 5472.835814925558, 5479.726013699299, 5479.917801232985, 5483.643563168382, 6290.182276304051, 6481.157449531531, 6508.934910650928, 6515.902261466082, 6516.120323756327, 1619.1256721370564, 1632.0697202594645, 1638.852503274711, 1644.7697322374877, 1645.983540164607, 1010.9039641234218, 1048.9562884929392, 1078.5200585739271, 1088.6570730219955, 1096.8519249901321, 6247.875042499125, 6264.780732674334, 6328.11406403104, 6335.271443784024, 6344.968275158594, 6663.233728121328, 6666.933330666631, 6677.098591690156, 6677.599344039373, 6680.565763225375, 6322.33615470369, 6325.304216536178, 6337.809865704036, 6341.985282354801, 6345.175127233522, 3545.663161999606, 3581.426971684518, 3585.4084076127147, 3586.7130629549574, 3589.4974703541525, 6798.082258895085, 6903.585784852925, 6936.653167341613, 6945.687444065029, 6946.756863509753, 6724.4284235840505, 6746.561473504206, 6746.898796518056, 6759.391654751096, 6761.830954226085, 6893.034975103489, 6895.965520172467, 6908.861822763517, 6922.342377474132, 6945.236024037352, 6646.036324732983, 6650.501212409185, 6657.900131497934, 6662.06731057662, 6666.066750654815, 6409.0, 6544.28012918569, 6595.967020164869, 6618.371254730793, 6634.635095069818, 6894.379505844498, 6927.58434493932, 6928.411085057625, 6933.0, 6939.097917270722, 4593.724376537285, 4595.770211489479, 4601.44782626087, 4602.148602508547, 4605.217113090715, 6605.0, 6608.900866487103, 6611.900821487586, 6619.966900165468, 6628.966855165693, 6328.0, 6451.935480645134, 6454.128692626436, 6527.412532872065, 6534.117894084237, 6400.743970241138, 6420.935790642221, 6448.484121270381, 6472.902906456313, 6483.124778154889, 6272.717727702356, 6287.528435367274, 6292.905606415999, 6297.307296197506, 6304.117423560613, 6446.904026315444, 6448.645324507197, 6462.127612772216, 6471.255805582418, 6523.282438931808, 6086.908696369469, 6095.146679464967, 6149.954507733606, 6251.156093927261, 6300.2754683212015], "value": 4912.776839543322, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [765.3991616580981, 834.2283387866227, 873.253368370044, 876.2902049340037, 910.2672348759248, 15399.461018864342, 15560.922195389006, 15562.455314063996, 15582.220888955564, 15656.060636361812, 13332.933335333333, 13836.861631383683, 13880.583582492542, 13911.095778774372, 13938.233397163178, 770.1836053783007, 924.560833604036, 933.0669330669348, 937.6718148647952, 951.490952340498, 929.066288380177, 933.2300851797261, 933.3653115881198, 933.4725879877848, 936.2229349639782, 981.1218959031662, 982.3271059324386, 984.1142971325828, 984.4437892590663, 986.7829077602916, 816.3754727633366, 972.9318947673595, 980.01998001998, 985.5121714751173, 988.6094992478003, 714.0610097721479, 717.5909731453074, 718.6011763471271, 719.4028955966587, 723.4501778648213, 15925.124118173495, 15956.760648590165, 15965.680686386324, 15978.44075457365, 15988.440404585785, 14787.630309242248, 15296.311665974947, 15500.302486388027, 15524.223788810514, 15529.145896975662, 12016.339101349422, 12179.147459677826, 12235.877641223651, 12237.449314780857, 12237.449314780857, 4697.859064228079, 4711.387519622427, 4725.385699858996, 4760.071786001731, 4838.709677419366, 54870.451295486935, 55575.72212138913, 60737.0, 61123.69438152781, 61269.0, 11892.762144757056, 12097.697557560956, 12166.756664866652, 12305.077119215915, 12412.56556020553, 20010.69983950242, 20155.193792248145, 20287.391378258675, 20318.390448286576, 20339.796602034086, 8859.0, 8899.33255005877, 8903.777405564913, 9234.122758337948, 9256.0, 5061.544460998528, 5164.096283150434, 5165.2149592455935, 5245.842624721265, 5321.86695332612, 3597.4244120940525, 3728.832202550892, 3769.8313522808016, 3818.427235914635, 3820.2550502651716, 685.3831551603597, 702.8242939265184, 705.1432509500981, 707.345705222667, 711.6477343714894, 651.840299126717, 679.751890559942, 730.4010711216857, 759.9430042746816, 767.9539227646359, 8473.449225800427, 8584.699535516227, 8698.33129590416, 8755.212030917248, 8916.0, 716.3695947566108, 725.2058995400029, 738.9076365454318, 741.6069483173926, 770.1374460604159, 4091.3044782387065, 4241.554636763157, 4357.629601483909, 4380.551030879029, 4475.060237350193, 58501.70749146227, 62686.0597091044, 63560.0, 63715.0, 67045.66477167583, 57831.71084144552, 59362.70318648466, 61184.0, 61752.07371889425, 61772.69113654403, 53472.0, 53983.46016539863, 54575.0, 54674.72662636741, 55738.72130639402, 9609.183219426428, 9627.326087173831, 9656.275779316438, 9804.803903922024, 9829.262805289774, 39338.409923850595, 39501.604983949794, 40100.3984940232, 40117.0, 40151.59848401479, 47458.76270618625, 47465.76267118642, 51658.0, 52149.0, 54169.0, 12833.486660533474, 12887.548935787578, 12942.741145177231, 13037.15258508194, 13125.0, 13921.234332111831, 14621.561353159423, 14818.851811481747, 14872.851271487147, 15221.315040822969, 13190.73618527605, 13226.0, 13305.667358315732, 13580.660483487993, 14203.934704896967, 13665.385057672229, 13725.862741372857, 13875.375608097862, 13948.930255349063, 14008.579742607739, 13279.402426891007, 13493.122947008413, 13571.117877337942, 13585.728285434037, 13702.10936289138, 10729.0, 10831.458427078456, 10857.40284284372, 10948.726281843017, 11067.72330691739, 10772.515236814519, 10813.760261911195, 10882.78234435291, 10924.235303528676, 10938.507767150657], "value": 7300.779287042139, "unit": "score"}], "name": "dromaeo_css", "value": 7497.354363447684, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 111.0, 110.0, 109.0, 109.0, 110.0, 103.0, 111.0, 107.0, 108.0], "value": 108.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 128.0, 152.0, 169.0, 134.0, 154.0, 157.0, 128.0, 178.0, 126.0], "value": 148.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 161.0, 162.0, 161.0, 160.0, 162.0, 161.0, 162.0, 160.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 75.0, 178.0, 75.0, 77.0, 75.0, 75.0, 166.0, 75.0], "value": 94.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 161.0, 92.0, 93.0, 93.0, 151.0, 92.0, 94.0, 150.0], "value": 111.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 117.0, 116.0, 116.0, 116.0, 116.0, 117.0, 117.0, 116.0], "value": 116.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 146.0, 146.0, 145.0, 145.0, 145.0, 146.0, 146.0, 146.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 94.0, 95.0, 94.0, 95.0, 95.0, 94.0, 95.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 54.0, 53.0, 54.0, 53.0, 55.0, 56.0, 73.0, 52.0, 52.0], "value": 55.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 58.0, 58.0, 57.0, 58.0, 58.0, 58.0, 57.0, 58.0, 57.0], "value": 58.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 72.0, 72.0, 73.0, 72.0, 73.0, 71.0, 73.0, 72.0, 73.0], "value": 72.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 116.0, 112.0, 110.0, 110.0, 114.0, 112.0, 112.0, 131.0, 132.0], "value": 117.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 153.0, 158.0, 157.0, 154.0, 157.0, 158.0, 159.0, 153.0, 159.0], "value": 156.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 66.0, 66.0, 66.0, 68.0, 65.0, 64.0, 68.0, 66.0, 61.0], "value": 65.8, "unit": "score"}], "name": "kraken", "value": 1506.0, "alertThreshold": 2.0}]} 08:12:45 INFO - Return code: 0 08:12:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 08:12:45 ERROR - # TBPL SUCCESS # 08:12:45 INFO - Running post-action listener: _resource_record_post_action 08:12:45 INFO - Running post-run listener: _resource_record_post_run 08:12:46 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 262144; Write bytes: 511078400; Read time: 28; Write time: 728932 08:12:46 INFO - install - Wall time: 16s; CPU: 17.0%; Read bytes: 0; Write bytes: 261746688; Read time: 0; Write time: 533756 08:12:46 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 262144; Write bytes: 249331712; Read time: 28; Write time: 195176 08:12:46 INFO - Running post-run listener: _upload_blobber_files 08:12:46 INFO - Blob upload gear active. 08:12:46 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:12:46 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 08:12:46 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:12:46 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:12:46 INFO - (blobuploader) - INFO - Open directory for files ... 08:12:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:12:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:12:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:12:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:12:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:12:47 INFO - (blobuploader) - INFO - Done attempting. 08:12:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:12:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:12:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:12:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:12:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:12:48 INFO - (blobuploader) - INFO - Done attempting. 08:12:48 INFO - (blobuploader) - INFO - Iteration through files over. 08:12:48 INFO - Return code: 0 08:12:48 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:12:48 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:12:48 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d6c8edd9d5b0e5c2cbabcbb47e2fbde8b4be728b15a717d462cefafdd5307e6d3ead29af4add795d18f4bc4ad09005eab82bd71ce7e1feea0a402edfb6873b05", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5543f726cd967bfb66a251e2be9a9ffd47a35d2e63878b2e37eed093713fe27ace2c9e35e9efad0a6ef101aafdb93539fcd90d56f4259d6230461a30febcf68e"} 08:12:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:12:48 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:12:48 INFO - Contents: 08:12:48 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d6c8edd9d5b0e5c2cbabcbb47e2fbde8b4be728b15a717d462cefafdd5307e6d3ead29af4add795d18f4bc4ad09005eab82bd71ce7e1feea0a402edfb6873b05", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5543f726cd967bfb66a251e2be9a9ffd47a35d2e63878b2e37eed093713fe27ace2c9e35e9efad0a6ef101aafdb93539fcd90d56f4259d6230461a30febcf68e"} 08:12:48 INFO - Running post-run listener: copy_logs_to_upload_dir 08:12:48 INFO - Copying logs to upload dir... 08:12:48 INFO - mkdir: /builds/slave/test/build/upload/logs 08:12:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1229.489883 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-06-01 08:12:48.544335) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-01 08:12:48.548248) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1464792736.64267-48109578 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d6c8edd9d5b0e5c2cbabcbb47e2fbde8b4be728b15a717d462cefafdd5307e6d3ead29af4add795d18f4bc4ad09005eab82bd71ce7e1feea0a402edfb6873b05", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5543f726cd967bfb66a251e2be9a9ffd47a35d2e63878b2e37eed093713fe27ace2c9e35e9efad0a6ef101aafdb93539fcd90d56f4259d6230461a30febcf68e"} build_url:https://queue.taskcluster.net/v1/task/I4a8ImCbQICdwTo_0ZpYoA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011278 build_url: 'https://queue.taskcluster.net/v1/task/I4a8ImCbQICdwTo_0ZpYoA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d6c8edd9d5b0e5c2cbabcbb47e2fbde8b4be728b15a717d462cefafdd5307e6d3ead29af4add795d18f4bc4ad09005eab82bd71ce7e1feea0a402edfb6873b05", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5543f726cd967bfb66a251e2be9a9ffd47a35d2e63878b2e37eed093713fe27ace2c9e35e9efad0a6ef101aafdb93539fcd90d56f4259d6230461a30febcf68e"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-01 08:12:48.573994) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 08:12:48.574361) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1464792736.64267-48109578 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004426 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 08:12:48.658859) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-01 08:12:48.659233) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-01 08:12:48.659562) ========= ========= Total master_lag: 0.17 =========