builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-001 starttime: 1467756390.14 results: success (0) buildid: 20160705121723 builduid: 15663881f04847ca8f7fddd4a660a773 revision: 52fb1d141cc9c18d7b7971d778b8976e43f360dc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-05 15:06:30.141172) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-05 15:06:30.141719) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-05 15:06:30.142044) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-05 15:06:30.157029) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 15:06:30.157346) ========= 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=8887e36bb8e381bfd44124ac000001a8-1467756389.510580-39514871 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-05 15:06:30-- 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% 112M=0s 2016-07-05 15:06:30 (112 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.101798 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 15:06:30.274943) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 15:06:30.275362) ========= 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=8887e36bb8e381bfd44124ac000001a8-1467756389.510580-39514871 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019561 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 15:06:30.329082) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-05 15:06:30.329939) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 52fb1d141cc9c18d7b7971d778b8976e43f360dc --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-beta --rev 52fb1d141cc9c18d7b7971d778b8976e43f360dc --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=8887e36bb8e381bfd44124ac000001a8-1467756389.510580-39514871 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-05 15:06:30,747 truncating revision to first 12 chars 2016-07-05 15:06:30,747 Setting DEBUG logging. 2016-07-05 15:06:30,747 attempt 1/10 2016-07-05 15:06:30,747 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/52fb1d141cc9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-05 15:06:32,136 unpacking tar archive at: mozilla-beta-52fb1d141cc9/testing/mozharness/ program finished with exit code 0 elapsedTime=1.706085 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-05 15:06:32.051632) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-05 15:06:32.052039) ========= script_repo_revision: 52fb1d141cc9c18d7b7971d778b8976e43f360dc ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-05 15:06:32.052550) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-05 15:06:32.052868) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-05 15:06:32.063168) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 23 secs) (at 2016-07-05 15:06:32.063786) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] 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=8887e36bb8e381bfd44124ac000001a8-1467756389.510580-39514871 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:06:32 INFO - MultiFileLogger online at 20160705 15:06:32 in /builds/slave/test 15:06:32 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 15:06:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:06:32 INFO - {'append_to_log': False, 15:06:32 INFO - 'base_work_dir': '/builds/slave/test', 15:06:32 INFO - 'blob_upload_branch': 'Mozilla-Beta', 15:06:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:06:32 INFO - 'branch': 'Mozilla-Beta', 15:06:32 INFO - 'buildbot_json_path': 'buildprops.json', 15:06:32 INFO - 'config_files': ('talos/linux_config.py',), 15:06:32 INFO - 'default_actions': ('clobber', 15:06:32 INFO - 'read-buildbot-config', 15:06:32 INFO - 'download-and-extract', 15:06:32 INFO - 'populate-webroot', 15:06:32 INFO - 'create-virtualenv', 15:06:32 INFO - 'install', 15:06:32 INFO - 'run-tests'), 15:06:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:06:32 INFO - 'download_minidump_stackwalk': True, 15:06:32 INFO - 'download_symbols': 'ondemand', 15:06:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:06:32 INFO - 'tooltool.py': '/tools/tooltool.py', 15:06:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:06:32 INFO - '/tools/misc-python/virtualenv.py')}, 15:06:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:06:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:06:32 INFO - 'installer_path': 'installer.exe', 15:06:32 INFO - 'log_level': 'info', 15:06:32 INFO - 'log_name': 'talos', 15:06:32 INFO - 'log_to_console': True, 15:06:32 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:06:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:06:32 INFO - 'opt_config_files': (), 15:06:32 INFO - 'pip_index': False, 15:06:32 INFO - 'sps_profile': False, 15:06:32 INFO - 'sps_profile_interval': 0, 15:06:32 INFO - 'suite': 'dromaeojs', 15:06:32 INFO - 'system_bits': '32', 15:06:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:06:32 INFO - 'title': 'talos-linux64-ix-001', 15:06:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:06:32 INFO - 'use_talos_json': True, 15:06:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:06:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:06:32 INFO - 'work_dir': 'build'} 15:06:32 INFO - ##### 15:06:32 INFO - ##### Running clobber step. 15:06:32 INFO - ##### 15:06:32 INFO - Running pre-action listener: _resource_record_pre_action 15:06:32 INFO - Running main action method: clobber 15:06:32 INFO - rmtree: /builds/slave/test/build 15:06:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:06:33 INFO - Running post-action listener: _resource_record_post_action 15:06:33 INFO - ##### 15:06:33 INFO - ##### Running read-buildbot-config step. 15:06:33 INFO - ##### 15:06:33 INFO - Running pre-action listener: _resource_record_pre_action 15:06:33 INFO - Running main action method: read_buildbot_config 15:06:33 INFO - Using buildbot properties: 15:06:33 INFO - { 15:06:33 INFO - "project": "", 15:06:33 INFO - "product": "firefox", 15:06:33 INFO - "script_repo_revision": "production", 15:06:33 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 15:06:33 INFO - "repository": "", 15:06:33 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 15:06:33 INFO - "buildid": "20160705121723", 15:06:33 INFO - "pgo_build": "True", 15:06:33 INFO - "basedir": "/builds/slave/test", 15:06:33 INFO - "buildnumber": 156, 15:06:33 INFO - "slavename": "talos-linux64-ix-001", 15:06:33 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 15:06:33 INFO - "platform": "ubuntu64_hw", 15:06:33 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 15:06:33 INFO - "branch": "mozilla-beta", 15:06:33 INFO - "repo_path": "releases/mozilla-beta", 15:06:33 INFO - "revision": "52fb1d141cc9c18d7b7971d778b8976e43f360dc", 15:06:33 INFO - "stage_platform": "linux64-pgo", 15:06:33 INFO - "builduid": "15663881f04847ca8f7fddd4a660a773", 15:06:33 INFO - "slavebuilddir": "test" 15:06:33 INFO - } 15:06:33 INFO - Found installer url https://queue.taskcluster.net/v1/task/bsjBRbYfRR-flt3iMjJ8Fw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2. 15:06:33 INFO - Running post-action listener: _resource_record_post_action 15:06:33 INFO - ##### 15:06:33 INFO - ##### Running download-and-extract step. 15:06:33 INFO - ##### 15:06:33 INFO - Running pre-action listener: _resource_record_pre_action 15:06:33 INFO - Running main action method: download_and_extract 15:06:33 INFO - mkdir: /builds/slave/test/build/tests 15:06:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:06:33 INFO - https://queue.taskcluster.net/v1/task/bsjBRbYfRR-flt3iMjJ8Fw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 15:06:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bsjBRbYfRR-flt3iMjJ8Fw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 15:06:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bsjBRbYfRR-flt3iMjJ8Fw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 15:06:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bsjBRbYfRR-flt3iMjJ8Fw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 15:06:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bsjBRbYfRR-flt3iMjJ8Fw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 15:06:33 INFO - Downloaded 1327 bytes. 15:06:33 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 15:06:33 INFO - Using the following test package requirements: 15:06:33 INFO - {u'common': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 15:06:33 INFO - u'cppunittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 15:06:33 INFO - u'firefox-48.0.en-US.linux-x86_64.cppunittest.tests.zip'], 15:06:33 INFO - u'gtest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 15:06:33 INFO - u'firefox-48.0.en-US.linux-x86_64.gtest.tests.zip'], 15:06:33 INFO - u'jittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 15:06:33 INFO - u'jsshell-linux-x86_64.zip'], 15:06:33 INFO - u'mochitest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 15:06:33 INFO - u'firefox-48.0.en-US.linux-x86_64.mochitest.tests.zip'], 15:06:33 INFO - u'mozbase': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 15:06:33 INFO - u'reftest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 15:06:33 INFO - u'firefox-48.0.en-US.linux-x86_64.reftest.tests.zip'], 15:06:33 INFO - u'talos': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 15:06:33 INFO - u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'], 15:06:33 INFO - u'web-platform': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 15:06:33 INFO - u'firefox-48.0.en-US.linux-x86_64.web-platform.tests.zip'], 15:06:33 INFO - u'xpcshell': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 15:06:33 INFO - u'firefox-48.0.en-US.linux-x86_64.xpcshell.tests.zip']} 15:06:33 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:06:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:06:33 INFO - https://queue.taskcluster.net/v1/task/bsjBRbYfRR-flt3iMjJ8Fw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:06:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bsjBRbYfRR-flt3iMjJ8Fw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 15:06:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bsjBRbYfRR-flt3iMjJ8Fw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 15:06:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bsjBRbYfRR-flt3iMjJ8Fw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 15:06:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bsjBRbYfRR-flt3iMjJ8Fw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:06:34 INFO - Downloaded 24236019 bytes. 15:06:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:06:34 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 15:06:36 INFO - Return code: 0 15:06:36 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 15:06:36 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')]} 15:06:36 INFO - https://queue.taskcluster.net/v1/task/bsjBRbYfRR-flt3iMjJ8Fw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:06:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bsjBRbYfRR-flt3iMjJ8Fw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 15:06:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bsjBRbYfRR-flt3iMjJ8Fw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 15:06:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bsjBRbYfRR-flt3iMjJ8Fw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 15:06:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bsjBRbYfRR-flt3iMjJ8Fw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:06:37 INFO - Downloaded 24236019 bytes. 15:06:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:06:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 15:06:38 INFO - Return code: 0 15:06:38 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')]} 15:06:38 INFO - https://queue.taskcluster.net/v1/task/bsjBRbYfRR-flt3iMjJ8Fw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:06:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bsjBRbYfRR-flt3iMjJ8Fw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 15:06:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bsjBRbYfRR-flt3iMjJ8Fw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 15:06:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bsjBRbYfRR-flt3iMjJ8Fw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 15:06:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bsjBRbYfRR-flt3iMjJ8Fw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:06:39 INFO - Downloaded 10840145 bytes. 15:06:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:06:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 15:06:39 INFO - Return code: 0 15:06:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:06:39 INFO - https://queue.taskcluster.net/v1/task/bsjBRbYfRR-flt3iMjJ8Fw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:06:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bsjBRbYfRR-flt3iMjJ8Fw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 15:06:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bsjBRbYfRR-flt3iMjJ8Fw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 15:06:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bsjBRbYfRR-flt3iMjJ8Fw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 15:06:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bsjBRbYfRR-flt3iMjJ8Fw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 15:06:41 INFO - Downloaded 56027258 bytes. 15:06:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bsjBRbYfRR-flt3iMjJ8Fw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 15:06:41 INFO - mkdir: /builds/slave/test/properties 15:06:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:06:41 INFO - Writing to file /builds/slave/test/properties/build_url 15:06:41 INFO - Contents: 15:06:41 INFO - build_url:https://queue.taskcluster.net/v1/task/bsjBRbYfRR-flt3iMjJ8Fw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 15:06:41 INFO - Running post-action listener: _resource_record_post_action 15:06:41 INFO - Running post-action listener: set_extra_try_arguments 15:06:41 INFO - ##### 15:06:41 INFO - ##### Running populate-webroot step. 15:06:41 INFO - ##### 15:06:41 INFO - Running pre-action listener: _resource_record_pre_action 15:06:41 INFO - Running main action method: populate_webroot 15:06:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:06:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:06:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:06:41 INFO - '--tppagecycles', 15:06:41 INFO - '7'], 15:06:41 INFO - 'tests': ['tsvgm']}}, 15:06:41 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:06:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:06:41 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:06:41 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:06:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:06:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:06:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:06:41 INFO - 'talos_options': ['--disable-e10s'], 15:06:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:06:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:06:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:06:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:06:41 INFO - 'talos_options': ['--disable-e10s'], 15:06:41 INFO - 'tests': ['damp', 'tps']}, 15:06:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:06:41 INFO - 'tests': ['damp', 'tps']}, 15:06:41 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:06:41 INFO - 'tests': ['dromaeo_dom']}, 15:06:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:06:41 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:06:41 INFO - 'tests': ['a11yr', 15:06:41 INFO - 'ts_paint', 15:06:41 INFO - 'tpaint', 15:06:41 INFO - 'sessionrestore', 15:06:41 INFO - 'sessionrestore_no_auto_restore', 15:06:41 INFO - 'tabpaint']}, 15:06:41 INFO - 'other-e10s': {'tests': ['a11yr', 15:06:41 INFO - 'ts_paint', 15:06:41 INFO - 'tpaint', 15:06:41 INFO - 'sessionrestore', 15:06:41 INFO - 'sessionrestore_no_auto_restore', 15:06:41 INFO - 'tabpaint']}, 15:06:41 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:06:41 INFO - 'ts_paint', 15:06:41 INFO - 'tpaint', 15:06:41 INFO - 'sessionrestore', 15:06:41 INFO - 'sessionrestore_no_auto_restore', 15:06:41 INFO - 'tabpaint']}, 15:06:41 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:06:41 INFO - 'ts_paint', 15:06:41 INFO - 'tpaint', 15:06:41 INFO - 'sessionrestore', 15:06:41 INFO - 'sessionrestore_no_auto_restore', 15:06:41 INFO - 'tabpaint']}, 15:06:41 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:06:41 INFO - 'tests': ['a11yr', 15:06:41 INFO - 'ts_paint', 15:06:41 INFO - 'tpaint', 15:06:41 INFO - 'sessionrestore', 15:06:41 INFO - 'sessionrestore_no_auto_restore', 15:06:41 INFO - 'tabpaint']}, 15:06:41 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:06:41 INFO - 'tests': ['a11yr', 15:06:41 INFO - 'ts_paint', 15:06:41 INFO - 'tpaint', 15:06:41 INFO - 'sessionrestore', 15:06:41 INFO - 'sessionrestore_no_auto_restore', 15:06:41 INFO - 'tabpaint']}, 15:06:41 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:06:41 INFO - 'tests': ['tsvgx', 15:06:41 INFO - 'tsvgr_opacity', 15:06:41 INFO - 'tart', 15:06:41 INFO - 'tscrollx', 15:06:41 INFO - 'cart']}, 15:06:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:06:41 INFO - 'tsvgr_opacity', 15:06:41 INFO - 'tart', 15:06:41 INFO - 'tscrollx', 15:06:41 INFO - 'cart']}, 15:06:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:06:41 INFO - 'talos_options': ['--disable-e10s'], 15:06:41 INFO - 'tests': ['tp5o']}, 15:06:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:06:41 INFO - 'tests': ['tp5o']}, 15:06:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:06:41 INFO - 'talos_options': ['--disable-e10s', 15:06:41 INFO - '--xperf_path', 15:06:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:06:41 INFO - 'tests': ['tp5n']}, 15:06:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:06:41 INFO - 'talos_options': ['--xperf_path', 15:06:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:06:41 INFO - 'tests': ['tp5n']}}, 15:06:41 INFO - 'talos.zip': {'path': '', 15:06:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:06:41 INFO - Running post-action listener: _resource_record_post_action 15:06:41 INFO - ##### 15:06:41 INFO - ##### Running create-virtualenv step. 15:06:41 INFO - ##### 15:06:41 INFO - Running pre-action listener: _resource_record_pre_action 15:06:41 INFO - Running main action method: create_virtualenv 15:06:41 INFO - Creating virtualenv /builds/slave/test/build/venv 15:06:41 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 15:06:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:06:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:06:42 INFO - Using real prefix '/usr' 15:06:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:06:42 INFO - Installing distribute.............................................................................................................................................................................................done. 15:06:44 INFO - Installing pip.................done. 15:06:44 INFO - Return code: 0 15:06:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:06:44 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')]} 15:06:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:06:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:06:44 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')]} 15:06:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:06:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:06:44 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 0x7f89f8fe7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd967d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe25640>, '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 0xe26540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe269d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1467756389.510580-39514871', '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 15:06:44 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 15:06:44 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 15:06:44 INFO - Using env: {'DISPLAY': ':0', 15:06:44 INFO - 'HOME': '/home/cltbld', 15:06:44 INFO - 'LANG': 'en_US.UTF-8', 15:06:44 INFO - 'LANGUAGE': 'en_US:en', 15:06:44 INFO - 'LOGNAME': 'cltbld', 15:06:44 INFO - 'MAIL': '/var/mail/cltbld', 15:06:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:06:44 INFO - 'MOZ_NO_REMOTE': '1', 15:06:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:06:44 INFO - 'NO_EM_RESTART': '1', 15:06:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:06:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:06:44 INFO - 'PWD': '/builds/slave/test', 15:06:44 INFO - 'SHELL': '/bin/bash', 15:06:44 INFO - 'SHLVL': '1', 15:06:44 INFO - 'TERM': 'linux', 15:06:44 INFO - 'TMOUT': '86400', 15:06:44 INFO - 'USER': 'cltbld', 15:06:44 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1467756389.510580-39514871', 15:06:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:06:44 INFO - '_': '/tools/buildbot/bin/python'} 15:06:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:06:44 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 15:06:44 INFO - Cleaning up... 15:06:44 INFO - Return code: 0 15:06:44 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 15:06:44 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')]} 15:06:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:06:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:06:44 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')]} 15:06:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:06:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:06:44 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 0x7f89f8fe7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd967d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe25640>, '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 0xe26540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe269d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1467756389.510580-39514871', '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 15:06:44 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 15:06:44 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 15:06:44 INFO - Using env: {'DISPLAY': ':0', 15:06:44 INFO - 'HOME': '/home/cltbld', 15:06:44 INFO - 'LANG': 'en_US.UTF-8', 15:06:44 INFO - 'LANGUAGE': 'en_US:en', 15:06:44 INFO - 'LOGNAME': 'cltbld', 15:06:44 INFO - 'MAIL': '/var/mail/cltbld', 15:06:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:06:44 INFO - 'MOZ_NO_REMOTE': '1', 15:06:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:06:44 INFO - 'NO_EM_RESTART': '1', 15:06:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:06:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:06:44 INFO - 'PWD': '/builds/slave/test', 15:06:44 INFO - 'SHELL': '/bin/bash', 15:06:44 INFO - 'SHLVL': '1', 15:06:44 INFO - 'TERM': 'linux', 15:06:44 INFO - 'TMOUT': '86400', 15:06:44 INFO - 'USER': 'cltbld', 15:06:44 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1467756389.510580-39514871', 15:06:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:06:44 INFO - '_': '/tools/buildbot/bin/python'} 15:06:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:06:45 INFO - Downloading/unpacking psutil>=0.7.1 15:06:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:06:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:06:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:06:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:06:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:06:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:06:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:06:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:06:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:06:47 INFO - Installing collected packages: psutil 15:06:47 INFO - Running setup.py install for psutil 15:06:47 INFO - building 'psutil._psutil_linux' extension 15:06:47 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 15:06:47 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 15:06:47 INFO - building 'psutil._psutil_posix' extension 15:06:47 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 15:06:47 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 15:06:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:06:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:06:47 INFO - Successfully installed psutil 15:06:47 INFO - Cleaning up... 15:06:47 INFO - Return code: 0 15:06:47 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 15:06:47 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')]} 15:06:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:06:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:06:47 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')]} 15:06:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:06:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:06:47 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 0x7f89f8fe7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd967d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe25640>, '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 0xe26540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe269d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1467756389.510580-39514871', '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 15:06:47 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 15:06:47 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 15:06:47 INFO - Using env: {'DISPLAY': ':0', 15:06:47 INFO - 'HOME': '/home/cltbld', 15:06:47 INFO - 'LANG': 'en_US.UTF-8', 15:06:47 INFO - 'LANGUAGE': 'en_US:en', 15:06:47 INFO - 'LOGNAME': 'cltbld', 15:06:47 INFO - 'MAIL': '/var/mail/cltbld', 15:06:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:06:47 INFO - 'MOZ_NO_REMOTE': '1', 15:06:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:06:47 INFO - 'NO_EM_RESTART': '1', 15:06:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:06:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:06:47 INFO - 'PWD': '/builds/slave/test', 15:06:47 INFO - 'SHELL': '/bin/bash', 15:06:47 INFO - 'SHLVL': '1', 15:06:47 INFO - 'TERM': 'linux', 15:06:47 INFO - 'TMOUT': '86400', 15:06:47 INFO - 'USER': 'cltbld', 15:06:47 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1467756389.510580-39514871', 15:06:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:06:47 INFO - '_': '/tools/buildbot/bin/python'} 15:06:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:06:47 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:06:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:06:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:06:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:06:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:06:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:06:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:06:50 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:06:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:06:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:06:50 INFO - Installing collected packages: mozsystemmonitor 15:06:50 INFO - Running setup.py install for mozsystemmonitor 15:06:50 INFO - Successfully installed mozsystemmonitor 15:06:50 INFO - Cleaning up... 15:06:50 INFO - Return code: 0 15:06:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:06: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')]} 15:06:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:06:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:06: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')]} 15:06:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:06:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:06: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', '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 0x7f89f8fe7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd967d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe25640>, '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 0xe26540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe269d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1467756389.510580-39514871', '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 15:06: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:06: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 blobuploader==1.2.4 15:06:50 INFO - Using env: {'DISPLAY': ':0', 15:06:50 INFO - 'HOME': '/home/cltbld', 15:06:50 INFO - 'LANG': 'en_US.UTF-8', 15:06:50 INFO - 'LANGUAGE': 'en_US:en', 15:06:50 INFO - 'LOGNAME': 'cltbld', 15:06:50 INFO - 'MAIL': '/var/mail/cltbld', 15:06:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:06:50 INFO - 'MOZ_NO_REMOTE': '1', 15:06:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:06:50 INFO - 'NO_EM_RESTART': '1', 15:06:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:06:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:06:50 INFO - 'PWD': '/builds/slave/test', 15:06:50 INFO - 'SHELL': '/bin/bash', 15:06:50 INFO - 'SHLVL': '1', 15:06:50 INFO - 'TERM': 'linux', 15:06:50 INFO - 'TMOUT': '86400', 15:06:50 INFO - 'USER': 'cltbld', 15:06:50 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1467756389.510580-39514871', 15:06:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:06:50 INFO - '_': '/tools/buildbot/bin/python'} 15:06:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:06:51 INFO - Downloading/unpacking blobuploader==1.2.4 15:06:51 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 15:06:51 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 15:06:51 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 15:06:51 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 15:06:51 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 15:06:51 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 15:06:52 INFO - Downloading blobuploader-1.2.4.tar.gz 15:06:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:06:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:06: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 15:06: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 15:06: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 15:06: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 15:06: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 15:06: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 15:06:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:06:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:06: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 15:06: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 15:06: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 15:06: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 15:06: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 15:06: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 15:06:53 INFO - Downloading docopt-0.6.1.tar.gz 15:06:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:06:53 INFO - Installing collected packages: blobuploader, requests, docopt 15:06:53 INFO - Running setup.py install for blobuploader 15:06:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:06:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:06:53 INFO - Running setup.py install for requests 15:06:54 INFO - Running setup.py install for docopt 15:06:54 INFO - Successfully installed blobuploader requests docopt 15:06:54 INFO - Cleaning up... 15:06:54 INFO - Return code: 0 15:06:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:06:54 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')]} 15:06:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:06:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:06:54 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')]} 15:06:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:06:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:06:54 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 0x7f89f8fe7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd967d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe25640>, '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 0xe26540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe269d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1467756389.510580-39514871', '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 15:06:54 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 15:06:54 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 15:06:54 INFO - Using env: {'DISPLAY': ':0', 15:06:54 INFO - 'HOME': '/home/cltbld', 15:06:54 INFO - 'LANG': 'en_US.UTF-8', 15:06:54 INFO - 'LANGUAGE': 'en_US:en', 15:06:54 INFO - 'LOGNAME': 'cltbld', 15:06:54 INFO - 'MAIL': '/var/mail/cltbld', 15:06:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:06:54 INFO - 'MOZ_NO_REMOTE': '1', 15:06:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:06:54 INFO - 'NO_EM_RESTART': '1', 15:06:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:06:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:06:54 INFO - 'PWD': '/builds/slave/test', 15:06:54 INFO - 'SHELL': '/bin/bash', 15:06:54 INFO - 'SHLVL': '1', 15:06:54 INFO - 'TERM': 'linux', 15:06:54 INFO - 'TMOUT': '86400', 15:06:54 INFO - 'USER': 'cltbld', 15:06:54 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1467756389.510580-39514871', 15:06:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:06:54 INFO - '_': '/tools/buildbot/bin/python'} 15:06:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:06:54 INFO - Running setup.py (path:/tmp/pip-UI71pW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:06:54 INFO - Running setup.py (path:/tmp/pip-FizMY6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:06:54 INFO - Running setup.py (path:/tmp/pip-gJ_Ils-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:06:54 INFO - Running setup.py (path:/tmp/pip-x8LN_d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:06:54 INFO - Running setup.py (path:/tmp/pip-x9mjgi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:06:54 INFO - Running setup.py (path:/tmp/pip-G79FKA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:06:55 INFO - Running setup.py (path:/tmp/pip-_hoySQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:06:55 INFO - Running setup.py (path:/tmp/pip-GImRmg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:06:55 INFO - Running setup.py (path:/tmp/pip-ivgMsL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:06:55 INFO - Running setup.py (path:/tmp/pip-FyyQKc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:06:55 INFO - Running setup.py (path:/tmp/pip-985i9I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:06:55 INFO - Running setup.py (path:/tmp/pip-ax5O5G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:06:55 INFO - Running setup.py (path:/tmp/pip-KHralM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:06:55 INFO - Running setup.py (path:/tmp/pip-kq8Xc3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:06:55 INFO - Running setup.py (path:/tmp/pip-pNhlJt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:06:55 INFO - Running setup.py (path:/tmp/pip-Dy9avw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:06:55 INFO - Running setup.py (path:/tmp/pip-r0cb6B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:06:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:06:55 INFO - Running setup.py install for manifestparser 15:06:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:06:55 INFO - Running setup.py install for mozcrash 15:06:56 INFO - Running setup.py install for mozdebug 15:06:56 INFO - Running setup.py install for mozdevice 15:06:56 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:06:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:06:56 INFO - Running setup.py install for mozfile 15:06:56 INFO - Running setup.py install for mozhttpd 15:06:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:06:56 INFO - Running setup.py install for mozinfo 15:06:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:06:56 INFO - Running setup.py install for mozInstall 15:06:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:06:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:06:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:06:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:06:56 INFO - Running setup.py install for mozleak 15:06:56 INFO - Running setup.py install for mozlog 15:06:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:06:56 INFO - Running setup.py install for moznetwork 15:06:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:06:56 INFO - Running setup.py install for mozprocess 15:06:57 INFO - Running setup.py install for mozprofile 15:06:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:06:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:06:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:06:57 INFO - Running setup.py install for mozrunner 15:06:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:06:57 INFO - Running setup.py install for mozscreenshot 15:06:57 INFO - Running setup.py install for moztest 15:06:57 INFO - Running setup.py install for mozversion 15:06:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:06:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:06:57 INFO - Cleaning up... 15:06:57 INFO - Return code: 0 15:06:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:06:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:06:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:06:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:06:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:06:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:06:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:06:57 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 0x7f89f8fe7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd967d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe25640>, '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 0xe26540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe269d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1467756389.510580-39514871', '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 15:06:57 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 15:06:57 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 15:06:57 INFO - Using env: {'DISPLAY': ':0', 15:06:57 INFO - 'HOME': '/home/cltbld', 15:06:57 INFO - 'LANG': 'en_US.UTF-8', 15:06:57 INFO - 'LANGUAGE': 'en_US:en', 15:06:57 INFO - 'LOGNAME': 'cltbld', 15:06:57 INFO - 'MAIL': '/var/mail/cltbld', 15:06:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:06:57 INFO - 'MOZ_NO_REMOTE': '1', 15:06:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:06:57 INFO - 'NO_EM_RESTART': '1', 15:06:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:06:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:06:57 INFO - 'PWD': '/builds/slave/test', 15:06:57 INFO - 'SHELL': '/bin/bash', 15:06:57 INFO - 'SHLVL': '1', 15:06:57 INFO - 'TERM': 'linux', 15:06:57 INFO - 'TMOUT': '86400', 15:06:57 INFO - 'USER': 'cltbld', 15:06:57 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1467756389.510580-39514871', 15:06:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:06:57 INFO - '_': '/tools/buildbot/bin/python'} 15:06:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:06:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:06:57 INFO - Running setup.py (path:/tmp/pip-IbaboK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:06:57 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)) 15:06:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:06:57 INFO - Running setup.py (path:/tmp/pip-hDOJBH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:06:57 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)) 15:06:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:06:57 INFO - Running setup.py (path:/tmp/pip-IN55bU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:06:58 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)) 15:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:06:58 INFO - Running setup.py (path:/tmp/pip-lKcgFU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:06:58 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)) 15:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:06:58 INFO - Running setup.py (path:/tmp/pip-qcHcSq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:06:58 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)) 15:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:06:58 INFO - Running setup.py (path:/tmp/pip-94W5ht-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:06:58 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)) 15:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:06:58 INFO - Running setup.py (path:/tmp/pip-yAIM7E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:06:58 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)) 15:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:06:58 INFO - Running setup.py (path:/tmp/pip-kY6wEx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:06:58 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)) 15:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:06:58 INFO - Running setup.py (path:/tmp/pip-adipc_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:06:58 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)) 15:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:06:58 INFO - Running setup.py (path:/tmp/pip-KrWuMO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:06:58 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)) 15:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:06:58 INFO - Running setup.py (path:/tmp/pip-1DG8yo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:06:58 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)) 15:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:06:58 INFO - Running setup.py (path:/tmp/pip-xDX0u0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:06:58 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)) 15:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:06:58 INFO - Running setup.py (path:/tmp/pip-pioU2N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:06:58 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)) 15:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:06:58 INFO - Running setup.py (path:/tmp/pip-HWMThv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:06:58 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)) 15:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:06:58 INFO - Running setup.py (path:/tmp/pip-Q0htLN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:06:58 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)) 15:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:06:58 INFO - Running setup.py (path:/tmp/pip-4g9RBY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:06:59 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)) 15:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:06:59 INFO - Running setup.py (path:/tmp/pip-ZV96x_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:06:59 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)) 15:06:59 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)) 15:06:59 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)) 15:06:59 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)) 15:06:59 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)) 15:06:59 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)) 15:06:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:06:59 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 15:06:59 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 15:06:59 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 15:06:59 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 15:06:59 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 15:06:59 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 15:07:00 INFO - Downloading blessings-1.6.tar.gz 15:07:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:07:01 INFO - Installing collected packages: blessings 15:07:01 INFO - Running setup.py install for blessings 15:07:01 INFO - Successfully installed blessings 15:07:01 INFO - Cleaning up... 15:07:01 INFO - Return code: 0 15:07:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:07:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:07:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:07:01 INFO - Reading from file tmpfile_stdout 15:07:01 INFO - Current package versions: 15:07:01 INFO - argparse == 1.2.1 15:07:01 INFO - blessings == 1.6 15:07:01 INFO - blobuploader == 1.2.4 15:07:01 INFO - docopt == 0.6.1 15:07:01 INFO - manifestparser == 1.1 15:07:01 INFO - mozInstall == 1.12 15:07:01 INFO - mozcrash == 0.17 15:07:01 INFO - mozdebug == 0.1 15:07:01 INFO - mozdevice == 0.48 15:07:01 INFO - mozfile == 1.2 15:07:01 INFO - mozhttpd == 0.7 15:07:01 INFO - mozinfo == 0.9 15:07:01 INFO - mozleak == 0.1 15:07:01 INFO - mozlog == 3.1 15:07:01 INFO - moznetwork == 0.27 15:07:01 INFO - mozprocess == 0.22 15:07:01 INFO - mozprofile == 0.28 15:07:01 INFO - mozrunner == 6.11 15:07:01 INFO - mozscreenshot == 0.1 15:07:01 INFO - mozsystemmonitor == 0.0 15:07:01 INFO - moztest == 0.7 15:07:01 INFO - mozversion == 1.4 15:07:01 INFO - psutil == 3.1.1 15:07:01 INFO - requests == 1.2.3 15:07:01 INFO - wsgiref == 0.1.2 15:07:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:07:01 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')]} 15:07:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:07:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:07:01 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')]} 15:07:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:07:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:07:01 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 0x7f89f8fe7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd967d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe25640>, '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 0xe26540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe269d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1467756389.510580-39514871', '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 15:07:01 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 15:07:01 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 15:07:01 INFO - Using env: {'DISPLAY': ':0', 15:07:01 INFO - 'HOME': '/home/cltbld', 15:07:01 INFO - 'LANG': 'en_US.UTF-8', 15:07:01 INFO - 'LANGUAGE': 'en_US:en', 15:07:01 INFO - 'LOGNAME': 'cltbld', 15:07:01 INFO - 'MAIL': '/var/mail/cltbld', 15:07:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:07:01 INFO - 'MOZ_NO_REMOTE': '1', 15:07:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:07:01 INFO - 'NO_EM_RESTART': '1', 15:07:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:07:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:07:01 INFO - 'PWD': '/builds/slave/test', 15:07:01 INFO - 'SHELL': '/bin/bash', 15:07:01 INFO - 'SHLVL': '1', 15:07:01 INFO - 'TERM': 'linux', 15:07:01 INFO - 'TMOUT': '86400', 15:07:01 INFO - 'USER': 'cltbld', 15:07:01 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1467756389.510580-39514871', 15:07:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:07:01 INFO - '_': '/tools/buildbot/bin/python'} 15:07:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:07:01 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)) 15:07:01 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)) 15:07:01 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)) 15:07:01 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)) 15:07:01 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)) 15:07:01 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)) 15:07:01 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)) 15:07:01 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)) 15:07:01 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)) 15:07:01 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)) 15:07:01 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)) 15:07:01 INFO - Cleaning up... 15:07:01 INFO - Return code: 0 15:07:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:07:01 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')]} 15:07:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:07:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:07:01 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')]} 15:07:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:07:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:07:01 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 0x7f89f8fe7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd967d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe25640>, '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 0xe26540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe269d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1467756389.510580-39514871', '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 15:07:01 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 15:07:01 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 15:07:01 INFO - Using env: {'DISPLAY': ':0', 15:07:01 INFO - 'HOME': '/home/cltbld', 15:07:01 INFO - 'LANG': 'en_US.UTF-8', 15:07:01 INFO - 'LANGUAGE': 'en_US:en', 15:07:01 INFO - 'LOGNAME': 'cltbld', 15:07:01 INFO - 'MAIL': '/var/mail/cltbld', 15:07:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:07:01 INFO - 'MOZ_NO_REMOTE': '1', 15:07:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:07:01 INFO - 'NO_EM_RESTART': '1', 15:07:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:07:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:07:01 INFO - 'PWD': '/builds/slave/test', 15:07:01 INFO - 'SHELL': '/bin/bash', 15:07:01 INFO - 'SHLVL': '1', 15:07:01 INFO - 'TERM': 'linux', 15:07:01 INFO - 'TMOUT': '86400', 15:07:01 INFO - 'USER': 'cltbld', 15:07:01 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1467756389.510580-39514871', 15:07:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:07:01 INFO - '_': '/tools/buildbot/bin/python'} 15:07:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:07:01 INFO - Downloading/unpacking jsonschema 15:07:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:07:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:07:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:07:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:07:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:07:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:07:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:07:03 INFO - Downloading/unpacking functools32 (from jsonschema) 15:07:03 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 15:07:03 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 15:07:03 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 15:07:03 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 15:07:03 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 15:07:03 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 15:07:03 INFO - Downloading functools32-3.2.3-2.tar.gz 15:07:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:07:04 INFO - warning: no files found matching '*.txt' 15:07:04 INFO - no previously-included directories found matching 'build' 15:07:04 INFO - no previously-included directories found matching 'dist' 15:07:04 INFO - no previously-included directories found matching '.git*' 15:07:04 INFO - Installing collected packages: jsonschema, functools32 15:07:04 INFO - Running setup.py install for functools32 15:07:04 INFO - warning: no files found matching '*.txt' 15:07:04 INFO - no previously-included directories found matching 'build' 15:07:04 INFO - no previously-included directories found matching 'dist' 15:07:04 INFO - no previously-included directories found matching '.git*' 15:07:04 INFO - Successfully installed jsonschema functools32 15:07:04 INFO - Cleaning up... 15:07:04 INFO - Return code: 0 15:07:04 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 15:07:04 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')]} 15:07:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:07:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:07:04 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')]} 15:07:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:07:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:07:04 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 0x7f89f8fe7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd967d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe25640>, '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 0xe26540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe269d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1467756389.510580-39514871', '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 15:07:04 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 15:07:04 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 15:07:04 INFO - Using env: {'DISPLAY': ':0', 15:07:04 INFO - 'HOME': '/home/cltbld', 15:07:04 INFO - 'LANG': 'en_US.UTF-8', 15:07:04 INFO - 'LANGUAGE': 'en_US:en', 15:07:04 INFO - 'LOGNAME': 'cltbld', 15:07:04 INFO - 'MAIL': '/var/mail/cltbld', 15:07:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:07:04 INFO - 'MOZ_NO_REMOTE': '1', 15:07:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:07:04 INFO - 'NO_EM_RESTART': '1', 15:07:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:07:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:07:04 INFO - 'PWD': '/builds/slave/test', 15:07:04 INFO - 'SHELL': '/bin/bash', 15:07:04 INFO - 'SHLVL': '1', 15:07:04 INFO - 'TERM': 'linux', 15:07:04 INFO - 'TMOUT': '86400', 15:07:04 INFO - 'USER': 'cltbld', 15:07:04 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1467756389.510580-39514871', 15:07:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:07:04 INFO - '_': '/tools/buildbot/bin/python'} 15:07:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:07:04 INFO - Downloading/unpacking flake8 15:07:04 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 15:07:04 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 15:07:04 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 15:07:04 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 15:07:04 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 15:07:04 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 15:07:06 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:07:06 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:07:06 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 15:07:06 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 15:07:06 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 15:07:06 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 15:07:06 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 15:07:06 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 15:07:06 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:07:06 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:07:06 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 15:07:06 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 15:07:06 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 15:07:06 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 15:07:06 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 15:07:06 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 15:07:06 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:07:06 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 15:07:06 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 15:07:06 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 15:07:06 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 15:07:06 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 15:07:06 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 15:07:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 15:07:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:07:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:07:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:07:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:07:07 INFO - no previously-included directories found matching 'docs/_build' 15:07:07 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:07:07 INFO - Running setup.py install for pep8 15:07:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:07:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:07:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:07:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:07:07 INFO - no previously-included directories found matching 'docs/_build' 15:07:07 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 15:07:07 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:07:07 INFO - Cleaning up... 15:07:07 INFO - Return code: 0 15:07:07 INFO - Running post-action listener: _resource_record_post_action 15:07:07 INFO - Running post-action listener: _start_resource_monitoring 15:07:07 INFO - Starting resource monitoring. 15:07:07 INFO - ##### 15:07:07 INFO - ##### Running install step. 15:07:07 INFO - ##### 15:07:07 INFO - Running pre-action listener: _resource_record_pre_action 15:07:07 INFO - Running main action method: install 15:07:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:07:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:07:07 INFO - Reading from file tmpfile_stdout 15:07:07 INFO - Detecting whether we're running mozinstall >=1.0... 15:07:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:07:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:07:07 INFO - Reading from file tmpfile_stdout 15:07:07 INFO - Output received: 15:07:07 INFO - Usage: mozinstall [options] installer 15:07:07 INFO - Options: 15:07:07 INFO - -h, --help show this help message and exit 15:07:07 INFO - -d DEST, --destination=DEST 15:07:07 INFO - Directory to install application into. [default: 15:07:07 INFO - "/builds/slave/test"] 15:07:07 INFO - --app=APP Application being installed. [default: firefox] 15:07:07 INFO - mkdir: /builds/slave/test/build/application 15:07:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 15:07:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 15:07:20 INFO - Reading from file tmpfile_stdout 15:07:20 INFO - Output received: 15:07:20 INFO - /builds/slave/test/build/application/firefox/firefox 15:07:20 INFO - Running post-action listener: _resource_record_post_action 15:07:20 INFO - ##### 15:07:20 INFO - ##### Running run-tests step. 15:07:20 INFO - ##### 15:07:20 INFO - Running pre-action listener: _resource_record_pre_action 15:07:20 INFO - Running main action method: run_tests 15:07:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:07:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:07:20 INFO - Python 2.7.3 15:07:20 INFO - Return code: 0 15:07:20 INFO - grabbing minidump binary from tooltool 15:07: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')]} 15:07:20 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 0xe25640>, '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 0xe26540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe269d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:07:20 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 15:07:20 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 15:07:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:07:20 INFO - Return code: 0 15:07:20 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:07:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:07:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:07:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:07:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:07:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 15:07:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 15:07:21 INFO - Return code: 0 15:07:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bsjBRbYfRR-flt3iMjJ8Fw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--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 15:07:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bsjBRbYfRR-flt3iMjJ8Fw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-001 --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 15:07:21 INFO - Using env: {'DISPLAY': ':0', 15:07:21 INFO - 'HOME': '/home/cltbld', 15:07:21 INFO - 'LANG': 'en_US.UTF-8', 15:07:21 INFO - 'LANGUAGE': 'en_US:en', 15:07:21 INFO - 'LOGNAME': 'cltbld', 15:07:21 INFO - 'MAIL': '/var/mail/cltbld', 15:07:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:07:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:07:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:07:21 INFO - 'MOZ_NO_REMOTE': '1', 15:07:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:07:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:07:21 INFO - 'NO_EM_RESTART': '1', 15:07:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:07:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:07:21 INFO - 'PWD': '/builds/slave/test', 15:07:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:07:21 INFO - 'SHELL': '/bin/bash', 15:07:21 INFO - 'SHLVL': '1', 15:07:21 INFO - 'TERM': 'linux', 15:07:21 INFO - 'TMOUT': '86400', 15:07:21 INFO - 'USER': 'cltbld', 15:07:21 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1467756389.510580-39514871', 15:07:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:07:21 INFO - '_': '/tools/buildbot/bin/python'} 15:07:21 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bsjBRbYfRR-flt3iMjJ8Fw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--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 15:07:22 INFO - mozversion application_buildid: 20160705121723 15:07:22 INFO - mozversion application_changeset: 52fb1d141cc9c18d7b7971d778b8976e43f360dc 15:07:22 INFO - mozversion application_display_name: Firefox 15:07:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:07:22 INFO - mozversion application_name: Firefox 15:07:22 INFO - mozversion application_remotingname: firefox 15:07:22 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 15:07:22 INFO - mozversion application_vendor: Mozilla 15:07:22 INFO - mozversion application_version: 48.0 15:07:22 INFO - mozversion platform_buildid: 20160705121723 15:07:22 INFO - mozversion platform_changeset: 52fb1d141cc9c18d7b7971d778b8976e43f360dc 15:07:22 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 15:07:22 INFO - mozversion platform_version: 48.0 15:07:22 INFO - using testdate: 1467756442 15:07:22 INFO - actual date: 1467756442 15:07:22 INFO - starting webserver on 'localhost:35180' 15:07:22 INFO - SUITE-START | Running 2 tests 15:07:22 INFO - TEST-START | dromaeo_css 15:07:22 INFO - operating with platform_type : linux_ 15:07:22 INFO - Initialising browser for dromaeo_css test... 15:07:22 INFO - TEST-INFO | started process 3342 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpP4MEvH/profile http://localhost:35180/getInfo.html) 15:07:26 INFO - PROCESS | 3342 | __metrics Screen width/height:1600/1200 15:07:26 INFO - PROCESS | 3342 | colorDepth:24 15:07:26 INFO - PROCESS | 3342 | Browser inner width/height: 1024/697 15:07:26 INFO - PROCESS | 3342 | __metrics 15:07:27 ERROR - PROCESS | 3342 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 15:07:27 INFO - TEST-INFO | 3342: exit 0 15:07:27 INFO - Browser initialized. 15:07:27 INFO - Running cycle 1/1 for dromaeo_css test... 15:07:27 INFO - TEST-INFO | started process 3434 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpP4MEvH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:07:39 INFO - PROCESS | 3434 | RSS: Main: 139673600 15:07:39 INFO - PROCESS | 3434 | 15:08:30 INFO - PROCESS | 3434 | 1467756510445 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] 15:10:37 INFO - PROCESS | 3434 | Cycle 1(1): loaded http://localhost:35180/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35180/tests/dromaeo/cssquery-ext.html) 15:10:38 INFO - PROCESS | 3434 | RSS: Main: 248741888 15:10:38 INFO - PROCESS | 3434 | 15:13:40 INFO - PROCESS | 3434 | Cycle 1(1): loaded http://localhost:35180/tests/dromaeo/cssquery-ext.html (next: http://localhost:35180/tests/dromaeo/cssquery-jquery.html) 15:13:41 INFO - PROCESS | 3434 | RSS: Main: 221188096 15:13:41 INFO - PROCESS | 3434 | 15:16:43 INFO - PROCESS | 3434 | Cycle 1(1): loaded http://localhost:35180/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35180/tests/dromaeo/cssquery-mootools.html) 15:16:44 INFO - PROCESS | 3434 | RSS: Main: 221048832 15:16:44 INFO - PROCESS | 3434 | 15:19:45 INFO - PROCESS | 3434 | Cycle 1(1): loaded http://localhost:35180/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35180/tests/dromaeo/cssquery-prototype.html) 15:19:46 INFO - PROCESS | 3434 | RSS: Main: 220098560 15:19:46 INFO - PROCESS | 3434 | 15:22:48 INFO - PROCESS | 3434 | Cycle 1(1): loaded http://localhost:35180/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35180/tests/dromaeo/cssquery-yui.html) 15:22:49 INFO - PROCESS | 3434 | RSS: Main: 185221120 15:22:49 INFO - PROCESS | 3434 | 15:25:51 INFO - PROCESS | 3434 | Cycle 1(1): loaded http://localhost:35180/tests/dromaeo/cssquery-yui.html (next: http://localhost:35180/tests/dromaeo/cssquery-dojo.html) 15:25:52 INFO - PROCESS | 3434 | RSS: Main: 254529536 15:25:52 INFO - PROCESS | 3434 | 15:25:52 INFO - PROCESS | 3434 | __start_tp_report 15:25:52 INFO - PROCESS | 3434 | _x_x_mozilla_page_load 15:25:52 INFO - PROCESS | 3434 | _x_x_mozilla_page_load_details 15:25:52 INFO - PROCESS | 3434 | |i|pagename|runs| 15:25:52 INFO - PROCESS | 3434 | |0;dojo.html;3183.5224716292555;3225.193701574606;3242.38394705006;3266.7713260071773;3274.296026354335;5342.038433082043;5342.599305052122;5345.6792592444435;5353.036453438384;5353.277307563478;5384.6499977501435;5395.514403703666;5403.648762830413;5412.783488660449;5424.783008679648;4906.435759887614;4908.190148625473;4978.178600530926;5031.471695471978;5048.343715317003;4904.117258893398;4968.925466118011;5009.924851127236;5015.3730783652045;5015.39815222172;4927.6550641455115;4991.600671946254;5008.223725322581;5019.573336266421;5041.344625198737;4898.14282500561;4911.607071434277;4926.507349265081;4929.9893521827935;4967.801287948496;4838.733869637169;4872.317875497433;4920.6309526785635;4922.532359425849;4991.875203119915;5366.785328586851;5380.219868119101;5410.053240682865;5425.240466334716;5429.8099566515375;5816.854578635525;5830.4461076197695;5832.62087964281;5837.824865254049;5838.2702162229725;5759.568032397545;5774.884502309972;5830.096335068071;5834.4165583441745;5874.588778785486;5335.893282134374;5342.171963345688;5386.48828361305;5387.4073851876265;5387.730613469272;5693.772249109989;5805.564582656318;5815;5820.1560773688425;5823.912641310384;5682.602217844711;5725.5133313667975;5730.512906402919;5746.224259724967;5781.364049954502;5775.653460792366;5776.018076926933;5780.421957804186;5781.219535362672;5789.8263052108505;5577.024020796344;5743.770249190069;5761.5102716269585;5763.8559036024435;5806.071028635482;5674.06377947634;5678.375378708339;5684.147377893349;5702.116171993348;5712.971435142797;4396.472423309159;4401.735895846259;4405.801738921757;4423.1153769246275;4429.180601588717;3930.0174956260935;3949.644531992077;3960.5643379228263;3997.6801855851463;3997.8001099944886;5313.654612450178;5372.516473517402;5376;5376.193570964387;5429.185622156708;5653.067243904792;5655.745491452894;5658.927109744661;5663.603547751618;5695.715214239354;5313.973430132902;5447.836564903059;5479.232907392969;5559.749811258503;5572.080606699849;4956.603471722254;4966.577840883493;4975.726335051607;4977.1538838397555;5000.099982003201;5904.350521442638;5964.7315870785915;5974.880502389928;5990.251218597676;5990.73041713124;5637.577181711306;5812.709364531841;5871.295444546682;5884.411558844081;5894.115882617642;6010.699465026819;6029.457348838626;6057.303410107717;6057.7879774207695;6058.303295121117;5522.116461366162;5681.744321505625;5697.971510142423;5703.230063941315;5725.112607545837;5826.475617194473;5861.912071318849;5879.147523609138;5885.058390657474;5918.2898052234;5644.9435505644415;5654.264945557051;5655.151727240782;5657.575681823797;5659.915101273402;5470.316210473691;5528.198411230269;5600.103983362643;5609.971950140386;5618.297712785902;5547.362053363915;5606.159076138449;5607.271054762855;5615.831525054255;5646.237757902795;5699.51554117888;5744.827655170351;5747.511461525817;5747.511461525817;5753.9136912945505;5414.972925135349;5554.416786237387;5625.718714064362;5641.746121424628;5662.943370566241 15:25:52 INFO - PROCESS | 3434 | |1;ext.html;653.1998302079953;669.1401549009527;682.7542084849454;744.9068866391701;753.2730914667345;32584.348313033755;39889;40609.39085913714;40648.18703625926;40723.98190045247;43597.564024359745;44041.339379909325;44251;44259.33610995838;44295.557044429544;8119.309858662021;8275.131111233324;8707.608157632922;8892.377533572653;10315.587376504931;10286.177105831515;10395.168386529098;10407.063364297212;10407.583696652126;10409;10416.843747343795;10499.790004199911;10502.107320877696;10505;10505.789884202311;10409.16726661869;10460.058594726435;10460.68617941463;10464.476776161238;10467.16262698986;10450.738731531697;10584.364938103738;10585.84121238182;10886.61896833607;10894.291871028357;42687.35968960468;43144.78427607873;43158;43173.78413107946;43197.35203971943;3520.9647903520895;3572.732045096628;3655.780653160819;3847.71142164336;4227.767472788995;32503.6749632503;32663;32903.34193316144;33876;34316.656833431596;4108.465899433085;4150.792460376999;4176.895577610554;4254.91490170198;4357.760323182224;321393;321977;322930;323190;323236;40099;40629;40631;40652.18695626071;60165.39834601685;37865.62134378676;37985.62014379821;38061.80969095137;38293.617063829006;38341.80829095837;14940;16836.915815420845;17041.48875533736;17045.40341088056;17063.48809535716;13847;13910.304484775923;13929.791053134211;13992.440302387995;14135;9170.587323570455;9243;9245.352825302165;9273.211776998896;9307.441553506811;3572.624874388204;3667.9083022924106;3681.889543313705;3685.1892583631557;3689.0777305673582;1063.707480442869;1138.1805100327915;1138.2203190814319;1202.915795894279;1228.846394200725;33200.83399582987;33201.83399082989;33907.49138762871;34328;34534.27196738446;1199.676087456382;1242.589945318061;1274.1972557288848;1298.2859427314938;1380.496118916588;17461;17702.026388548755;17805.7329140063;17894.821051789575;17931.73102403465;470990;475707;476344;477282;477440;60143.097853532236;61046;61089.69455152785;61144;61201;1383.8616138386283;1531.0890020438044;1552.1851028210053;1552.534239728077;1672.4898905833838;30137.246568835955;31663.841680791447;32192.263657589367;32532.67467325391;33563.49654755229;48758.75620621874;49334.75332623314;49402.75298623484;49412.258816118505;49413.25880111729;305128;312698;312858;313717;433339;30132.397352052398;30526.08421747351;30597.08208753741;30895.691043089282;31023.68976310208;43687;44300.77849610731;44361.33457998068;45289.54710452853;46042.07915841731;37215.62784372122;37350.31923563392;37406.438903415925;37552.2489550202;38073.23853522969;35738.262565402394;37050;37430.6256937438;39305.803470982464;40024;41689.37465938074;41752.79123604484;41811.7909410451;43042;43478.78260608677;35154.82422587871;35336.04481926701;36426.635733642324;36688.899333020054;36818.815905920295;28195.57706634443;28280.434391311646;28383.716162838933;28504.57243141396;28579.28551786222 15:25:52 INFO - PROCESS | 3434 | |2;jquery.html;423.99581865874694;431.3292829649895;434.07975092803264;442.634120625258;460.44746304434665;18883.52791180221;19482.51293717656;19519;19853.908035058066;20136.59726805463;19297.61404771904;19361.709574356362;20210.69683954738;20257.189712411524;20268.59462810743;5707.172459993288;5773.595848290622;5928.199693041449;5947.791827286046;5950.256217972732;4307.806148723299;5804.854878628026;5829.358770535237;6075.63546187228;6372.299047104815;6329.4619957303685;6335.968320158416;6343.873122537547;6367.968160159193;6371.8407039823915;6307.432331090201;6334.556581039329;6370.235571731376;6403.5197360197935;6549.083128362033;4031.093004074089;4141.088960428731;5505.6696598204235;5832.620879642852;5866.178734977107;23326.883365583235;24415;25238.495230095294;25324;25423.23730288094;2471.4439251168524;2490.0164435048237;2492.8753562321813;2708.9051883183993;2845.672747634028;14811.259437028106;15248.31382587775;15621.218939053002;15773.447929322534;15941;1834.5230240137528;1890.8203720646516;1919.0500702152385;1978.169168949045;2017.2939471185114;82416;84539;85071.57464212702;85557.57221213855;86246.56876715577;10990.505427255792;11208.66374008781;11439.084873210124;11531.423428828693;11657.650270491898;16463.753043704353;16542.172891355385;16627.83372166287;16630.6673866522;16661.583460413345;8591.484510929364;8699.086595907338;8717.91282087171;8757.386982911263;8768.824623507622;8435.536045517432;8521.914780852112;8535.274501667303;8542.871856922151;8546.914530854736;4908.730019848943;5057.747112644353;5058.772355244023;5099.209622508443;5125.948740512622;1866.1322485044248;2009.849261305408;2019.4951262184454;2076.8338532917332;2113.7991890770354;1038.7818558102883;1052.0426411965075;1089.3953855610212;1091.770728147082;1190.3215167354697;18701.620600566544;19480.415587532396;19714.802851971297;19838.70241946372;19848.10683519245;1069.4226016625416;1116.0848104554188;1121.3384103379046;1144.4392247798685;1174.682835634374;11051.889481105247;11099.83350249747;11145.554177832959;11148.832767508495;11198.38408887519;523601;533644;534540;549164;563320;91549;91715.54142229246;93504;95300.52349738206;95353.52323238339;1112.710695219249;1139.0773473486668;1184.1237484261756;1186.6832203989698;1209.9758004839855;16927.984320940785;16990.23543940501;17065;17273.790834641455;17280.481585552454;40871.38692919549;41457.79271103625;41804.163916720885;42547;42603;55637.44362556485;59931;60015.69992150011;60099.39900600938;60115;8831.249343805848;8871.955640221757;8950.507722075348;9014.639414423613;9302.860457093013;9453.905460945303;12762.872371276168;13106.410211540695;13138.540151094665;13587.86412135866;11494.597689080842;11573.652790416301;11739.882601173878;11820.290782553075;12092.214006089927;11458.484368203617;11507.712307192387;11693.88306116962;11805.468753905923;11955.342456164994;11697.941510292394;11774.587889423829;11872.347020913587;11953;12079.51681932713;8749.606267717842;8883.555822208993;8972.820543589221;8997.145271199226;9012.369134160808;9004.414713043894;11899;11951.76096478083;12006.699832504257;12255.387230638611 15:25:52 INFO - PROCESS | 3434 | |3;mootools.html;1415.787631855221;1573.606598350412;1578.3292100857136;1765.7704498415212;1905.4093231098352;7535.321821036106;8202.507849529033;8305.294050005758;8305.750827475178;8307.29388002019;8373.539455329954;8499.107593702665;8507.872381914261;8516.06323304436;8539.530325832076;2313.5488579726916;2326.8603883766946;2341.098677009355;2342.390978345634;2350.4476448034698;2180;2218.689383486313;2220.289507357646;2233.8101261392803;2235.3405745305095;2293.747687754346;2297.701298831158;2302.9078836846506;2340.309608665439;2342.0865862313713;2227.9220227291967;2302.5970455170363;2304.83866129371;2305.3775480620307;2309.1225334372916;2259.5819773341987;2259.728832540089;2263.1400067974064;2265.490264690448;2267.047839907243;8300.418970672055;8453.365997550147;8779.20987111163;8789.340799440004;8811.955940220321;5468.507834294933;5515.944840551583;5530.695811730353;5545.306836645419;5583.8883222335735;3528.9294214115575;3544.1848374873925;3581.5164952731307;3623.7644553103964;3626.8367923443507;1113.6881673131536;1129.4409267412602;1157.195748954477;1167.1479819731558;1209.0871392098998;11947.462364193632;12304.384780761016;12311.076669249842;12318.938405308007;12332.506699732;4599.425071866017;4673.439187297546;4744.027474367746;4781.52184781526;4803.351547541107;9831.655892043744;9850.359726617748;9861.802763944681;9917.603295868228;9939.304248702667;5501.614886957875;5505.476979686923;5511;5513.421090785409;5513.751881165357;4353.9129217415475;4817.470078291385;4956.8760780980765;4997.7755449915;5107.055194788976;3852.7110466715108;3863.61363863617;3974.145558704892;3976.8011599419915;4013.1572369802084;1179.3690375648987;1182.355616189179;1205.4153735438306;1208.0577149823152;1217.8964787992943;886.9334799890034;972.9346365729515;1030.3229207069103;1042.781015986636;1051.8895515970867;5856.677882716406;5876.294844618673;5930;5996.4603185713495;6073.271207455134;476.138189876325;479.39356713757127;479.6210993315242;486.32643788353386;487.4783981140146;3820.2932457495453;3915.9216815663526;3937.92124157521;3939.0546268895832;3997.8001099944886;10498.370097794004;10879.564817407216;10885.074768644754;10913.126949843994;10941.945290273658;10746.140308775279;10748.193885458622;10771.78456430867;10773.730656733644;10775.83836242457;8187.4678145920325;8290.544020078833;8366.874496882552;8373.62318695648;8382.748517544484;5592.524635406036;5639.125935480007;5642.774289028393;5701.914471282851;5743.167240749985;9548.236141108833;9569.28230382738;9682.70951871445;9767.169790567881;9775.902240977499;9602.519874006412;9691;9695.321327507007;9890.703278901645;9917.355371900803;6537.738490460329;6753.932460675527;7112.715491380287;7419.962900185465;7475.626218688935;8348.415610907177;8400.201980811813;8419.115992820665;8439.831203375776;8455.704050358208;7025.894611580932;7082.185548661764;7122.5726456412785;7273.527220730635;7305.780826575211;7458.254174582498;7484.363829074589;7516.060492438445;7549.01862757838;7622;6964;7082.220955694766;7149.60677162761;7151.678174482265;7180;4996.700857776931;5122.871928201825;5153.922691159561;5182.97408512955;5215.113430716711;5027.924581131213;5125.231215317583;5192.610554208525;5225.268462415341;5230.607704422107 15:25:52 INFO - PROCESS | 3434 | |4;prototype.html;364.8303538854434;366.89910274674463;369.0644216910133;373.7570579123571;375.87220345082665;6014.1580178775;6195.194624698783;6285.874282514353;6292.8741425171465;6310.7791227307;6182.2581290245125;6238.095476155955;6284.591501552396;6288.088227207052;6305.716242769075;4821.180399332122;4865.68373055752;4871.196252618313;4874.805007799701;4876.902461950759;4620.792064357095;4719.433667959833;4829.782659780319;4872.537108974641;4875.366202393684;4813.3983252093485;4819.807207711688;4832.347633069543;4833.516648335173;4837.346958160639;4797.424309082898;4816.590589799889;4820.517948205186;4829.589484893788;4837.8306759263605;4275.764832934187;4279.657627389802;4281.678874084425;4287.356896465524;4288.592583704543;6000.279966404016;6000.399960004008;6012.278526576839;6013.128096426038;6021.157038014681;5337.2527846101575;5603.3836278009385;5606.943930560683;5607.495325420732;5610.49505544503;6519.4132528072705;6549.443297319734;6569.474442044625;6571.934280657228;6577.079208910756;4583.03756211196;4589.632829373642;4590.977045114753;4597.517260687613;4604.861854144381;6798.354156355188;6877.931220687829;6890.621015844126;6894.207166175904;6896.172459304866;4701.882452938704;4703.412073490814;4708.152532544106;4708.95291047092;4710.199266124767;4657.534246575383;4768.403949506312;4775.307580400822;4776.020915712271;4776.785044672998;5452.345718513724;5481.5340696041285;5485.232067510552;5491.066518691832;5498.120300751861;6593;6612.966935165294;6620.404163625297;6625.768098116543;6648.368405001517;1583.754518049704;1638.3037209186048;1673.3473945161154;1673.707101257275;1674.2131198336763;1096.2216826053432;1113.1150735165563;1114.7101753543975;1116.6482557994207;1119.322809700136;6302.243730752339;6322.0516922462;6323.430891219812;6323.494120470351;6342.429181373606;6680.432163266177;6682.899756503656;6683.866322673519;6687.665616719145;6691.76578819739;6317.399847014526;6322.71547780351;6323.146375239376;6323.683815809191;6326.323524266073;3621.6740493355724;3654.543182102237;3657.561092668897;3659.3779057560278;3664.6885014774043;6983.650817459106;7079.469039822034;7216.278372162847;7280.708771649075;7282.563046217244;7001.824954376181;7015.158181018311;7015.298470153046;7020.122484689414;7022.578645281299;7230.457715671346;7238.963805180941;7249.565026098451;7256.0567126273245;7256.746013889594;6875.621840798804;6888.586684798928;6893.689783959633;6893.724251029903;6908.827279318058;6599.142111525471;6774.153230846145;6785.626790526569;6791.592504449749;6797.422219111431;7196.928030719835;7215.855682886207;7219.783406497813;7227;7237.059182306267;4692.155412025868;4733.905321893474;4736.194846876108;4737.407824021997;4740.431148262231;6513.576617519846;6735.6968936397;6859.725610975505;6860.176778786577;6874.862502749817;6642.634655094016;6655.101561289358;6661.3338666132995;6663.800085997428;6665.133532640726;6589.505787065893;6654.234763002123;6661.300563440769;6668.43318317929;6676.098726672031;6478.967605161944;6484.773032943825;6490.221173459215;6491.285958544462;6500.382463665944;6588;6667.099941507834;6698.095757072733;6713.395794378529;6735.124433823572;6533.934660653523;6553.475721942138;6556.704948277435;6559.048937903882;6564.146660934048 15:25:52 INFO - PROCESS | 3434 | |5;yui.html;890.8619164029576;921.2169655792577;931.942245551299;936.5457752989803;938.4885237545537;14374.784378234323;14572.708545829077;14580.781288280657;14590.978631495786;14598.124112553242;14177.716445671107;14196.503122390692;14287.285635718225;14289.499867504639;14344.856551434483;901.2069378946518;910.2126660438739;916.0152835701614;916.1251005289932;916.8166366726681;744.4193529047352;881.8280435315116;904.1681652879366;908.2280061947325;908.3369140527419;949.9097585729379;950.7813202963323;955.0926619711302;955.913967742903;958;771.8263390737095;948.48781657905;951.4386511957978;951.6193522590985;952.6998995316487;695.3185877839695;701.7473709464589;703.9753608623724;705.3546005405049;707.1337611426013;14524.636884077878;14568.781468277984;14612.123272603572;14623.488177913721;14646.560603181922;13970.650733731738;14622.26888655563;14851.183184924825;15182.924085379613;15214.923925380303;11499.885001150049;11746.412679366083;11869.821952670716;12241.387930603523;12289.815652765215;3947.940780888289;4010.7794071326066;4028.4964379452567;4050.25070361984;4076.714629975903;54114.72942635301;54176.18735718967;54708.72645636786;54958.72520637371;55020.174697379574;10784.697870736376;11085.113190944705;11329.773404531863;11477.54089836414;11580.478878450322;21046.684299735516;21081.26215582478;21106.683399749018;21221.257255996275;21223.363299101053;7962.56205908669;8289.336853051742;8600.612972416131;8754.037055923844;8754.343424243207;4973.452920178777;4989.251612258117;5015.673981191211;5016.598672106223;5130.384353877484;3742.1580144467275;3781.5084039075296;3801.885943421702;3806.352920003606;3808.409696497047;658.5094104891887;667.1760375935716;725.271102541942;750.1860481377657;757.5757575757593;664.4020381656547;713.5718568858747;767.4359345880773;809.1948511231362;827.7351247600831;8972.237359824358;9448.433094014381;9538.23694104484;9545.474998875128;9644.710658680251;780.2197802197802;843.4180415513276;843.7384410832661;848.974530764078;854.1159899503983;4543;4575.450945886449;4611.8847028823875;4630.6758526902795;4657.767111644472;69015.30984690088;69648.30351696418;69664.30335696579;69893;69985;56182.71908640431;56350.49196064305;57593;57618.135727964116;59810.70094649499;50447.24329135066;51524.227136592985;51627;52574.21138682999;53171.46828531665;8679.913200868163;8817.470951742916;8924.616684413926;9069.18377346042;9152.267818574632;36765.81617092004;37672.62327376801;38556.614433855306;38556.80721596374;38674;46598.53401466078;47964.28053579269;48083.27875081947;51846.74076629593;52731.47268527419;12596.685082873002;12797.29614871191;12825.358732063172;13203.735925281248;13514.59456216315;14577.489787857374;14605.061159807938;14685.926570367079;14912.254387280376;15508.84491155074;13635.727285454434;13718.17690938547;13764.242966636932;13778.931105344409;14258.643533911736;12751.362431878555;13527.729445411234;13697.246651434267;13760.31198440054;14411.495597654031;12146.75706485883;12598.370081496072;12753.8086928698;12811.295378754257;13090.345482725636;9428.15146636806;9620.37467564606;11384.715382115513;11778.82331765007;11800.114991375509;11308.378039207922;11454.599089031844;11457.140714446283;11631.53473861036;11751.764964700487 15:25:52 INFO - PROCESS | 3434 | __end_tp_report 15:25:52 INFO - PROCESS | 3434 | __start_cc_report 15:25:52 INFO - PROCESS | 3434 | _x_x_mozilla_cycle_collect,865 15:25:52 INFO - PROCESS | 3434 | __end_cc_report 15:25:52 INFO - PROCESS | 3434 | __startTimestamp1467757552078__endTimestamp 15:25:52 INFO - PROCESS | 3434 | 15:25:52 INFO - PROCESS | 3434 | ------- Summary: start ------- 15:25:52 INFO - PROCESS | 3434 | Number of tests: 6 15:25:52 INFO - PROCESS | 3434 | 15:25:52 INFO - PROCESS | 3434 | [#0] dojo.html Cycles:165 Average:5372.78 Median:5600.10 stddev:590.39 (10.5%) stddev-sans-first:566.67 15:25:52 INFO - PROCESS | 3434 | Values: 3183.5 3225.2 3242.4 3266.8 3274.3 5342.0 5342.6 5345.7 5353.0 5353.3 5384.6 5395.5 5403.6 5412.8 5424.8 4906.4 4908.2 4978.2 5031.5 5048.3 4904.1 4968.9 5009.9 5015.4 5015.4 4927.7 4991.6 5008.2 5019.6 5041.3 4898.1 4911.6 4926.5 4930.0 4967.8 4838.7 4872.3 4920.6 4922.5 4991.9 5366.8 5380.2 5410.1 5425.2 5429.8 5816.9 5830.4 5832.6 5837.8 5838.3 5759.6 5774.9 5830.1 5834.4 5874.6 5335.9 5342.2 5386.5 5387.4 5387.7 5693.8 5805.6 5815.0 5820.2 5823.9 5682.6 5725.5 5730.5 5746.2 5781.4 5775.7 5776.0 5780.4 5781.2 5789.8 5577.0 5743.8 5761.5 5763.9 5806.1 5674.1 5678.4 5684.1 5702.1 5713.0 4396.5 4401.7 4405.8 4423.1 4429.2 3930.0 3949.6 3960.6 3997.7 3997.8 5313.7 5372.5 5376.0 5376.2 5429.2 5653.1 5655.7 5658.9 5663.6 5695.7 5314.0 5447.8 5479.2 5559.7 5572.1 4956.6 4966.6 4975.7 4977.2 5000.1 5904.4 5964.7 5974.9 5990.3 5990.7 5637.6 5812.7 5871.3 5884.4 5894.1 6010.7 6029.5 6057.3 6057.8 6058.3 5522.1 5681.7 5698.0 5703.2 5725.1 5826.5 5861.9 5879.1 5885.1 5918.3 5644.9 5654.3 5655.2 5657.6 5659.9 5470.3 5528.2 5600.1 5610.0 5618.3 5547.4 5606.2 5607.3 5615.8 5646.2 5699.5 5744.8 5747.5 5747.5 5753.9 5415.0 5554.4 5625.7 5641.7 5662.9 15:25:52 INFO - PROCESS | 3434 | 15:25:52 INFO - PROCESS | 3434 | [#1] ext.html Cycles:180 Average:53719.16 Median:19655.50 stddev:101752.68 (517.7%) stddev-sans-first:101960.12 15:25:52 INFO - PROCESS | 3434 | Values: 653.2 669.1 682.8 744.9 753.3 32584.3 39889.0 40609.4 40648.2 40724.0 43597.6 44041.3 44251.0 44259.3 44295.6 8119.3 8275.1 8707.6 8892.4 10315.6 10286.2 10395.2 10407.1 10407.6 10409.0 10416.8 10499.8 10502.1 10505.0 10505.8 10409.2 10460.1 10460.7 10464.5 10467.2 10450.7 10584.4 10585.8 10886.6 10894.3 42687.4 43144.8 43158.0 43173.8 43197.4 3521.0 3572.7 3655.8 3847.7 4227.8 32503.7 32663.0 32903.3 33876.0 34316.7 4108.5 4150.8 4176.9 4254.9 4357.8 321393.0 321977.0 322930.0 323190.0 323236.0 40099.0 40629.0 40631.0 40652.2 60165.4 37865.6 37985.6 38061.8 38293.6 38341.8 14940.0 16836.9 17041.5 17045.4 17063.5 13847.0 13910.3 13929.8 13992.4 14135.0 9170.6 9243.0 9245.4 9273.2 9307.4 3572.6 3667.9 3681.9 3685.2 3689.1 1063.7 1138.2 1138.2 1202.9 1228.8 33200.8 33201.8 33907.5 34328.0 34534.3 1199.7 1242.6 1274.2 1298.3 1380.5 17461.0 17702.0 17805.7 17894.8 17931.7 470990.0 475707.0 476344.0 477282.0 477440.0 60143.1 61046.0 61089.7 61144.0 61201.0 1383.9 1531.1 1552.2 1552.5 1672.5 30137.2 31663.8 32192.3 32532.7 33563.5 48758.8 49334.8 49402.8 49412.3 49413.3 305128.0 312698.0 312858.0 313717.0 433339.0 30132.4 30526.1 30597.1 30895.7 31023.7 43687.0 44300.8 44361.3 45289.5 46042.1 37215.6 37350.3 37406.4 37552.2 38073.2 35738.3 37050.0 37430.6 39305.8 40024.0 41689.4 41752.8 41811.8 43042.0 43478.8 35154.8 35336.0 36426.6 36688.9 36818.8 28195.6 28280.4 28383.7 28504.6 28579.3 15:25:52 INFO - PROCESS | 3434 | 15:25:52 INFO - PROCESS | 3434 | [#2] jquery.html Cycles:180 Average:30959.96 Median:2480.73 stddev:88982.18 (3586.9%) stddev-sans-first:89202.26 15:25:52 INFO - PROCESS | 3434 | Values: 424.0 431.3 434.1 442.6 460.4 18883.5 19482.5 19519.0 19853.9 20136.6 19297.6 19361.7 20210.7 20257.2 20268.6 5707.2 5773.6 5928.2 5947.8 5950.3 4307.8 5804.9 5829.4 6075.6 6372.3 6329.5 6336.0 6343.9 6368.0 6371.8 6307.4 6334.6 6370.2 6403.5 6549.1 4031.1 4141.1 5505.7 5832.6 5866.2 23326.9 24415.0 25238.5 25324.0 25423.2 2471.4 2490.0 2492.9 2708.9 2845.7 14811.3 15248.3 15621.2 15773.4 15941.0 1834.5 1890.8 1919.1 1978.2 2017.3 82416.0 84539.0 85071.6 85557.6 86246.6 10990.5 11208.7 11439.1 11531.4 11657.7 16463.8 16542.2 16627.8 16630.7 16661.6 8591.5 8699.1 8717.9 8757.4 8768.8 8435.5 8521.9 8535.3 8542.9 8546.9 4908.7 5057.7 5058.8 5099.2 5125.9 1866.1 2009.8 2019.5 2076.8 2113.8 1038.8 1052.0 1089.4 1091.8 1190.3 18701.6 19480.4 19714.8 19838.7 19848.1 1069.4 1116.1 1121.3 1144.4 1174.7 11051.9 11099.8 11145.6 11148.8 11198.4 523601.0 533644.0 534540.0 549164.0 563320.0 91549.0 91715.5 93504.0 95300.5 95353.5 1112.7 1139.1 1184.1 1186.7 1210.0 16928.0 16990.2 17065.0 17273.8 17280.5 40871.4 41457.8 41804.2 42547.0 42603.0 55637.4 59931.0 60015.7 60099.4 60115.0 8831.2 8872.0 8950.5 9014.6 9302.9 9453.9 12762.9 13106.4 13138.5 13587.9 11494.6 11573.7 11739.9 11820.3 12092.2 11458.5 11507.7 11693.9 11805.5 11955.3 11697.9 11774.6 11872.3 11953.0 12079.5 8749.6 8883.6 8972.8 8997.1 9012.4 9004.4 11899.0 11951.8 12006.7 12255.4 15:25:52 INFO - PROCESS | 3434 | 15:25:52 INFO - PROCESS | 3434 | [#3] mootools.html Cycles:180 Average:5689.45 Median:5124.05 stddev:3210.06 (62.6%) stddev-sans-first:3203.00 15:25:52 INFO - PROCESS | 3434 | Values: 1415.8 1573.6 1578.3 1765.8 1905.4 7535.3 8202.5 8305.3 8305.8 8307.3 8373.5 8499.1 8507.9 8516.1 8539.5 2313.5 2326.9 2341.1 2342.4 2350.4 2180.0 2218.7 2220.3 2233.8 2235.3 2293.7 2297.7 2302.9 2340.3 2342.1 2227.9 2302.6 2304.8 2305.4 2309.1 2259.6 2259.7 2263.1 2265.5 2267.0 8300.4 8453.4 8779.2 8789.3 8812.0 5468.5 5515.9 5530.7 5545.3 5583.9 3528.9 3544.2 3581.5 3623.8 3626.8 1113.7 1129.4 1157.2 1167.1 1209.1 11947.5 12304.4 12311.1 12318.9 12332.5 4599.4 4673.4 4744.0 4781.5 4803.4 9831.7 9850.4 9861.8 9917.6 9939.3 5501.6 5505.5 5511.0 5513.4 5513.8 4353.9 4817.5 4956.9 4997.8 5107.1 3852.7 3863.6 3974.1 3976.8 4013.2 1179.4 1182.4 1205.4 1208.1 1217.9 886.9 972.9 1030.3 1042.8 1051.9 5856.7 5876.3 5930.0 5996.5 6073.3 476.1 479.4 479.6 486.3 487.5 3820.3 3915.9 3937.9 3939.1 3997.8 10498.4 10879.6 10885.1 10913.1 10941.9 10746.1 10748.2 10771.8 10773.7 10775.8 8187.5 8290.5 8366.9 8373.6 8382.7 5592.5 5639.1 5642.8 5701.9 5743.2 9548.2 9569.3 9682.7 9767.2 9775.9 9602.5 9691.0 9695.3 9890.7 9917.4 6537.7 6753.9 7112.7 7420.0 7475.6 8348.4 8400.2 8419.1 8439.8 8455.7 7025.9 7082.2 7122.6 7273.5 7305.8 7458.3 7484.4 7516.1 7549.0 7622.0 6964.0 7082.2 7149.6 7151.7 7180.0 4996.7 5122.9 5153.9 5183.0 5215.1 5027.9 5125.2 5192.6 5225.3 5230.6 15:25:52 INFO - PROCESS | 3434 | 15:25:52 INFO - PROCESS | 3434 | [#4] prototype.html Cycles:180 Average:5559.18 Median:6314.09 stddev:1674.77 (26.5%) stddev-sans-first:1633.46 15:25:52 INFO - PROCESS | 3434 | Values: 364.8 366.9 369.1 373.8 375.9 6014.2 6195.2 6285.9 6292.9 6310.8 6182.3 6238.1 6284.6 6288.1 6305.7 4821.2 4865.7 4871.2 4874.8 4876.9 4620.8 4719.4 4829.8 4872.5 4875.4 4813.4 4819.8 4832.3 4833.5 4837.3 4797.4 4816.6 4820.5 4829.6 4837.8 4275.8 4279.7 4281.7 4287.4 4288.6 6000.3 6000.4 6012.3 6013.1 6021.2 5337.3 5603.4 5606.9 5607.5 5610.5 6519.4 6549.4 6569.5 6571.9 6577.1 4583.0 4589.6 4591.0 4597.5 4604.9 6798.4 6877.9 6890.6 6894.2 6896.2 4701.9 4703.4 4708.2 4709.0 4710.2 4657.5 4768.4 4775.3 4776.0 4776.8 5452.3 5481.5 5485.2 5491.1 5498.1 6593.0 6613.0 6620.4 6625.8 6648.4 1583.8 1638.3 1673.3 1673.7 1674.2 1096.2 1113.1 1114.7 1116.6 1119.3 6302.2 6322.1 6323.4 6323.5 6342.4 6680.4 6682.9 6683.9 6687.7 6691.8 6317.4 6322.7 6323.1 6323.7 6326.3 3621.7 3654.5 3657.6 3659.4 3664.7 6983.7 7079.5 7216.3 7280.7 7282.6 7001.8 7015.2 7015.3 7020.1 7022.6 7230.5 7239.0 7249.6 7256.1 7256.7 6875.6 6888.6 6893.7 6893.7 6908.8 6599.1 6774.2 6785.6 6791.6 6797.4 7196.9 7215.9 7219.8 7227.0 7237.1 4692.2 4733.9 4736.2 4737.4 4740.4 6513.6 6735.7 6859.7 6860.2 6874.9 6642.6 6655.1 6661.3 6663.8 6665.1 6589.5 6654.2 6661.3 6668.4 6676.1 6479.0 6484.8 6490.2 6491.3 6500.4 6588.0 6667.1 6698.1 6713.4 6735.1 6533.9 6553.5 6556.7 6559.0 6564.1 15:25:52 INFO - PROCESS | 3434 | 15:25:52 INFO - PROCESS | 3434 | [#5] yui.html Cycles:180 Average:15715.25 Median:26528.37 stddev:18234.56 (68.7%) stddev-sans-first:18251.73 15:25:52 INFO - PROCESS | 3434 | Values: 890.9 921.2 931.9 936.5 938.5 14374.8 14572.7 14580.8 14591.0 14598.1 14177.7 14196.5 14287.3 14289.5 14344.9 901.2 910.2 916.0 916.1 916.8 744.4 881.8 904.2 908.2 908.3 949.9 950.8 955.1 955.9 958.0 771.8 948.5 951.4 951.6 952.7 695.3 701.7 704.0 705.4 707.1 14524.6 14568.8 14612.1 14623.5 14646.6 13970.7 14622.3 14851.2 15182.9 15214.9 11499.9 11746.4 11869.8 12241.4 12289.8 3947.9 4010.8 4028.5 4050.3 4076.7 54114.7 54176.2 54708.7 54958.7 55020.2 10784.7 11085.1 11329.8 11477.5 11580.5 21046.7 21081.3 21106.7 21221.3 21223.4 7962.6 8289.3 8600.6 8754.0 8754.3 4973.5 4989.3 5015.7 5016.6 5130.4 3742.2 3781.5 3801.9 3806.4 3808.4 658.5 667.2 725.3 750.2 757.6 664.4 713.6 767.4 809.2 827.7 8972.2 9448.4 9538.2 9545.5 9644.7 780.2 843.4 843.7 849.0 854.1 4543.0 4575.5 4611.9 4630.7 4657.8 69015.3 69648.3 69664.3 69893.0 69985.0 56182.7 56350.5 57593.0 57618.1 59810.7 50447.2 51524.2 51627.0 52574.2 53171.5 8679.9 8817.5 8924.6 9069.2 9152.3 36765.8 37672.6 38556.6 38556.8 38674.0 46598.5 47964.3 48083.3 51846.7 52731.5 12596.7 12797.3 12825.4 13203.7 13514.6 14577.5 14605.1 14685.9 14912.3 15508.8 13635.7 13718.2 13764.2 13778.9 14258.6 12751.4 13527.7 13697.2 13760.3 14411.5 12146.8 12598.4 12753.8 12811.3 13090.3 9428.2 9620.4 11384.7 11778.8 11800.1 11308.4 11454.6 11457.1 11631.5 11751.8 15:25:52 INFO - PROCESS | 3434 | -------- Summary: end -------- 15:25:52 INFO - PROCESS | 3434 | 15:25:52 INFO - TEST-INFO | 3434: exit 0 15:25:52 INFO - TEST-OK | dromaeo_css | took 1110711ms 15:25:52 INFO - TEST-START | kraken 15:25:52 INFO - operating with platform_type : linux_ 15:25:52 INFO - Initialising browser for kraken test... 15:25:52 INFO - TEST-INFO | started process 3628 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxSSvMp/profile http://localhost:35180/getInfo.html) 15:25:56 INFO - PROCESS | 3628 | __metrics Screen width/height:1600/1200 15:25:56 INFO - PROCESS | 3628 | colorDepth:24 15:25:56 INFO - PROCESS | 3628 | Browser inner width/height: 1024/697 15:25:56 INFO - PROCESS | 3628 | __metrics 15:25:57 ERROR - PROCESS | 3628 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 15:25:58 INFO - TEST-INFO | 3628: exit 0 15:25:58 INFO - Browser initialized. 15:25:58 INFO - Running cycle 1/1 for kraken test... 15:25:58 INFO - TEST-INFO | started process 3719 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxSSvMp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:26:10 INFO - PROCESS | 3719 | RSS: Main: 139218944 15:26:10 INFO - PROCESS | 3719 | 15:26:12 INFO - PROCESS | 3719 | Cycle 1(1): loaded http://localhost:35180/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35180/tests/kraken/driver.html?testName=audio-beat-detection) 15:26:13 INFO - PROCESS | 3719 | RSS: Main: 197435392 15:26:13 INFO - PROCESS | 3719 | 15:26:16 INFO - PROCESS | 3719 | Cycle 1(1): loaded http://localhost:35180/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35180/tests/kraken/driver.html?testName=audio-dft) 15:26:16 INFO - PROCESS | 3719 | RSS: Main: 183992320 15:26:16 INFO - PROCESS | 3719 | 15:26:19 INFO - PROCESS | 3719 | Cycle 1(1): loaded http://localhost:35180/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35180/tests/kraken/driver.html?testName=audio-fft) 15:26:20 INFO - PROCESS | 3719 | RSS: Main: 273645568 15:26:20 INFO - PROCESS | 3719 | 15:26:22 INFO - PROCESS | 3719 | Cycle 1(1): loaded http://localhost:35180/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35180/tests/kraken/driver.html?testName=audio-oscillator) 15:26:22 INFO - PROCESS | 3719 | RSS: Main: 179257344 15:26:22 INFO - PROCESS | 3719 | 15:26:24 INFO - PROCESS | 3719 | Cycle 1(1): loaded http://localhost:35180/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35180/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:26:25 INFO - PROCESS | 3719 | RSS: Main: 177709056 15:26:25 INFO - PROCESS | 3719 | 15:26:28 INFO - PROCESS | 3719 | Cycle 1(1): loaded http://localhost:35180/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35180/tests/kraken/driver.html?testName=imaging-darkroom) 15:26:29 INFO - PROCESS | 3719 | RSS: Main: 213061632 15:26:29 INFO - PROCESS | 3719 | 15:26:32 INFO - PROCESS | 3719 | Cycle 1(1): loaded http://localhost:35180/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35180/tests/kraken/driver.html?testName=imaging-desaturate) 15:26:33 INFO - PROCESS | 3719 | RSS: Main: 212643840 15:26:33 INFO - PROCESS | 3719 | 15:26:35 INFO - PROCESS | 3719 | Cycle 1(1): loaded http://localhost:35180/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35180/tests/kraken/driver.html?testName=json-parse-financial) 15:26:36 INFO - PROCESS | 3719 | RSS: Main: 212377600 15:26:36 INFO - PROCESS | 3719 | 15:26:37 INFO - PROCESS | 3719 | Cycle 1(1): loaded http://localhost:35180/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35180/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:26:38 INFO - PROCESS | 3719 | RSS: Main: 196780032 15:26:38 INFO - PROCESS | 3719 | 15:26:40 INFO - PROCESS | 3719 | Cycle 1(1): loaded http://localhost:35180/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35180/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:26:40 INFO - PROCESS | 3719 | RSS: Main: 199237632 15:26:40 INFO - PROCESS | 3719 | 15:26:42 INFO - PROCESS | 3719 | Cycle 1(1): loaded http://localhost:35180/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35180/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:26:43 INFO - PROCESS | 3719 | RSS: Main: 210042880 15:26:43 INFO - PROCESS | 3719 | 15:26:45 INFO - PROCESS | 3719 | Cycle 1(1): loaded http://localhost:35180/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35180/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:26:46 INFO - PROCESS | 3719 | RSS: Main: 217649152 15:26:46 INFO - PROCESS | 3719 | 15:26:49 INFO - PROCESS | 3719 | Cycle 1(1): loaded http://localhost:35180/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35180/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:26:49 INFO - PROCESS | 3719 | RSS: Main: 212398080 15:26:49 INFO - PROCESS | 3719 | 15:26:51 INFO - PROCESS | 3719 | Cycle 1(1): loaded http://localhost:35180/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35180/tests/kraken/driver.html?testName=ai-astar) 15:26:51 INFO - PROCESS | 3719 | RSS: Main: 273096704 15:26:51 INFO - PROCESS | 3719 | 15:26:51 INFO - PROCESS | 3719 | __start_tp_report 15:26:51 INFO - PROCESS | 3719 | _x_x_mozilla_page_load 15:26:51 INFO - PROCESS | 3719 | _x_x_mozilla_page_load_details 15:26:51 INFO - PROCESS | 3719 | |i|pagename|runs| 15:26:51 INFO - PROCESS | 3719 | |0;ai-astar;109;109;110;110;108;111;105;110;110;109 15:26:51 INFO - PROCESS | 3719 | |1;audio-beat-detection;163;129;158;185;126;152;161;130;177;126 15:26:51 INFO - PROCESS | 3719 | |2;audio-dft;162;162;163;160;161;162;161;161;161;160 15:26:51 INFO - PROCESS | 3719 | |3;audio-fft;75;76;76;181;73;75;77;73;171;75 15:26:51 INFO - PROCESS | 3719 | |4;audio-oscillator;91;92;148;95;93;91;152;91;92;147 15:26:51 INFO - PROCESS | 3719 | |5;imaging-gaussian-blur;116;117;116;117;117;117;117;117;117;117 15:26:51 INFO - PROCESS | 3719 | |6;imaging-darkroom;146;145;146;146;147;146;145;146;146;144 15:26:51 INFO - PROCESS | 3719 | |7;imaging-desaturate;95;94;95;95;95;94;95;95;95;95 15:26:51 INFO - PROCESS | 3719 | |8;json-parse-financial;54;64;53;54;55;53;55;73;53;52 15:26:51 INFO - PROCESS | 3719 | |9;json-stringify-tinderbox;56;57;57;57;56;57;57;57;57;57 15:26:51 INFO - PROCESS | 3719 | |10;stanford-crypto-aes;73;72;72;72;72;72;74;74;73;72 15:26:51 INFO - PROCESS | 3719 | |11;stanford-crypto-ccm;115;124;118;113;109;112;110;113;139;115 15:26:51 INFO - PROCESS | 3719 | |12;stanford-crypto-pbkdf2;158;156;156;161;158;160;157;156;157;157 15:26:51 INFO - PROCESS | 3719 | |13;stanford-crypto-sha256-iterative;67;67;67;66;63;77;65;65;65;67 15:26:51 INFO - PROCESS | 3719 | __end_tp_report 15:26:51 INFO - PROCESS | 3719 | __start_cc_report 15:26:51 INFO - PROCESS | 3719 | _x_x_mozilla_cycle_collect,1606 15:26:51 INFO - PROCESS | 3719 | __end_cc_report 15:26:51 INFO - PROCESS | 3719 | __startTimestamp1467757611594__endTimestamp 15:26:51 INFO - PROCESS | 3719 | 15:26:51 INFO - PROCESS | 3719 | ------- Summary: start ------- 15:26:51 INFO - PROCESS | 3719 | Number of tests: 14 15:26:51 INFO - PROCESS | 3719 | 15:26:51 INFO - PROCESS | 3719 | [#0] ai-astar Cycles:10 Average:109.10 Median:110.00 stddev:1.66 (1.5%) stddev-sans-first:1.76 15:26:51 INFO - PROCESS | 3719 | Values: 109.0 109.0 110.0 110.0 108.0 111.0 105.0 110.0 110.0 109.0 15:26:51 INFO - PROCESS | 3719 | 15:26:51 INFO - PROCESS | 3719 | [#1] audio-beat-detection Cycles:10 Average:150.70 Median:159.50 stddev:21.86 (13.7%) stddev-sans-first:22.73 15:26:51 INFO - PROCESS | 3719 | Values: 163.0 129.0 158.0 185.0 126.0 152.0 161.0 130.0 177.0 126.0 15:26:51 INFO - PROCESS | 3719 | 15:26:51 INFO - PROCESS | 3719 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.50 stddev:0.95 (0.6%) stddev-sans-first:0.97 15:26:51 INFO - PROCESS | 3719 | Values: 162.0 162.0 163.0 160.0 161.0 162.0 161.0 161.0 161.0 160.0 15:26:51 INFO - PROCESS | 3719 | 15:26:51 INFO - PROCESS | 3719 | [#3] audio-fft Cycles:10 Average:95.20 Median:75.00 stddev:42.67 (56.9%) stddev-sans-first:44.63 15:26:51 INFO - PROCESS | 3719 | Values: 75.0 76.0 76.0 181.0 73.0 75.0 77.0 73.0 171.0 75.0 15:26:51 INFO - PROCESS | 3719 | 15:26:51 INFO - PROCESS | 3719 | [#4] audio-oscillator Cycles:10 Average:109.20 Median:91.50 stddev:27.52 (30.1%) stddev-sans-first:28.39 15:26:51 INFO - PROCESS | 3719 | Values: 91.0 92.0 148.0 95.0 93.0 91.0 152.0 91.0 92.0 147.0 15:26:51 INFO - PROCESS | 3719 | 15:26:51 INFO - PROCESS | 3719 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 15:26:51 INFO - PROCESS | 3719 | Values: 116.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 15:26:51 INFO - PROCESS | 3719 | 15:26:51 INFO - PROCESS | 3719 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 15:26:51 INFO - PROCESS | 3719 | Values: 146.0 145.0 146.0 146.0 147.0 146.0 145.0 146.0 146.0 144.0 15:26:51 INFO - PROCESS | 3719 | 15:26:51 INFO - PROCESS | 3719 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 15:26:51 INFO - PROCESS | 3719 | Values: 95.0 94.0 95.0 95.0 95.0 94.0 95.0 95.0 95.0 95.0 15:26:51 INFO - PROCESS | 3719 | 15:26:51 INFO - PROCESS | 3719 | [#8] json-parse-financial Cycles:10 Average:56.60 Median:54.50 stddev:6.69 (12.3%) stddev-sans-first:7.03 15:26:51 INFO - PROCESS | 3719 | Values: 54.0 64.0 53.0 54.0 55.0 53.0 55.0 73.0 53.0 52.0 15:26:51 INFO - PROCESS | 3719 | 15:26:51 INFO - PROCESS | 3719 | [#9] json-stringify-tinderbox Cycles:10 Average:56.80 Median:57.00 stddev:0.42 (0.7%) stddev-sans-first:0.33 15:26:51 INFO - PROCESS | 3719 | Values: 56.0 57.0 57.0 57.0 56.0 57.0 57.0 57.0 57.0 57.0 15:26:51 INFO - PROCESS | 3719 | 15:26:51 INFO - PROCESS | 3719 | [#10] stanford-crypto-aes Cycles:10 Average:72.60 Median:72.50 stddev:0.84 (1.2%) stddev-sans-first:0.88 15:26:51 INFO - PROCESS | 3719 | Values: 73.0 72.0 72.0 72.0 72.0 72.0 74.0 74.0 73.0 72.0 15:26:51 INFO - PROCESS | 3719 | 15:26:51 INFO - PROCESS | 3719 | [#11] stanford-crypto-ccm Cycles:10 Average:116.80 Median:115.00 stddev:8.89 (7.7%) stddev-sans-first:9.41 15:26:51 INFO - PROCESS | 3719 | Values: 115.0 124.0 118.0 113.0 109.0 112.0 110.0 113.0 139.0 115.0 15:26:51 INFO - PROCESS | 3719 | 15:26:51 INFO - PROCESS | 3719 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.60 Median:157.50 stddev:1.71 (1.1%) stddev-sans-first:1.81 15:26:51 INFO - PROCESS | 3719 | Values: 158.0 156.0 156.0 161.0 158.0 160.0 157.0 156.0 157.0 157.0 15:26:51 INFO - PROCESS | 3719 | 15:26:51 INFO - PROCESS | 3719 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:67.00 stddev:3.78 (5.6%) stddev-sans-first:4.01 15:26:51 INFO - PROCESS | 3719 | Values: 67.0 67.0 67.0 66.0 63.0 77.0 65.0 65.0 65.0 67.0 15:26:51 INFO - PROCESS | 3719 | -------- Summary: end -------- 15:26:51 INFO - PROCESS | 3719 | 15:26:52 INFO - TEST-INFO | 3719: exit 0 15:26:52 INFO - TEST-OK | kraken | took 59833ms 15:26:52 INFO - SUITE-END | took 1170s 15:26:52 INFO - Completed test suite (00:19:30) 15:26:52 INFO - javascript benchmark 15:26:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3183.5224716292555, 3225.193701574606, 3242.38394705006, 3266.7713260071773, 3274.296026354335, 5342.038433082043, 5342.599305052122, 5345.6792592444435, 5353.036453438384, 5353.277307563478, 5384.6499977501435, 5395.514403703666, 5403.648762830413, 5412.783488660449, 5424.783008679648, 4906.435759887614, 4908.190148625473, 4978.178600530926, 5031.471695471978, 5048.343715317003, 4904.117258893398, 4968.925466118011, 5009.924851127236, 5015.3730783652045, 5015.39815222172, 4927.6550641455115, 4991.600671946254, 5008.223725322581, 5019.573336266421, 5041.344625198737, 4898.14282500561, 4911.607071434277, 4926.507349265081, 4929.9893521827935, 4967.801287948496, 4838.733869637169, 4872.317875497433, 4920.6309526785635, 4922.532359425849, 4991.875203119915, 5366.785328586851, 5380.219868119101, 5410.053240682865, 5425.240466334716, 5429.8099566515375, 5816.854578635525, 5830.4461076197695, 5832.62087964281, 5837.824865254049, 5838.2702162229725, 5759.568032397545, 5774.884502309972, 5830.096335068071, 5834.4165583441745, 5874.588778785486, 5335.893282134374, 5342.171963345688, 5386.48828361305, 5387.4073851876265, 5387.730613469272, 5693.772249109989, 5805.564582656318, 5815.0, 5820.1560773688425, 5823.912641310384, 5682.602217844711, 5725.5133313667975, 5730.512906402919, 5746.224259724967, 5781.364049954502, 5775.653460792366, 5776.018076926933, 5780.421957804186, 5781.219535362672, 5789.8263052108505, 5577.024020796344, 5743.770249190069, 5761.5102716269585, 5763.8559036024435, 5806.071028635482, 5674.06377947634, 5678.375378708339, 5684.147377893349, 5702.116171993348, 5712.971435142797, 4396.472423309159, 4401.735895846259, 4405.801738921757, 4423.1153769246275, 4429.180601588717, 3930.0174956260935, 3949.644531992077, 3960.5643379228263, 3997.6801855851463, 3997.8001099944886, 5313.654612450178, 5372.516473517402, 5376.0, 5376.193570964387, 5429.185622156708, 5653.067243904792, 5655.745491452894, 5658.927109744661, 5663.603547751618, 5695.715214239354, 5313.973430132902, 5447.836564903059, 5479.232907392969, 5559.749811258503, 5572.080606699849, 4956.603471722254, 4966.577840883493, 4975.726335051607, 4977.1538838397555, 5000.099982003201, 5904.350521442638, 5964.7315870785915, 5974.880502389928, 5990.251218597676, 5990.73041713124, 5637.577181711306, 5812.709364531841, 5871.295444546682, 5884.411558844081, 5894.115882617642, 6010.699465026819, 6029.457348838626, 6057.303410107717, 6057.7879774207695, 6058.303295121117, 5522.116461366162, 5681.744321505625, 5697.971510142423, 5703.230063941315, 5725.112607545837, 5826.475617194473, 5861.912071318849, 5879.147523609138, 5885.058390657474, 5918.2898052234, 5644.9435505644415, 5654.264945557051, 5655.151727240782, 5657.575681823797, 5659.915101273402, 5470.316210473691, 5528.198411230269, 5600.103983362643, 5609.971950140386, 5618.297712785902, 5547.362053363915, 5606.159076138449, 5607.271054762855, 5615.831525054255, 5646.237757902795, 5699.51554117888, 5744.827655170351, 5747.511461525817, 5747.511461525817, 5753.9136912945505, 5414.972925135349, 5554.416786237387, 5625.718714064362, 5641.746121424628, 5662.943370566241], "value": 5334.665227295508, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [653.1998302079953, 669.1401549009527, 682.7542084849454, 744.9068866391701, 753.2730914667345, 32584.348313033755, 39889.0, 40609.39085913714, 40648.18703625926, 40723.98190045247, 43597.564024359745, 44041.339379909325, 44251.0, 44259.33610995838, 44295.557044429544, 8119.309858662021, 8275.131111233324, 8707.608157632922, 8892.377533572653, 10315.587376504931, 10286.177105831515, 10395.168386529098, 10407.063364297212, 10407.583696652126, 10409.0, 10416.843747343795, 10499.790004199911, 10502.107320877696, 10505.0, 10505.789884202311, 10409.16726661869, 10460.058594726435, 10460.68617941463, 10464.476776161238, 10467.16262698986, 10450.738731531697, 10584.364938103738, 10585.84121238182, 10886.61896833607, 10894.291871028357, 42687.35968960468, 43144.78427607873, 43158.0, 43173.78413107946, 43197.35203971943, 3520.9647903520895, 3572.732045096628, 3655.780653160819, 3847.71142164336, 4227.767472788995, 32503.6749632503, 32663.0, 32903.34193316144, 33876.0, 34316.656833431596, 4108.465899433085, 4150.792460376999, 4176.895577610554, 4254.91490170198, 4357.760323182224, 321393.0, 321977.0, 322930.0, 323190.0, 323236.0, 40099.0, 40629.0, 40631.0, 40652.18695626071, 60165.39834601685, 37865.62134378676, 37985.62014379821, 38061.80969095137, 38293.617063829006, 38341.80829095837, 14940.0, 16836.915815420845, 17041.48875533736, 17045.40341088056, 17063.48809535716, 13847.0, 13910.304484775923, 13929.791053134211, 13992.440302387995, 14135.0, 9170.587323570455, 9243.0, 9245.352825302165, 9273.211776998896, 9307.441553506811, 3572.624874388204, 3667.9083022924106, 3681.889543313705, 3685.1892583631557, 3689.0777305673582, 1063.707480442869, 1138.1805100327915, 1138.2203190814319, 1202.915795894279, 1228.846394200725, 33200.83399582987, 33201.83399082989, 33907.49138762871, 34328.0, 34534.27196738446, 1199.676087456382, 1242.589945318061, 1274.1972557288848, 1298.2859427314938, 1380.496118916588, 17461.0, 17702.026388548755, 17805.7329140063, 17894.821051789575, 17931.73102403465, 470990.0, 475707.0, 476344.0, 477282.0, 477440.0, 60143.097853532236, 61046.0, 61089.69455152785, 61144.0, 61201.0, 1383.8616138386283, 1531.0890020438044, 1552.1851028210053, 1552.534239728077, 1672.4898905833838, 30137.246568835955, 31663.841680791447, 32192.263657589367, 32532.67467325391, 33563.49654755229, 48758.75620621874, 49334.75332623314, 49402.75298623484, 49412.258816118505, 49413.25880111729, 305128.0, 312698.0, 312858.0, 313717.0, 433339.0, 30132.397352052398, 30526.08421747351, 30597.08208753741, 30895.691043089282, 31023.68976310208, 43687.0, 44300.77849610731, 44361.33457998068, 45289.54710452853, 46042.07915841731, 37215.62784372122, 37350.31923563392, 37406.438903415925, 37552.2489550202, 38073.23853522969, 35738.262565402394, 37050.0, 37430.6256937438, 39305.803470982464, 40024.0, 41689.37465938074, 41752.79123604484, 41811.7909410451, 43042.0, 43478.78260608677, 35154.82422587871, 35336.04481926701, 36426.635733642324, 36688.899333020054, 36818.815905920295, 28195.57706634443, 28280.434391311646, 28383.716162838933, 28504.57243141396, 28579.28551786222], "value": 19385.43548911385, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [423.99581865874694, 431.3292829649895, 434.07975092803264, 442.634120625258, 460.44746304434665, 18883.52791180221, 19482.51293717656, 19519.0, 19853.908035058066, 20136.59726805463, 19297.61404771904, 19361.709574356362, 20210.69683954738, 20257.189712411524, 20268.59462810743, 5707.172459993288, 5773.595848290622, 5928.199693041449, 5947.791827286046, 5950.256217972732, 4307.806148723299, 5804.854878628026, 5829.358770535237, 6075.63546187228, 6372.299047104815, 6329.4619957303685, 6335.968320158416, 6343.873122537547, 6367.968160159193, 6371.8407039823915, 6307.432331090201, 6334.556581039329, 6370.235571731376, 6403.5197360197935, 6549.083128362033, 4031.093004074089, 4141.088960428731, 5505.6696598204235, 5832.620879642852, 5866.178734977107, 23326.883365583235, 24415.0, 25238.495230095294, 25324.0, 25423.23730288094, 2471.4439251168524, 2490.0164435048237, 2492.8753562321813, 2708.9051883183993, 2845.672747634028, 14811.259437028106, 15248.31382587775, 15621.218939053002, 15773.447929322534, 15941.0, 1834.5230240137528, 1890.8203720646516, 1919.0500702152385, 1978.169168949045, 2017.2939471185114, 82416.0, 84539.0, 85071.57464212702, 85557.57221213855, 86246.56876715577, 10990.505427255792, 11208.66374008781, 11439.084873210124, 11531.423428828693, 11657.650270491898, 16463.753043704353, 16542.172891355385, 16627.83372166287, 16630.6673866522, 16661.583460413345, 8591.484510929364, 8699.086595907338, 8717.91282087171, 8757.386982911263, 8768.824623507622, 8435.536045517432, 8521.914780852112, 8535.274501667303, 8542.871856922151, 8546.914530854736, 4908.730019848943, 5057.747112644353, 5058.772355244023, 5099.209622508443, 5125.948740512622, 1866.1322485044248, 2009.849261305408, 2019.4951262184454, 2076.8338532917332, 2113.7991890770354, 1038.7818558102883, 1052.0426411965075, 1089.3953855610212, 1091.770728147082, 1190.3215167354697, 18701.620600566544, 19480.415587532396, 19714.802851971297, 19838.70241946372, 19848.10683519245, 1069.4226016625416, 1116.0848104554188, 1121.3384103379046, 1144.4392247798685, 1174.682835634374, 11051.889481105247, 11099.83350249747, 11145.554177832959, 11148.832767508495, 11198.38408887519, 523601.0, 533644.0, 534540.0, 549164.0, 563320.0, 91549.0, 91715.54142229246, 93504.0, 95300.52349738206, 95353.52323238339, 1112.710695219249, 1139.0773473486668, 1184.1237484261756, 1186.6832203989698, 1209.9758004839855, 16927.984320940785, 16990.23543940501, 17065.0, 17273.790834641455, 17280.481585552454, 40871.38692919549, 41457.79271103625, 41804.163916720885, 42547.0, 42603.0, 55637.44362556485, 59931.0, 60015.69992150011, 60099.39900600938, 60115.0, 8831.249343805848, 8871.955640221757, 8950.507722075348, 9014.639414423613, 9302.860457093013, 9453.905460945303, 12762.872371276168, 13106.410211540695, 13138.540151094665, 13587.86412135866, 11494.597689080842, 11573.652790416301, 11739.882601173878, 11820.290782553075, 12092.214006089927, 11458.484368203617, 11507.712307192387, 11693.88306116962, 11805.468753905923, 11955.342456164994, 11697.941510292394, 11774.587889423829, 11872.347020913587, 11953.0, 12079.51681932713, 8749.606267717842, 8883.555822208993, 8972.820543589221, 8997.145271199226, 9012.369134160808, 9004.414713043894, 11899.0, 11951.76096478083, 12006.699832504257, 12255.387230638611], "value": 9702.655180144398, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1415.787631855221, 1573.606598350412, 1578.3292100857136, 1765.7704498415212, 1905.4093231098352, 7535.321821036106, 8202.507849529033, 8305.294050005758, 8305.750827475178, 8307.29388002019, 8373.539455329954, 8499.107593702665, 8507.872381914261, 8516.06323304436, 8539.530325832076, 2313.5488579726916, 2326.8603883766946, 2341.098677009355, 2342.390978345634, 2350.4476448034698, 2180.0, 2218.689383486313, 2220.289507357646, 2233.8101261392803, 2235.3405745305095, 2293.747687754346, 2297.701298831158, 2302.9078836846506, 2340.309608665439, 2342.0865862313713, 2227.9220227291967, 2302.5970455170363, 2304.83866129371, 2305.3775480620307, 2309.1225334372916, 2259.5819773341987, 2259.728832540089, 2263.1400067974064, 2265.490264690448, 2267.047839907243, 8300.418970672055, 8453.365997550147, 8779.20987111163, 8789.340799440004, 8811.955940220321, 5468.507834294933, 5515.944840551583, 5530.695811730353, 5545.306836645419, 5583.8883222335735, 3528.9294214115575, 3544.1848374873925, 3581.5164952731307, 3623.7644553103964, 3626.8367923443507, 1113.6881673131536, 1129.4409267412602, 1157.195748954477, 1167.1479819731558, 1209.0871392098998, 11947.462364193632, 12304.384780761016, 12311.076669249842, 12318.938405308007, 12332.506699732, 4599.425071866017, 4673.439187297546, 4744.027474367746, 4781.52184781526, 4803.351547541107, 9831.655892043744, 9850.359726617748, 9861.802763944681, 9917.603295868228, 9939.304248702667, 5501.614886957875, 5505.476979686923, 5511.0, 5513.421090785409, 5513.751881165357, 4353.9129217415475, 4817.470078291385, 4956.8760780980765, 4997.7755449915, 5107.055194788976, 3852.7110466715108, 3863.61363863617, 3974.145558704892, 3976.8011599419915, 4013.1572369802084, 1179.3690375648987, 1182.355616189179, 1205.4153735438306, 1208.0577149823152, 1217.8964787992943, 886.9334799890034, 972.9346365729515, 1030.3229207069103, 1042.781015986636, 1051.8895515970867, 5856.677882716406, 5876.294844618673, 5930.0, 5996.4603185713495, 6073.271207455134, 476.138189876325, 479.39356713757127, 479.6210993315242, 486.32643788353386, 487.4783981140146, 3820.2932457495453, 3915.9216815663526, 3937.92124157521, 3939.0546268895832, 3997.8001099944886, 10498.370097794004, 10879.564817407216, 10885.074768644754, 10913.126949843994, 10941.945290273658, 10746.140308775279, 10748.193885458622, 10771.78456430867, 10773.730656733644, 10775.83836242457, 8187.4678145920325, 8290.544020078833, 8366.874496882552, 8373.62318695648, 8382.748517544484, 5592.524635406036, 5639.125935480007, 5642.774289028393, 5701.914471282851, 5743.167240749985, 9548.236141108833, 9569.28230382738, 9682.70951871445, 9767.169790567881, 9775.902240977499, 9602.519874006412, 9691.0, 9695.321327507007, 9890.703278901645, 9917.355371900803, 6537.738490460329, 6753.932460675527, 7112.715491380287, 7419.962900185465, 7475.626218688935, 8348.415610907177, 8400.201980811813, 8419.115992820665, 8439.831203375776, 8455.704050358208, 7025.894611580932, 7082.185548661764, 7122.5726456412785, 7273.527220730635, 7305.780826575211, 7458.254174582498, 7484.363829074589, 7516.060492438445, 7549.01862757838, 7622.0, 6964.0, 7082.220955694766, 7149.60677162761, 7151.678174482265, 7180.0, 4996.700857776931, 5122.871928201825, 5153.922691159561, 5182.97408512955, 5215.113430716711, 5027.924581131213, 5125.231215317583, 5192.610554208525, 5225.268462415341, 5230.607704422107], "value": 4508.896179154793, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [364.8303538854434, 366.89910274674463, 369.0644216910133, 373.7570579123571, 375.87220345082665, 6014.1580178775, 6195.194624698783, 6285.874282514353, 6292.8741425171465, 6310.7791227307, 6182.2581290245125, 6238.095476155955, 6284.591501552396, 6288.088227207052, 6305.716242769075, 4821.180399332122, 4865.68373055752, 4871.196252618313, 4874.805007799701, 4876.902461950759, 4620.792064357095, 4719.433667959833, 4829.782659780319, 4872.537108974641, 4875.366202393684, 4813.3983252093485, 4819.807207711688, 4832.347633069543, 4833.516648335173, 4837.346958160639, 4797.424309082898, 4816.590589799889, 4820.517948205186, 4829.589484893788, 4837.8306759263605, 4275.764832934187, 4279.657627389802, 4281.678874084425, 4287.356896465524, 4288.592583704543, 6000.279966404016, 6000.399960004008, 6012.278526576839, 6013.128096426038, 6021.157038014681, 5337.2527846101575, 5603.3836278009385, 5606.943930560683, 5607.495325420732, 5610.49505544503, 6519.4132528072705, 6549.443297319734, 6569.474442044625, 6571.934280657228, 6577.079208910756, 4583.03756211196, 4589.632829373642, 4590.977045114753, 4597.517260687613, 4604.861854144381, 6798.354156355188, 6877.931220687829, 6890.621015844126, 6894.207166175904, 6896.172459304866, 4701.882452938704, 4703.412073490814, 4708.152532544106, 4708.95291047092, 4710.199266124767, 4657.534246575383, 4768.403949506312, 4775.307580400822, 4776.020915712271, 4776.785044672998, 5452.345718513724, 5481.5340696041285, 5485.232067510552, 5491.066518691832, 5498.120300751861, 6593.0, 6612.966935165294, 6620.404163625297, 6625.768098116543, 6648.368405001517, 1583.754518049704, 1638.3037209186048, 1673.3473945161154, 1673.707101257275, 1674.2131198336763, 1096.2216826053432, 1113.1150735165563, 1114.7101753543975, 1116.6482557994207, 1119.322809700136, 6302.243730752339, 6322.0516922462, 6323.430891219812, 6323.494120470351, 6342.429181373606, 6680.432163266177, 6682.899756503656, 6683.866322673519, 6687.665616719145, 6691.76578819739, 6317.399847014526, 6322.71547780351, 6323.146375239376, 6323.683815809191, 6326.323524266073, 3621.6740493355724, 3654.543182102237, 3657.561092668897, 3659.3779057560278, 3664.6885014774043, 6983.650817459106, 7079.469039822034, 7216.278372162847, 7280.708771649075, 7282.563046217244, 7001.824954376181, 7015.158181018311, 7015.298470153046, 7020.122484689414, 7022.578645281299, 7230.457715671346, 7238.963805180941, 7249.565026098451, 7256.0567126273245, 7256.746013889594, 6875.621840798804, 6888.586684798928, 6893.689783959633, 6893.724251029903, 6908.827279318058, 6599.142111525471, 6774.153230846145, 6785.626790526569, 6791.592504449749, 6797.422219111431, 7196.928030719835, 7215.855682886207, 7219.783406497813, 7227.0, 7237.059182306267, 4692.155412025868, 4733.905321893474, 4736.194846876108, 4737.407824021997, 4740.431148262231, 6513.576617519846, 6735.6968936397, 6859.725610975505, 6860.176778786577, 6874.862502749817, 6642.634655094016, 6655.101561289358, 6661.3338666132995, 6663.800085997428, 6665.133532640726, 6589.505787065893, 6654.234763002123, 6661.300563440769, 6668.43318317929, 6676.098726672031, 6478.967605161944, 6484.773032943825, 6490.221173459215, 6491.285958544462, 6500.382463665944, 6588.0, 6667.099941507834, 6698.095757072733, 6713.395794378529, 6735.124433823572, 6533.934660653523, 6553.475721942138, 6556.704948277435, 6559.048937903882, 6564.146660934048], "value": 5017.814172735997, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [890.8619164029576, 921.2169655792577, 931.942245551299, 936.5457752989803, 938.4885237545537, 14374.784378234323, 14572.708545829077, 14580.781288280657, 14590.978631495786, 14598.124112553242, 14177.716445671107, 14196.503122390692, 14287.285635718225, 14289.499867504639, 14344.856551434483, 901.2069378946518, 910.2126660438739, 916.0152835701614, 916.1251005289932, 916.8166366726681, 744.4193529047352, 881.8280435315116, 904.1681652879366, 908.2280061947325, 908.3369140527419, 949.9097585729379, 950.7813202963323, 955.0926619711302, 955.913967742903, 958.0, 771.8263390737095, 948.48781657905, 951.4386511957978, 951.6193522590985, 952.6998995316487, 695.3185877839695, 701.7473709464589, 703.9753608623724, 705.3546005405049, 707.1337611426013, 14524.636884077878, 14568.781468277984, 14612.123272603572, 14623.488177913721, 14646.560603181922, 13970.650733731738, 14622.26888655563, 14851.183184924825, 15182.924085379613, 15214.923925380303, 11499.885001150049, 11746.412679366083, 11869.821952670716, 12241.387930603523, 12289.815652765215, 3947.940780888289, 4010.7794071326066, 4028.4964379452567, 4050.25070361984, 4076.714629975903, 54114.72942635301, 54176.18735718967, 54708.72645636786, 54958.72520637371, 55020.174697379574, 10784.697870736376, 11085.113190944705, 11329.773404531863, 11477.54089836414, 11580.478878450322, 21046.684299735516, 21081.26215582478, 21106.683399749018, 21221.257255996275, 21223.363299101053, 7962.56205908669, 8289.336853051742, 8600.612972416131, 8754.037055923844, 8754.343424243207, 4973.452920178777, 4989.251612258117, 5015.673981191211, 5016.598672106223, 5130.384353877484, 3742.1580144467275, 3781.5084039075296, 3801.885943421702, 3806.352920003606, 3808.409696497047, 658.5094104891887, 667.1760375935716, 725.271102541942, 750.1860481377657, 757.5757575757593, 664.4020381656547, 713.5718568858747, 767.4359345880773, 809.1948511231362, 827.7351247600831, 8972.237359824358, 9448.433094014381, 9538.23694104484, 9545.474998875128, 9644.710658680251, 780.2197802197802, 843.4180415513276, 843.7384410832661, 848.974530764078, 854.1159899503983, 4543.0, 4575.450945886449, 4611.8847028823875, 4630.6758526902795, 4657.767111644472, 69015.30984690088, 69648.30351696418, 69664.30335696579, 69893.0, 69985.0, 56182.71908640431, 56350.49196064305, 57593.0, 57618.135727964116, 59810.70094649499, 50447.24329135066, 51524.227136592985, 51627.0, 52574.21138682999, 53171.46828531665, 8679.913200868163, 8817.470951742916, 8924.616684413926, 9069.18377346042, 9152.267818574632, 36765.81617092004, 37672.62327376801, 38556.614433855306, 38556.80721596374, 38674.0, 46598.53401466078, 47964.28053579269, 48083.27875081947, 51846.74076629593, 52731.47268527419, 12596.685082873002, 12797.29614871191, 12825.358732063172, 13203.735925281248, 13514.59456216315, 14577.489787857374, 14605.061159807938, 14685.926570367079, 14912.254387280376, 15508.84491155074, 13635.727285454434, 13718.17690938547, 13764.242966636932, 13778.931105344409, 14258.643533911736, 12751.362431878555, 13527.729445411234, 13697.246651434267, 13760.31198440054, 14411.495597654031, 12146.75706485883, 12598.370081496072, 12753.8086928698, 12811.295378754257, 13090.345482725636, 9428.15146636806, 9620.37467564606, 11384.715382115513, 11778.82331765007, 11800.114991375509, 11308.378039207922, 11454.599089031844, 11457.140714446283, 11631.53473861036, 11751.764964700487], "value": 7216.730746026459, "unit": "score"}], "name": "dromaeo_css", "value": 7397.296031405806, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 109.0, 110.0, 110.0, 108.0, 111.0, 105.0, 110.0, 110.0, 109.0], "value": 109.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 129.0, 158.0, 185.0, 126.0, 152.0, 161.0, 130.0, 177.0, 126.0], "value": 150.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 163.0, 160.0, 161.0, 162.0, 161.0, 161.0, 161.0, 160.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 181.0, 73.0, 75.0, 77.0, 73.0, 171.0, 75.0], "value": 95.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 92.0, 148.0, 95.0, 93.0, 91.0, 152.0, 91.0, 92.0, 147.0], "value": 109.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 146.0, 146.0, 147.0, 146.0, 145.0, 146.0, 146.0, 144.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 64.0, 53.0, 54.0, 55.0, 53.0, 55.0, 73.0, 53.0, 52.0], "value": 56.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 57.0, 57.0, 57.0, 56.0, 57.0, 57.0, 57.0, 57.0, 57.0], "value": 56.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 72.0, 72.0, 72.0, 72.0, 72.0, 74.0, 74.0, 73.0, 72.0], "value": 72.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 124.0, 118.0, 113.0, 109.0, 112.0, 110.0, 113.0, 139.0, 115.0], "value": 116.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 156.0, 156.0, 161.0, 158.0, 160.0, 157.0, 156.0, 157.0, 157.0], "value": 157.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 67.0, 66.0, 63.0, 77.0, 65.0, 65.0, 65.0, 67.0], "value": 66.9, "unit": "score"}], "name": "kraken", "value": 1510.0999999999997, "alertThreshold": 2.0}]} 15:26:52 INFO - Return code: 0 15:26:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 15:26:52 ERROR - # TBPL SUCCESS # 15:26:52 INFO - Running post-action listener: _resource_record_post_action 15:26:52 INFO - Running post-run listener: _resource_record_post_run 15:26:53 INFO - Total resource usage - Wall time: 1185s; CPU: 13.0%; Read bytes: 4096; Write bytes: 472203264; Read time: 16; Write time: 332772 15:26:53 INFO - install - Wall time: 14s; CPU: 14.0%; Read bytes: 0; Write bytes: 250216448; Read time: 0; Write time: 210028 15:26:53 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 4096; Write bytes: 221425664; Read time: 16; Write time: 122736 15:26:53 INFO - Running post-run listener: _upload_blobber_files 15:26:53 INFO - Blob upload gear active. 15:26:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:26:53 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 15:26:53 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-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:26:53 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-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:26:54 INFO - (blobuploader) - INFO - Open directory for files ... 15:26:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:26:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:26:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:26:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:26:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:26:55 INFO - (blobuploader) - INFO - Done attempting. 15:26:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:26:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:26:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:26:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:26:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:26:55 INFO - (blobuploader) - INFO - Done attempting. 15:26:55 INFO - (blobuploader) - INFO - Iteration through files over. 15:26:55 INFO - Return code: 0 15:26:55 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:26:55 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:26:55 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d3d9c8cac377e197e08c62a9f0f708123766330f7c9aa0bff805f488c71de77d432689d74531bf4a11885b2fe23295ce4dfabda2d4094c73fd7c738621f53345", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/498b3eb830ae1a3285a837b685129d757a381d450f391a1c152596bd62ed58b9d7c223e79414ca5d1dc1e577e62055684bce48e0c1d862b5794c2d9915a187e3"} 15:26:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:26:55 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:26:55 INFO - Contents: 15:26:55 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d3d9c8cac377e197e08c62a9f0f708123766330f7c9aa0bff805f488c71de77d432689d74531bf4a11885b2fe23295ce4dfabda2d4094c73fd7c738621f53345", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/498b3eb830ae1a3285a837b685129d757a381d450f391a1c152596bd62ed58b9d7c223e79414ca5d1dc1e577e62055684bce48e0c1d862b5794c2d9915a187e3"} 15:26:55 INFO - Running post-run listener: copy_logs_to_upload_dir 15:26:55 INFO - Copying logs to upload dir... 15:26:55 INFO - mkdir: /builds/slave/test/build/upload/logs 15:26:55 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1223.417707 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 23 secs) (at 2016-07-05 15:26:55.502408) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-05 15:26:55.505718) ========= 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=8887e36bb8e381bfd44124ac000001a8-1467756389.510580-39514871 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-Beta/sha512/d3d9c8cac377e197e08c62a9f0f708123766330f7c9aa0bff805f488c71de77d432689d74531bf4a11885b2fe23295ce4dfabda2d4094c73fd7c738621f53345", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/498b3eb830ae1a3285a837b685129d757a381d450f391a1c152596bd62ed58b9d7c223e79414ca5d1dc1e577e62055684bce48e0c1d862b5794c2d9915a187e3"} build_url:https://queue.taskcluster.net/v1/task/bsjBRbYfRR-flt3iMjJ8Fw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011177 build_url: 'https://queue.taskcluster.net/v1/task/bsjBRbYfRR-flt3iMjJ8Fw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d3d9c8cac377e197e08c62a9f0f708123766330f7c9aa0bff805f488c71de77d432689d74531bf4a11885b2fe23295ce4dfabda2d4094c73fd7c738621f53345", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/498b3eb830ae1a3285a837b685129d757a381d450f391a1c152596bd62ed58b9d7c223e79414ca5d1dc1e577e62055684bce48e0c1d862b5794c2d9915a187e3"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-05 15:26:55.531428) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 15:26:55.531733) ========= 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=8887e36bb8e381bfd44124ac000001a8-1467756389.510580-39514871 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004454 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 15:26:55.613781) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-05 15:26:55.614094) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-05 15:26:55.614413) ========= ========= Total master_lag: 0.18 =========