builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-040 starttime: 1466700145.64 results: success (0) buildid: 20160623064724 builduid: 3c87a22166e34e378a564d9881fe0e90 revision: 75bb5e9490a0b4a058e92b7da0643df7beddc2b0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-23 09:42:25.636589) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-23 09:42:25.637114) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-23 09:42:25.637478) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-23 09:42:25.660886) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 09:42:25.661275) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1466700047.74863-1396451921 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-23 09:42:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 218M=0s 2016-06-23 09:42:25 (218 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.092389 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 09:42:25.774690) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 09:42:25.775034) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1466700047.74863-1396451921 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020641 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 09:42:25.830632) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 09:42:25.830997) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 75bb5e9490a0b4a058e92b7da0643df7beddc2b0 --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 75bb5e9490a0b4a058e92b7da0643df7beddc2b0 --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=9e0dfe3369c33a1556e63f89000001d8-1466700047.74863-1396451921 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-23 09:42:25,850 truncating revision to first 12 chars 2016-06-23 09:42:25,850 Setting DEBUG logging. 2016-06-23 09:42:25,850 attempt 1/10 2016-06-23 09:42:25,850 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/75bb5e9490a0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-23 09:42:26,151 unpacking tar archive at: mozilla-beta-75bb5e9490a0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.721258 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 09:42:26.566632) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-23 09:42:26.567061) ========= script_repo_revision: 75bb5e9490a0b4a058e92b7da0643df7beddc2b0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-23 09:42:26.567581) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-23 09:42:26.567891) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-23 09:42:26.577463) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 24 secs) (at 2016-06-23 09:42:26.577872) ========= /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=9e0dfe3369c33a1556e63f89000001d8-1466700047.74863-1396451921 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:42:26 INFO - MultiFileLogger online at 20160623 09:42:26 in /builds/slave/test 09:42:26 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 09:42:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:42:26 INFO - {'append_to_log': False, 09:42:26 INFO - 'base_work_dir': '/builds/slave/test', 09:42:26 INFO - 'blob_upload_branch': 'Mozilla-Beta', 09:42:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:42:26 INFO - 'branch': 'Mozilla-Beta', 09:42:26 INFO - 'buildbot_json_path': 'buildprops.json', 09:42:26 INFO - 'config_files': ('talos/linux_config.py',), 09:42:26 INFO - 'default_actions': ('clobber', 09:42:26 INFO - 'read-buildbot-config', 09:42:26 INFO - 'download-and-extract', 09:42:26 INFO - 'populate-webroot', 09:42:26 INFO - 'create-virtualenv', 09:42:26 INFO - 'install', 09:42:26 INFO - 'run-tests'), 09:42:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:42:26 INFO - 'download_minidump_stackwalk': True, 09:42:26 INFO - 'download_symbols': 'ondemand', 09:42:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:42:26 INFO - 'tooltool.py': '/tools/tooltool.py', 09:42:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:42:26 INFO - '/tools/misc-python/virtualenv.py')}, 09:42:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:42:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:42:26 INFO - 'installer_path': 'installer.exe', 09:42:26 INFO - 'log_level': 'info', 09:42:26 INFO - 'log_name': 'talos', 09:42:26 INFO - 'log_to_console': True, 09:42:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:42:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:42:26 INFO - 'opt_config_files': (), 09:42:26 INFO - 'pip_index': False, 09:42:26 INFO - 'sps_profile': False, 09:42:26 INFO - 'sps_profile_interval': 0, 09:42:26 INFO - 'suite': 'dromaeojs', 09:42:26 INFO - 'system_bits': '32', 09:42:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:42:26 INFO - 'title': 'talos-linux64-ix-040', 09:42:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:42:26 INFO - 'use_talos_json': True, 09:42:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:42:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:42:26 INFO - 'work_dir': 'build'} 09:42:26 INFO - ##### 09:42:26 INFO - ##### Running clobber step. 09:42:26 INFO - ##### 09:42:26 INFO - Running pre-action listener: _resource_record_pre_action 09:42:26 INFO - Running main action method: clobber 09:42:26 INFO - rmtree: /builds/slave/test/build 09:42:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:42:27 INFO - Running post-action listener: _resource_record_post_action 09:42:27 INFO - ##### 09:42:27 INFO - ##### Running read-buildbot-config step. 09:42:27 INFO - ##### 09:42:27 INFO - Running pre-action listener: _resource_record_pre_action 09:42:27 INFO - Running main action method: read_buildbot_config 09:42:27 INFO - Using buildbot properties: 09:42:27 INFO - { 09:42:27 INFO - "project": "", 09:42:27 INFO - "product": "firefox", 09:42:27 INFO - "script_repo_revision": "production", 09:42:27 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 09:42:27 INFO - "repository": "", 09:42:27 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 09:42:27 INFO - "buildid": "20160623064724", 09:42:27 INFO - "pgo_build": "True", 09:42:27 INFO - "basedir": "/builds/slave/test", 09:42:27 INFO - "buildnumber": 63, 09:42:27 INFO - "slavename": "talos-linux64-ix-040", 09:42:27 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 09:42:27 INFO - "platform": "ubuntu64_hw", 09:42:27 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 09:42:27 INFO - "branch": "mozilla-beta", 09:42:27 INFO - "repo_path": "releases/mozilla-beta", 09:42:27 INFO - "revision": "75bb5e9490a0b4a058e92b7da0643df7beddc2b0", 09:42:27 INFO - "stage_platform": "linux64-pgo", 09:42:27 INFO - "builduid": "3c87a22166e34e378a564d9881fe0e90", 09:42:27 INFO - "slavebuilddir": "test" 09:42:27 INFO - } 09:42:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/EcAS53vgTEqzzX_U6f1uLw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2. 09:42:27 INFO - Running post-action listener: _resource_record_post_action 09:42:27 INFO - ##### 09:42:27 INFO - ##### Running download-and-extract step. 09:42:27 INFO - ##### 09:42:27 INFO - Running pre-action listener: _resource_record_pre_action 09:42:27 INFO - Running main action method: download_and_extract 09:42:27 INFO - mkdir: /builds/slave/test/build/tests 09:42:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:42:27 INFO - https://queue.taskcluster.net/v1/task/EcAS53vgTEqzzX_U6f1uLw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 09:42:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EcAS53vgTEqzzX_U6f1uLw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 09:42:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EcAS53vgTEqzzX_U6f1uLw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 09:42:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EcAS53vgTEqzzX_U6f1uLw/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 09:42:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EcAS53vgTEqzzX_U6f1uLw/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 09:42:28 INFO - Downloaded 1327 bytes. 09:42:28 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 09:42:28 INFO - Using the following test package requirements: 09:42:28 INFO - {u'common': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 09:42:28 INFO - u'cppunittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 09:42:28 INFO - u'firefox-48.0.en-US.linux-x86_64.cppunittest.tests.zip'], 09:42:28 INFO - u'gtest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 09:42:28 INFO - u'firefox-48.0.en-US.linux-x86_64.gtest.tests.zip'], 09:42:28 INFO - u'jittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 09:42:28 INFO - u'jsshell-linux-x86_64.zip'], 09:42:28 INFO - u'mochitest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 09:42:28 INFO - u'firefox-48.0.en-US.linux-x86_64.mochitest.tests.zip'], 09:42:28 INFO - u'mozbase': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 09:42:28 INFO - u'reftest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 09:42:28 INFO - u'firefox-48.0.en-US.linux-x86_64.reftest.tests.zip'], 09:42:28 INFO - u'talos': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 09:42:28 INFO - u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'], 09:42:28 INFO - u'web-platform': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 09:42:28 INFO - u'firefox-48.0.en-US.linux-x86_64.web-platform.tests.zip'], 09:42:28 INFO - u'xpcshell': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 09:42:28 INFO - u'firefox-48.0.en-US.linux-x86_64.xpcshell.tests.zip']} 09:42:28 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:42:28 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')]} 09:42:28 INFO - https://queue.taskcluster.net/v1/task/EcAS53vgTEqzzX_U6f1uLw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:42:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EcAS53vgTEqzzX_U6f1uLw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 09:42:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EcAS53vgTEqzzX_U6f1uLw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 09:42:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EcAS53vgTEqzzX_U6f1uLw/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 09:42:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EcAS53vgTEqzzX_U6f1uLw/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 09:42:29 INFO - Downloaded 24185911 bytes. 09:42:29 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'] 09:42:29 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 09:42:30 INFO - Return code: 0 09:42:30 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 09:42:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:42:30 INFO - https://queue.taskcluster.net/v1/task/EcAS53vgTEqzzX_U6f1uLw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:42:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EcAS53vgTEqzzX_U6f1uLw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 09:42:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EcAS53vgTEqzzX_U6f1uLw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 09:42:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EcAS53vgTEqzzX_U6f1uLw/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 09:42:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EcAS53vgTEqzzX_U6f1uLw/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 09:42:33 INFO - Downloaded 24185911 bytes. 09:42:33 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'] 09:42:33 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 09:42:34 INFO - Return code: 0 09:42:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:42:34 INFO - https://queue.taskcluster.net/v1/task/EcAS53vgTEqzzX_U6f1uLw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:42:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EcAS53vgTEqzzX_U6f1uLw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 09:42:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EcAS53vgTEqzzX_U6f1uLw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 09:42:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EcAS53vgTEqzzX_U6f1uLw/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 09:42:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EcAS53vgTEqzzX_U6f1uLw/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 09:42:35 INFO - Downloaded 10840145 bytes. 09:42:35 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'] 09:42:35 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 09:42:35 INFO - Return code: 0 09:42:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:42:35 INFO - https://queue.taskcluster.net/v1/task/EcAS53vgTEqzzX_U6f1uLw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:42:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EcAS53vgTEqzzX_U6f1uLw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 09:42:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EcAS53vgTEqzzX_U6f1uLw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 09:42:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EcAS53vgTEqzzX_U6f1uLw/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 09:42:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EcAS53vgTEqzzX_U6f1uLw/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 09:42:37 INFO - Downloaded 56003279 bytes. 09:42:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EcAS53vgTEqzzX_U6f1uLw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 09:42:37 INFO - mkdir: /builds/slave/test/properties 09:42:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:42:37 INFO - Writing to file /builds/slave/test/properties/build_url 09:42:37 INFO - Contents: 09:42:37 INFO - build_url:https://queue.taskcluster.net/v1/task/EcAS53vgTEqzzX_U6f1uLw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 09:42:37 INFO - Running post-action listener: _resource_record_post_action 09:42:37 INFO - Running post-action listener: set_extra_try_arguments 09:42:37 INFO - ##### 09:42:37 INFO - ##### Running populate-webroot step. 09:42:37 INFO - ##### 09:42:37 INFO - Running pre-action listener: _resource_record_pre_action 09:42:37 INFO - Running main action method: populate_webroot 09:42:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:42:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:42:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:42:37 INFO - '--tppagecycles', 09:42:37 INFO - '7'], 09:42:37 INFO - 'tests': ['tsvgm']}}, 09:42:37 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:42:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:42:37 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:42:37 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:42:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:42:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:42:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:42:37 INFO - 'talos_options': ['--disable-e10s'], 09:42:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:42:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:42:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:42:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:42:37 INFO - 'talos_options': ['--disable-e10s'], 09:42:37 INFO - 'tests': ['damp', 'tps']}, 09:42:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:42:37 INFO - 'tests': ['damp', 'tps']}, 09:42:37 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:42:37 INFO - 'tests': ['dromaeo_dom']}, 09:42:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:42:37 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:42:37 INFO - 'tests': ['a11yr', 09:42:37 INFO - 'ts_paint', 09:42:37 INFO - 'tpaint', 09:42:37 INFO - 'sessionrestore', 09:42:37 INFO - 'sessionrestore_no_auto_restore', 09:42:37 INFO - 'tabpaint']}, 09:42:37 INFO - 'other-e10s': {'tests': ['a11yr', 09:42:37 INFO - 'ts_paint', 09:42:37 INFO - 'tpaint', 09:42:37 INFO - 'sessionrestore', 09:42:37 INFO - 'sessionrestore_no_auto_restore', 09:42:37 INFO - 'tabpaint']}, 09:42:37 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:42:37 INFO - 'ts_paint', 09:42:37 INFO - 'tpaint', 09:42:37 INFO - 'sessionrestore', 09:42:37 INFO - 'sessionrestore_no_auto_restore', 09:42:37 INFO - 'tabpaint']}, 09:42:37 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:42:37 INFO - 'ts_paint', 09:42:37 INFO - 'tpaint', 09:42:37 INFO - 'sessionrestore', 09:42:37 INFO - 'sessionrestore_no_auto_restore', 09:42:37 INFO - 'tabpaint']}, 09:42:37 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:42:37 INFO - 'tests': ['a11yr', 09:42:37 INFO - 'ts_paint', 09:42:37 INFO - 'tpaint', 09:42:37 INFO - 'sessionrestore', 09:42:37 INFO - 'sessionrestore_no_auto_restore', 09:42:37 INFO - 'tabpaint']}, 09:42:37 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:42:37 INFO - 'tests': ['a11yr', 09:42:37 INFO - 'ts_paint', 09:42:37 INFO - 'tpaint', 09:42:37 INFO - 'sessionrestore', 09:42:37 INFO - 'sessionrestore_no_auto_restore', 09:42:37 INFO - 'tabpaint']}, 09:42:37 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:42:37 INFO - 'tests': ['tsvgx', 09:42:37 INFO - 'tsvgr_opacity', 09:42:37 INFO - 'tart', 09:42:37 INFO - 'tscrollx', 09:42:37 INFO - 'cart']}, 09:42:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:42:37 INFO - 'tsvgr_opacity', 09:42:37 INFO - 'tart', 09:42:37 INFO - 'tscrollx', 09:42:37 INFO - 'cart']}, 09:42:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:42:37 INFO - 'talos_options': ['--disable-e10s'], 09:42:37 INFO - 'tests': ['tp5o']}, 09:42:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:42:37 INFO - 'tests': ['tp5o']}, 09:42:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:42:37 INFO - 'talos_options': ['--disable-e10s', 09:42:37 INFO - '--xperf_path', 09:42:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:42:37 INFO - 'tests': ['tp5n']}, 09:42:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:42:37 INFO - 'talos_options': ['--xperf_path', 09:42:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:42:37 INFO - 'tests': ['tp5n']}}, 09:42:37 INFO - 'talos.zip': {'path': '', 09:42:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:42:37 INFO - Running post-action listener: _resource_record_post_action 09:42:37 INFO - ##### 09:42:37 INFO - ##### Running create-virtualenv step. 09:42:37 INFO - ##### 09:42:37 INFO - Running pre-action listener: _resource_record_pre_action 09:42:37 INFO - Running main action method: create_virtualenv 09:42:37 INFO - Creating virtualenv /builds/slave/test/build/venv 09:42:37 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 09:42:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:42:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:42:37 INFO - Using real prefix '/usr' 09:42:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:42:38 INFO - Installing distribute.............................................................................................................................................................................................done. 09:42:40 INFO - Installing pip.................done. 09:42:40 INFO - Return code: 0 09:42:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:42:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:42:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:42:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:42:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:42:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:42:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:42:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2041563f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc708a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd3b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdca410>, '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 0xdcb310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdcb7a0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1466700047.74863-1396451921', '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 09:42:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:42:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:42:40 INFO - Using env: {'DISPLAY': ':0', 09:42:40 INFO - 'HOME': '/home/cltbld', 09:42:40 INFO - 'LANG': 'en_US.UTF-8', 09:42:40 INFO - 'LANGUAGE': 'en_US:en', 09:42:40 INFO - 'LOGNAME': 'cltbld', 09:42:40 INFO - 'MAIL': '/var/mail/cltbld', 09:42:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:42:40 INFO - 'MOZ_NO_REMOTE': '1', 09:42:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:42:40 INFO - 'NO_EM_RESTART': '1', 09:42:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:42:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:42:40 INFO - 'PWD': '/builds/slave/test', 09:42:40 INFO - 'SHELL': '/bin/bash', 09:42:40 INFO - 'SHLVL': '1', 09:42:40 INFO - 'TERM': 'linux', 09:42:40 INFO - 'TMOUT': '86400', 09:42:40 INFO - 'USER': 'cltbld', 09:42:40 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1466700047.74863-1396451921', 09:42:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:42:40 INFO - '_': '/tools/buildbot/bin/python'} 09:42:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:42:40 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 09:42:40 INFO - Cleaning up... 09:42:40 INFO - Return code: 0 09:42:40 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 09:42:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:42:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:42:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:42:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:42:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:42:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:42:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2041563f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc708a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd3b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdca410>, '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 0xdcb310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdcb7a0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1466700047.74863-1396451921', '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 09:42:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 09:42:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 09:42:40 INFO - Using env: {'DISPLAY': ':0', 09:42:40 INFO - 'HOME': '/home/cltbld', 09:42:40 INFO - 'LANG': 'en_US.UTF-8', 09:42:40 INFO - 'LANGUAGE': 'en_US:en', 09:42:40 INFO - 'LOGNAME': 'cltbld', 09:42:40 INFO - 'MAIL': '/var/mail/cltbld', 09:42:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:42:40 INFO - 'MOZ_NO_REMOTE': '1', 09:42:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:42:40 INFO - 'NO_EM_RESTART': '1', 09:42:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:42:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:42:40 INFO - 'PWD': '/builds/slave/test', 09:42:40 INFO - 'SHELL': '/bin/bash', 09:42:40 INFO - 'SHLVL': '1', 09:42:40 INFO - 'TERM': 'linux', 09:42:40 INFO - 'TMOUT': '86400', 09:42:40 INFO - 'USER': 'cltbld', 09:42:40 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1466700047.74863-1396451921', 09:42:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:42:40 INFO - '_': '/tools/buildbot/bin/python'} 09:42:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:42:40 INFO - Downloading/unpacking psutil>=0.7.1 09:42:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:42:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:42:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:42:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:42:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:42:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:42:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:42:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:42:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:42:42 INFO - Installing collected packages: psutil 09:42:42 INFO - Running setup.py install for psutil 09:42:42 INFO - building 'psutil._psutil_linux' extension 09:42:42 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 09:42:43 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 09:42:43 INFO - building 'psutil._psutil_posix' extension 09:42:43 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 09:42:43 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 09:42:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:42:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:42:43 INFO - Successfully installed psutil 09:42:43 INFO - Cleaning up... 09:42:43 INFO - Return code: 0 09:42:43 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 09:42:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:42:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:42:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:42:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:42:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:42:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:42:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2041563f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc708a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd3b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdca410>, '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 0xdcb310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdcb7a0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1466700047.74863-1396451921', '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 09:42:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 09:42:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 09:42:43 INFO - Using env: {'DISPLAY': ':0', 09:42:43 INFO - 'HOME': '/home/cltbld', 09:42:43 INFO - 'LANG': 'en_US.UTF-8', 09:42:43 INFO - 'LANGUAGE': 'en_US:en', 09:42:43 INFO - 'LOGNAME': 'cltbld', 09:42:43 INFO - 'MAIL': '/var/mail/cltbld', 09:42:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:42:43 INFO - 'MOZ_NO_REMOTE': '1', 09:42:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:42:43 INFO - 'NO_EM_RESTART': '1', 09:42:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:42:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:42:43 INFO - 'PWD': '/builds/slave/test', 09:42:43 INFO - 'SHELL': '/bin/bash', 09:42:43 INFO - 'SHLVL': '1', 09:42:43 INFO - 'TERM': 'linux', 09:42:43 INFO - 'TMOUT': '86400', 09:42:43 INFO - 'USER': 'cltbld', 09:42:43 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1466700047.74863-1396451921', 09:42:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:42:43 INFO - '_': '/tools/buildbot/bin/python'} 09:42:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:42:43 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:42:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:42:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:42:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:42:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:42:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:42:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:42:45 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:42:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:42:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:42:45 INFO - Installing collected packages: mozsystemmonitor 09:42:45 INFO - Running setup.py install for mozsystemmonitor 09:42:45 INFO - Successfully installed mozsystemmonitor 09:42:45 INFO - Cleaning up... 09:42:45 INFO - Return code: 0 09:42:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:42:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:42:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:42:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:42:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:42:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:42:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:42:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2041563f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc708a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd3b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdca410>, '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 0xdcb310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdcb7a0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1466700047.74863-1396451921', '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 09:42:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:42:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:42:45 INFO - Using env: {'DISPLAY': ':0', 09:42:45 INFO - 'HOME': '/home/cltbld', 09:42:45 INFO - 'LANG': 'en_US.UTF-8', 09:42:45 INFO - 'LANGUAGE': 'en_US:en', 09:42:45 INFO - 'LOGNAME': 'cltbld', 09:42:45 INFO - 'MAIL': '/var/mail/cltbld', 09:42:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:42:45 INFO - 'MOZ_NO_REMOTE': '1', 09:42:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:42:45 INFO - 'NO_EM_RESTART': '1', 09:42:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:42:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:42:45 INFO - 'PWD': '/builds/slave/test', 09:42:45 INFO - 'SHELL': '/bin/bash', 09:42:45 INFO - 'SHLVL': '1', 09:42:45 INFO - 'TERM': 'linux', 09:42:45 INFO - 'TMOUT': '86400', 09:42:45 INFO - 'USER': 'cltbld', 09:42:45 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1466700047.74863-1396451921', 09:42:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:42:45 INFO - '_': '/tools/buildbot/bin/python'} 09:42:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:42:45 INFO - Downloading/unpacking blobuploader==1.2.4 09:42: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 09:42: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 09:42: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 09:42: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 09:42: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 09:42: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 09:42:48 INFO - Downloading blobuploader-1.2.4.tar.gz 09:42:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:42:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:42:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:42:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:42:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:42:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:42:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:42:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:42:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:42:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:42:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:42:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:42:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:42:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:42:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:42:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:42:49 INFO - Downloading docopt-0.6.1.tar.gz 09:42:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:42:49 INFO - Installing collected packages: blobuploader, requests, docopt 09:42:49 INFO - Running setup.py install for blobuploader 09:42:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:42:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:42:49 INFO - Running setup.py install for requests 09:42:49 INFO - Running setup.py install for docopt 09:42:50 INFO - Successfully installed blobuploader requests docopt 09:42:50 INFO - Cleaning up... 09:42:50 INFO - Return code: 0 09:42:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:42: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')]} 09:42:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:42:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:42: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')]} 09:42:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:42:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:42:50 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 0x7f2041563f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc708a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd3b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdca410>, '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 0xdcb310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdcb7a0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1466700047.74863-1396451921', '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 09:42:50 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 09:42:50 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 09:42:50 INFO - Using env: {'DISPLAY': ':0', 09:42:50 INFO - 'HOME': '/home/cltbld', 09:42:50 INFO - 'LANG': 'en_US.UTF-8', 09:42:50 INFO - 'LANGUAGE': 'en_US:en', 09:42:50 INFO - 'LOGNAME': 'cltbld', 09:42:50 INFO - 'MAIL': '/var/mail/cltbld', 09:42:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:42:50 INFO - 'MOZ_NO_REMOTE': '1', 09:42:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:42:50 INFO - 'NO_EM_RESTART': '1', 09:42:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:42:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:42:50 INFO - 'PWD': '/builds/slave/test', 09:42:50 INFO - 'SHELL': '/bin/bash', 09:42:50 INFO - 'SHLVL': '1', 09:42:50 INFO - 'TERM': 'linux', 09:42:50 INFO - 'TMOUT': '86400', 09:42:50 INFO - 'USER': 'cltbld', 09:42:50 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1466700047.74863-1396451921', 09:42:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:42:50 INFO - '_': '/tools/buildbot/bin/python'} 09:42:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:42:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:42:50 INFO - Running setup.py (path:/tmp/pip-9ALg2K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:42:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:42:50 INFO - Running setup.py (path:/tmp/pip-O7JQSL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:42:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:42:50 INFO - Running setup.py (path:/tmp/pip-UIjf8M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:42:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:42:50 INFO - Running setup.py (path:/tmp/pip-gDJXOR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:42:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:42:50 INFO - Running setup.py (path:/tmp/pip-UTAgHX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:42:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:42:50 INFO - Running setup.py (path:/tmp/pip-BeQ7o7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:42:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:42:50 INFO - Running setup.py (path:/tmp/pip-7im0Nj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:42:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:42:50 INFO - Running setup.py (path:/tmp/pip-lTawt8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:42:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:42:50 INFO - Running setup.py (path:/tmp/pip-jy9XXM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:42:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:42:50 INFO - Running setup.py (path:/tmp/pip-WmkXgt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:42:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:42:51 INFO - Running setup.py (path:/tmp/pip-Io4pW9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:42:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:42:51 INFO - Running setup.py (path:/tmp/pip-Bg1x1P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:42:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:42:51 INFO - Running setup.py (path:/tmp/pip-r44h_O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:42:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:42:51 INFO - Running setup.py (path:/tmp/pip-Lc6vxZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:42:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:42:51 INFO - Running setup.py (path:/tmp/pip-lFQUJv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:42:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:42:51 INFO - Running setup.py (path:/tmp/pip-3As19C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:42:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:42:51 INFO - Running setup.py (path:/tmp/pip-iXMfe9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:42:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:42:51 INFO - Running setup.py install for manifestparser 09:42:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:42:51 INFO - Running setup.py install for mozcrash 09:42:51 INFO - Running setup.py install for mozdebug 09:42:51 INFO - Running setup.py install for mozdevice 09:42:51 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:42:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:42:51 INFO - Running setup.py install for mozfile 09:42:52 INFO - Running setup.py install for mozhttpd 09:42:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:42:52 INFO - Running setup.py install for mozinfo 09:42:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:42:52 INFO - Running setup.py install for mozInstall 09:42:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:42:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:42:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:42:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:42:52 INFO - Running setup.py install for mozleak 09:42:52 INFO - Running setup.py install for mozlog 09:42:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:42:52 INFO - Running setup.py install for moznetwork 09:42:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:42:52 INFO - Running setup.py install for mozprocess 09:42:52 INFO - Running setup.py install for mozprofile 09:42:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:42:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:42:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:42:52 INFO - Running setup.py install for mozrunner 09:42:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:42:53 INFO - Running setup.py install for mozscreenshot 09:42:53 INFO - Running setup.py install for moztest 09:42:53 INFO - Running setup.py install for mozversion 09:42:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:42:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:42:53 INFO - Cleaning up... 09:42:53 INFO - Return code: 0 09:42:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:42:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:42:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:42:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:42:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:42:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:42:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:42:53 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 0x7f2041563f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc708a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd3b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdca410>, '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 0xdcb310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdcb7a0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1466700047.74863-1396451921', '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 09:42:53 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 09:42:53 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 09:42:53 INFO - Using env: {'DISPLAY': ':0', 09:42:53 INFO - 'HOME': '/home/cltbld', 09:42:53 INFO - 'LANG': 'en_US.UTF-8', 09:42:53 INFO - 'LANGUAGE': 'en_US:en', 09:42:53 INFO - 'LOGNAME': 'cltbld', 09:42:53 INFO - 'MAIL': '/var/mail/cltbld', 09:42:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:42:53 INFO - 'MOZ_NO_REMOTE': '1', 09:42:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:42:53 INFO - 'NO_EM_RESTART': '1', 09:42:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:42:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:42:53 INFO - 'PWD': '/builds/slave/test', 09:42:53 INFO - 'SHELL': '/bin/bash', 09:42:53 INFO - 'SHLVL': '1', 09:42:53 INFO - 'TERM': 'linux', 09:42:53 INFO - 'TMOUT': '86400', 09:42:53 INFO - 'USER': 'cltbld', 09:42:53 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1466700047.74863-1396451921', 09:42:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:42:53 INFO - '_': '/tools/buildbot/bin/python'} 09:42:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:42:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:42:53 INFO - Running setup.py (path:/tmp/pip-VYYaFG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:42:53 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)) 09:42:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:42:53 INFO - Running setup.py (path:/tmp/pip-tT062e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:42:53 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)) 09:42:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:42:53 INFO - Running setup.py (path:/tmp/pip-72yXh0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:42:53 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)) 09:42:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:42:53 INFO - Running setup.py (path:/tmp/pip-Cl0fQ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:42:53 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)) 09:42:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:42:53 INFO - Running setup.py (path:/tmp/pip-wK3QgZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:42:53 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)) 09:42:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:42:53 INFO - Running setup.py (path:/tmp/pip-pvys91-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:42:53 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)) 09:42:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:42:53 INFO - Running setup.py (path:/tmp/pip-j_txus-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:42:54 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)) 09:42:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:42:54 INFO - Running setup.py (path:/tmp/pip-1VJOdU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:42:54 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)) 09:42:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:42:54 INFO - Running setup.py (path:/tmp/pip-6ajFIE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:42:54 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)) 09:42:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:42:54 INFO - Running setup.py (path:/tmp/pip-3oZNkH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:42:54 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)) 09:42:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:42:54 INFO - Running setup.py (path:/tmp/pip-DFdIDn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:42:54 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)) 09:42:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:42:54 INFO - Running setup.py (path:/tmp/pip-ih9yk0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:42:54 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)) 09:42:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:42:54 INFO - Running setup.py (path:/tmp/pip-96QbOe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:42:54 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)) 09:42:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:42:54 INFO - Running setup.py (path:/tmp/pip-3wPNFy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:42:54 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)) 09:42:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:42:54 INFO - Running setup.py (path:/tmp/pip-90hYVY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:42:54 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)) 09:42:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:42:54 INFO - Running setup.py (path:/tmp/pip-jDV2Ph-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:42:54 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)) 09:42:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:42:54 INFO - Running setup.py (path:/tmp/pip-oSP2ks-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:42:54 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)) 09:42:54 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)) 09:42:54 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)) 09:42:54 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)) 09:42:54 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)) 09:42:54 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)) 09:42:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:42:54 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 09:42:54 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 09:42:54 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 09:42:54 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 09:42:54 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 09:42:54 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 09:42:56 INFO - Downloading blessings-1.6.tar.gz 09:42:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:42:56 INFO - Installing collected packages: blessings 09:42:56 INFO - Running setup.py install for blessings 09:42:56 INFO - Successfully installed blessings 09:42:56 INFO - Cleaning up... 09:42:56 INFO - Return code: 0 09:42:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:42:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:42:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:42:57 INFO - Reading from file tmpfile_stdout 09:42:57 INFO - Current package versions: 09:42:57 INFO - argparse == 1.2.1 09:42:57 INFO - blessings == 1.6 09:42:57 INFO - blobuploader == 1.2.4 09:42:57 INFO - docopt == 0.6.1 09:42:57 INFO - manifestparser == 1.1 09:42:57 INFO - mozInstall == 1.12 09:42:57 INFO - mozcrash == 0.17 09:42:57 INFO - mozdebug == 0.1 09:42:57 INFO - mozdevice == 0.48 09:42:57 INFO - mozfile == 1.2 09:42:57 INFO - mozhttpd == 0.7 09:42:57 INFO - mozinfo == 0.9 09:42:57 INFO - mozleak == 0.1 09:42:57 INFO - mozlog == 3.1 09:42:57 INFO - moznetwork == 0.27 09:42:57 INFO - mozprocess == 0.22 09:42:57 INFO - mozprofile == 0.28 09:42:57 INFO - mozrunner == 6.11 09:42:57 INFO - mozscreenshot == 0.1 09:42:57 INFO - mozsystemmonitor == 0.0 09:42:57 INFO - moztest == 0.7 09:42:57 INFO - mozversion == 1.4 09:42:57 INFO - psutil == 3.1.1 09:42:57 INFO - requests == 1.2.3 09:42:57 INFO - wsgiref == 0.1.2 09:42:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:42: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')]} 09:42:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:42:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:42: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')]} 09:42:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:42:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:42:57 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 0x7f2041563f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc708a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd3b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdca410>, '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 0xdcb310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdcb7a0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1466700047.74863-1396451921', '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 09:42:57 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 09:42:57 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 09:42:57 INFO - Using env: {'DISPLAY': ':0', 09:42:57 INFO - 'HOME': '/home/cltbld', 09:42:57 INFO - 'LANG': 'en_US.UTF-8', 09:42:57 INFO - 'LANGUAGE': 'en_US:en', 09:42:57 INFO - 'LOGNAME': 'cltbld', 09:42:57 INFO - 'MAIL': '/var/mail/cltbld', 09:42:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:42:57 INFO - 'MOZ_NO_REMOTE': '1', 09:42:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:42:57 INFO - 'NO_EM_RESTART': '1', 09:42:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:42:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:42:57 INFO - 'PWD': '/builds/slave/test', 09:42:57 INFO - 'SHELL': '/bin/bash', 09:42:57 INFO - 'SHLVL': '1', 09:42:57 INFO - 'TERM': 'linux', 09:42:57 INFO - 'TMOUT': '86400', 09:42:57 INFO - 'USER': 'cltbld', 09:42:57 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1466700047.74863-1396451921', 09:42:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:42:57 INFO - '_': '/tools/buildbot/bin/python'} 09:42:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:42:57 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)) 09:42:57 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)) 09:42:57 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)) 09:42:57 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)) 09:42:57 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)) 09:42:57 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)) 09:42:57 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)) 09:42:57 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)) 09:42:57 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)) 09:42:57 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)) 09:42:57 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)) 09:42:57 INFO - Cleaning up... 09:42:57 INFO - Return code: 0 09:42:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:42: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')]} 09:42:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:42:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:42: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')]} 09:42:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:42:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:42:57 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 0x7f2041563f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc708a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd3b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdca410>, '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 0xdcb310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdcb7a0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1466700047.74863-1396451921', '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 09:42:57 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 09:42:57 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 09:42:57 INFO - Using env: {'DISPLAY': ':0', 09:42:57 INFO - 'HOME': '/home/cltbld', 09:42:57 INFO - 'LANG': 'en_US.UTF-8', 09:42:57 INFO - 'LANGUAGE': 'en_US:en', 09:42:57 INFO - 'LOGNAME': 'cltbld', 09:42:57 INFO - 'MAIL': '/var/mail/cltbld', 09:42:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:42:57 INFO - 'MOZ_NO_REMOTE': '1', 09:42:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:42:57 INFO - 'NO_EM_RESTART': '1', 09:42:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:42:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:42:57 INFO - 'PWD': '/builds/slave/test', 09:42:57 INFO - 'SHELL': '/bin/bash', 09:42:57 INFO - 'SHLVL': '1', 09:42:57 INFO - 'TERM': 'linux', 09:42:57 INFO - 'TMOUT': '86400', 09:42:57 INFO - 'USER': 'cltbld', 09:42:57 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1466700047.74863-1396451921', 09:42:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:42:57 INFO - '_': '/tools/buildbot/bin/python'} 09:42:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:42:57 INFO - Downloading/unpacking jsonschema 09:42:57 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 09:42:57 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 09:42:57 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 09:42:57 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 09:42:57 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 09:42:57 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 09:42:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:42:59 INFO - Downloading/unpacking functools32 (from jsonschema) 09:42: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 09:42: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 09:42: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 09:42: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 09:42: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 09:42: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 09:42:59 INFO - Downloading functools32-3.2.3-2.tar.gz 09:42:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:42:59 INFO - warning: no files found matching '*.txt' 09:42:59 INFO - no previously-included directories found matching 'build' 09:42:59 INFO - no previously-included directories found matching 'dist' 09:42:59 INFO - no previously-included directories found matching '.git*' 09:42:59 INFO - Installing collected packages: jsonschema, functools32 09:42:59 INFO - Running setup.py install for functools32 09:42:59 INFO - warning: no files found matching '*.txt' 09:42:59 INFO - no previously-included directories found matching 'build' 09:42:59 INFO - no previously-included directories found matching 'dist' 09:42:59 INFO - no previously-included directories found matching '.git*' 09:42:59 INFO - Successfully installed jsonschema functools32 09:42:59 INFO - Cleaning up... 09:43:00 INFO - Return code: 0 09:43:00 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:43:00 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')]} 09:43:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:43:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:43:00 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')]} 09:43:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:43:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:43:00 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 0x7f2041563f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc708a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd3b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdca410>, '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 0xdcb310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdcb7a0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1466700047.74863-1396451921', '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 09:43:00 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 09:43:00 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 09:43:00 INFO - Using env: {'DISPLAY': ':0', 09:43:00 INFO - 'HOME': '/home/cltbld', 09:43:00 INFO - 'LANG': 'en_US.UTF-8', 09:43:00 INFO - 'LANGUAGE': 'en_US:en', 09:43:00 INFO - 'LOGNAME': 'cltbld', 09:43:00 INFO - 'MAIL': '/var/mail/cltbld', 09:43:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:43:00 INFO - 'MOZ_NO_REMOTE': '1', 09:43:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:43:00 INFO - 'NO_EM_RESTART': '1', 09:43:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:43:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:43:00 INFO - 'PWD': '/builds/slave/test', 09:43:00 INFO - 'SHELL': '/bin/bash', 09:43:00 INFO - 'SHLVL': '1', 09:43:00 INFO - 'TERM': 'linux', 09:43:00 INFO - 'TMOUT': '86400', 09:43:00 INFO - 'USER': 'cltbld', 09:43:00 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1466700047.74863-1396451921', 09:43:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:43:00 INFO - '_': '/tools/buildbot/bin/python'} 09:43:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:43:00 INFO - Downloading/unpacking flake8 09:43:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:43:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:43:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:43:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:43:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:43:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:43:02 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:43:02 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:43:02 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 09:43:02 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 09:43:02 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 09:43:02 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 09:43:02 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 09:43:02 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 09:43:02 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:43:02 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:43:02 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 09:43:02 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 09:43:02 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 09:43:02 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 09:43:02 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 09:43:02 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 09:43:02 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:43:02 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 09:43:02 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 09:43:02 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 09:43:02 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 09:43:02 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 09:43:02 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 09:43:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:43:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:43:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:43:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:43:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:43:02 INFO - no previously-included directories found matching 'docs/_build' 09:43:02 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:43:02 INFO - Running setup.py install for pep8 09:43:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:43:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:43:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:43:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:43:02 INFO - no previously-included directories found matching 'docs/_build' 09:43:03 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:43:03 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:43:03 INFO - Cleaning up... 09:43:03 INFO - Return code: 0 09:43:03 INFO - Running post-action listener: _resource_record_post_action 09:43:03 INFO - Running post-action listener: _start_resource_monitoring 09:43:03 INFO - Starting resource monitoring. 09:43:03 INFO - ##### 09:43:03 INFO - ##### Running install step. 09:43:03 INFO - ##### 09:43:03 INFO - Running pre-action listener: _resource_record_pre_action 09:43:03 INFO - Running main action method: install 09:43:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:43:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:43:03 INFO - Reading from file tmpfile_stdout 09:43:03 INFO - Detecting whether we're running mozinstall >=1.0... 09:43:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:43:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:43:03 INFO - Reading from file tmpfile_stdout 09:43:03 INFO - Output received: 09:43:03 INFO - Usage: mozinstall [options] installer 09:43:03 INFO - Options: 09:43:03 INFO - -h, --help show this help message and exit 09:43:03 INFO - -d DEST, --destination=DEST 09:43:03 INFO - Directory to install application into. [default: 09:43:03 INFO - "/builds/slave/test"] 09:43:03 INFO - --app=APP Application being installed. [default: firefox] 09:43:03 INFO - mkdir: /builds/slave/test/build/application 09:43:03 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'] 09:43:03 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 09:43:16 INFO - Reading from file tmpfile_stdout 09:43:16 INFO - Output received: 09:43:16 INFO - /builds/slave/test/build/application/firefox/firefox 09:43:16 INFO - Running post-action listener: _resource_record_post_action 09:43:16 INFO - ##### 09:43:16 INFO - ##### Running run-tests step. 09:43:16 INFO - ##### 09:43:16 INFO - Running pre-action listener: _resource_record_pre_action 09:43:16 INFO - Running main action method: run_tests 09:43:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:43:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:43:16 INFO - Python 2.7.3 09:43:16 INFO - Return code: 0 09:43:16 INFO - grabbing minidump binary from tooltool 09:43:16 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')]} 09:43:16 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 0xdca410>, '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 0xdcb310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdcb7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:43:16 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 09:43:16 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 09:43:16 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:43:16 INFO - Return code: 0 09:43:16 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:43:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:43:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:43:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:43:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:43:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:43:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:43:17 INFO - Return code: 0 09:43:17 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/EcAS53vgTEqzzX_U6f1uLw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-040', '--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 09:43:17 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/EcAS53vgTEqzzX_U6f1uLw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-040 --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 09:43:17 INFO - Using env: {'DISPLAY': ':0', 09:43:17 INFO - 'HOME': '/home/cltbld', 09:43:17 INFO - 'LANG': 'en_US.UTF-8', 09:43:17 INFO - 'LANGUAGE': 'en_US:en', 09:43:17 INFO - 'LOGNAME': 'cltbld', 09:43:17 INFO - 'MAIL': '/var/mail/cltbld', 09:43:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:43:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:43:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:43:17 INFO - 'MOZ_NO_REMOTE': '1', 09:43:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:43:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:43:17 INFO - 'NO_EM_RESTART': '1', 09:43:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:43:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:43:17 INFO - 'PWD': '/builds/slave/test', 09:43:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:43:17 INFO - 'SHELL': '/bin/bash', 09:43:17 INFO - 'SHLVL': '1', 09:43:17 INFO - 'TERM': 'linux', 09:43:17 INFO - 'TMOUT': '86400', 09:43:17 INFO - 'USER': 'cltbld', 09:43:17 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1466700047.74863-1396451921', 09:43:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:43:17 INFO - '_': '/tools/buildbot/bin/python'} 09:43:17 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/EcAS53vgTEqzzX_U6f1uLw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-040', '--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 09:43:17 INFO - mozversion application_buildid: 20160623064724 09:43:17 INFO - mozversion application_changeset: 75bb5e9490a0b4a058e92b7da0643df7beddc2b0 09:43:17 INFO - mozversion application_display_name: Firefox 09:43:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:43:17 INFO - mozversion application_name: Firefox 09:43:17 INFO - mozversion application_remotingname: firefox 09:43:17 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 09:43:17 INFO - mozversion application_vendor: Mozilla 09:43:17 INFO - mozversion application_version: 48.0 09:43:17 INFO - mozversion platform_buildid: 20160623064724 09:43:17 INFO - mozversion platform_changeset: 75bb5e9490a0b4a058e92b7da0643df7beddc2b0 09:43:17 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 09:43:17 INFO - mozversion platform_version: 48.0 09:43:17 INFO - using testdate: 1466700197 09:43:17 INFO - actual date: 1466700197 09:43:17 INFO - starting webserver on 'localhost:58040' 09:43:17 INFO - SUITE-START | Running 2 tests 09:43:17 INFO - TEST-START | dromaeo_css 09:43:17 INFO - operating with platform_type : linux_ 09:43:17 INFO - Initialising browser for dromaeo_css test... 09:43:17 INFO - TEST-INFO | started process 18058 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpi6YhZ8/profile http://localhost:58040/getInfo.html) 09:43:21 INFO - PROCESS | 18058 | __metrics Screen width/height:1600/1200 09:43:21 INFO - PROCESS | 18058 | colorDepth:24 09:43:21 INFO - PROCESS | 18058 | Browser inner width/height: 1024/697 09:43:21 INFO - PROCESS | 18058 | __metrics 09:43:22 ERROR - PROCESS | 18058 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 09:43:23 INFO - TEST-INFO | 18058: exit 0 09:43:23 INFO - Browser initialized. 09:43:23 INFO - Running cycle 1/1 for dromaeo_css test... 09:43:23 INFO - TEST-INFO | started process 18148 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpi6YhZ8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:43:35 INFO - PROCESS | 18148 | RSS: Main: 139182080 09:43:35 INFO - PROCESS | 18148 | 09:44:26 INFO - PROCESS | 18148 | 1466700266224 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] 09:46:33 INFO - PROCESS | 18148 | Cycle 1(1): loaded http://localhost:58040/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58040/tests/dromaeo/cssquery-ext.html) 09:46:34 INFO - PROCESS | 18148 | RSS: Main: 249339904 09:46:34 INFO - PROCESS | 18148 | 09:49:37 INFO - PROCESS | 18148 | Cycle 1(1): loaded http://localhost:58040/tests/dromaeo/cssquery-ext.html (next: http://localhost:58040/tests/dromaeo/cssquery-jquery.html) 09:49:37 INFO - PROCESS | 18148 | RSS: Main: 224907264 09:49:37 INFO - PROCESS | 18148 | 09:52:39 INFO - PROCESS | 18148 | Cycle 1(1): loaded http://localhost:58040/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58040/tests/dromaeo/cssquery-mootools.html) 09:52:40 INFO - PROCESS | 18148 | RSS: Main: 228122624 09:52:40 INFO - PROCESS | 18148 | 09:55:41 INFO - PROCESS | 18148 | Cycle 1(1): loaded http://localhost:58040/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58040/tests/dromaeo/cssquery-prototype.html) 09:55:42 INFO - PROCESS | 18148 | RSS: Main: 225349632 09:55:42 INFO - PROCESS | 18148 | 09:58:45 INFO - PROCESS | 18148 | Cycle 1(1): loaded http://localhost:58040/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58040/tests/dromaeo/cssquery-yui.html) 09:58:45 INFO - PROCESS | 18148 | RSS: Main: 210526208 09:58:45 INFO - PROCESS | 18148 | 10:01:47 INFO - PROCESS | 18148 | Cycle 1(1): loaded http://localhost:58040/tests/dromaeo/cssquery-yui.html (next: http://localhost:58040/tests/dromaeo/cssquery-dojo.html) 10:01:48 INFO - PROCESS | 18148 | RSS: Main: 256245760 10:01:48 INFO - PROCESS | 18148 | 10:01:48 INFO - PROCESS | 18148 | __start_tp_report 10:01:48 INFO - PROCESS | 18148 | _x_x_mozilla_page_load 10:01:48 INFO - PROCESS | 18148 | _x_x_mozilla_page_load_details 10:01:48 INFO - PROCESS | 18148 | |i|pagename|runs| 10:01:48 INFO - PROCESS | 18148 | |0;dojo.html;3252.0406480088373;3311.917202069948;3322.269100797824;3337.46600543913;3362.562866827312;5472.616916815825;5484.808031718886;5507.421720719327;5508;5509.035918714219;5478.972605136979;5521.834344969648;5522.861928451791;5534.972325138378;5557.972210138943;4879;4966.52817982292;5048.066107770056;5094.31226784383;5128.5640720538795;4959.752012399384;5044.092063428581;5082.186850103984;5087.389513258414;5095.464976177504;4975.328330675348;5016.372953380827;5081.974590127044;5099.209622508499;5126.666766660173;5107.8467645970495;5149.227615857614;5159.303494028296;5159.948400515985;5189.662671926331;4902.509749025105;4950.183219768734;4962.0075984802825;5044.470330615306;5067.670601410933;5326.094563924142;5382.327209098863;5405.405405405402;5414.7834086636485;5416.322959630046;5849.502792262663;5908.468237858613;5912.4974377178;5913.408659134096;5915.674637894914;5934.43622855828;5961.8807623847715;6030.306514750816;6066.575339726221;6077.453029227391;5547.11246200606;5550.86122846928;5575.330960284751;5575.581831362664;5582.609217354787;5785.71071446426;6040.335563088057;6047.667378294236;6053.243344581927;6058.0610005449225;5829.213056237439;5897.734601942923;5900.114982752536;5910.586258961917;5914.142449344907;5805.506531944748;5811.0121279381765;5813.88372232553;5817.214676018768;5819.912701309484;5695.658260504383;5788.363280039192;5790.247267855152;5796.62321949072;5802.47777700009;5891.3814049525035;5931.110333450017;5937.495312898452;5938.435848594377;5978.701064946736;4542.954570454319;4562.771861406916;4564.018735971716;4564.452265728134;4591.403117594691;4024.4566983456857;4042.2521833460905;4069.267531844237;4090.5295890972325;4120.381942708617;5657.858553536113;5673.574481913873;5679.943200568024;5685.090385538377;5688.459596338341;5914.9112763308585;5917.112433135064;5919.585629005928;5922.585419020627;5924.170616113747;5478.808241711521;5571.582131340166;5576.749046292926;5663.150527420919;5668.829935101953;5049.2426136079885;5074.594032477393;5098.745062746848;5099.5410413063;5103.209002604603;6246.656433896089;6286.49708023357;6294.118823364733;6295.937040629627;6297.181366422427;5735.139729040594;5928.9110663339225;6010.128531363015;6024.307204671343;6049.3950604939155;6247.5001999840815;6258.571250467523;6279.466245369012;6292.590981586182;6295.622262664072;5612.579056570692;5826.126081087871;5836.503897168618;5850.063989761617;5891.086881533369;5843.532517398683;5881.088431292986;5894.70526473666;5903.822885313276;5935.673537955454;5653.236813030353;5665.915011274917;5677.318721753416;5681.119426488901;5689.34572524165;5597.468240517144;5626.409227031103;5688.317401911797;5695.800646977336;5704.258446401941;5600.215969764317;5613.494785469327;5618.69097199658;5619.072852979212;5651.406602306863;5725.5992080555625;5762.94237057624;5764.481196692318;5770;5773.624714393551;5558.221848941071;5558.583106266965;5633.774649014157;5660.85847853807;5701.600887937971 10:01:48 INFO - PROCESS | 18148 | |1;ext.html;663.9535232533722;670.6814263224967;675.3179288918197;736.3005145112145;749.898763666905;33596.832015839915;33772.15569610761;34092.65907340926;39444.21111577774;40327.79836100816;43826;44329.7783511082;44398.66803995885;44406.7779661102;44541;8332.416730828845;8902;9081.682141125062;9089.136532029446;9090.272778177763;10795.892041079607;11073.335599863995;11075;11075.833862492069;11076.556937722482;10616.256862019662;10622.78754424911;10637.308574942643;10697.83953240702;10702.678919632424;10749.570017199303;10831.566737330537;10834.133269338434;10836.349819010884;10855.40295283759;10357.430341331225;10430.061294483457;10461.686149415453;10766.461676916122;10769.83845242322;43341.349879751826;43720;43742.78128609368;43803.78098109489;43884.561154388364;3774.45270435788;3816.274907767543;3906.58980807014;4234.386014027979;4642.210824159867;30031.249218769488;30034;30108;30468.39063218723;31170.688293117004;3951.5455722591696;4602.1946159422305;4617.492075871652;4652.649772462724;4770.475247722748;278652;279770;282007;282300;283813.99999999796;38612.61387386146;39549.209015820095;60855;62018.75962480815;62066;37444.43833342502;37597;37636.05909852275;37651.24697506035;37660.62339376571;16760.916195419188;16847.32610695583;16873.578160546083;16890.071046092336;16930.661386772197;13215.405306761219;14197.290135493184;14352.784708229385;14361.281935903373;14409.567712968628;8956;9031.729048128567;9073.911130664363;9093;9128.041555636695;3519.8416071276856;3589.246258285737;3604.7837129772297;3607.458881167793;3613.9277214456088;1087.9075278601408;1094.7646256054827;1107.9474499225769;1144.9942750286361;1192.8568571771443;28452.573211401846;29692.851535742182;31374.52938205929;31602.209944751565;31642.525362119126;1222.358261912503;1239.7334573066835;1271.332550411023;1288.310753746741;1292.689754458923;16766.497005089866;16926;17078.829211707973;17267.65464690699;17385.47843564695;503255;536861;537599;538336;539404;56928.43071569314;57544.42455575475;57683;57726;57750;1503.6842263124647;1505.1796770759963;1530.958947915406;1567.6629524652026;1606.32534335577;30038.699613004464;30746.077617671504;33606.32787344191;33755.66244337525;33899.83050084734;51412;51853.7407312961;51947.220791687396;52227;52257.7387113062;356550;357499;357801;357846;357951;26985.73014269832;29633.407331853672;29890;30552.236194095327;30636.540451892793;42460.78769606256;42504;43779.78110109556;46131.76934115308;48487;39538.209235814546;39928.60071399249;40615.3907691379;40686.389704153866;41305.1738965225;38892.80553597327;39702.2059558813;39797.2040559193;39804.80097599609;40384.59615403926;41831.37252941269;41862.372064419666;44539.33191002073;45264.77367613141;45474.772626136655;35116;36838.8158059208;37329;37773.62226377701;38221.42667859929;28992.565111522923;29138;29428.705712943454;29431.411371772872;29521.557176641938 10:01:48 INFO - PROCESS | 18148 | |2;jquery.html;410.9054917369004;413.72280572016746;414.42188147534193;422.3474731539771;426.2817153097031;13664.9751268655;18893.149808258626;19458.318958836444;19487.123079461442;19698.90150549249;16540.33838646456;19045.428637140907;19342.709859352122;19474.31839885604;19761.604767904635;5579.7489112990015;5777;5785.190073389729;5810.360860305363;5811.0702287633985;5658.971705141468;5711.343195532505;5716.485516303532;5733.111367738007;5738.741756620962;5422.945770542284;5664.660120392769;5711.571632127586;5713.514351280146;5714.142878568227;5742.196092547047;5753.712314384264;5801.274840644919;5811.883762324751;5822.592418530726;5050.116229659795;5200.583953283766;5220.138677118271;5222.738863056832;5239.554637855748;24318.756812431828;24329.513409731884;24415.389615259584;24839.62740558893;24954.750452495424;2478.429961108937;2612.6472926154916;2673.2247648182006;2676.866156692158;2801.523740964041;14855.034422762486;15422.228888555639;15523.534293971086;15722;15728.05631662104;2025.3417639267298;2098.4229336932467;2102.432343267309;2114.68279758036;2147.1304121830685;77057.61471192609;78803.60598196973;80329.59835200846;81446.59276703697;83414;11375;11822.467988940518;11824.645260642195;11923.821142682868;12000.339981300938;16895.662086758442;17008.48974530766;17011.914940425468;17033.318667253418;17056.06191659446;8989.865152022725;9140.90859091414;9151.17639412456;9188.770280743034;9203.355765096512;7960.4825686330205;8349.165083491724;8811.647534098563;9005.054469280762;9169.220616247694;4716.551927566876;5035.219540971156;5100.2349647553165;5137.614678899023;5202.4277329493725;1984.3253293879861;2042.6629606114825;2093.979060209409;2105.0842883345795;2133.0827744070198;954.1841725324886;1058.7829494953517;1071.3143588103464;1117.0672488472055;1138.6014894786924;19225.423237302904;19325.710114348298;19359.903200483906;19748.70376944347;20258.088386022664;1039.5322105052755;1060.4538662588773;1065.2064212161833;1070.8340207267886;1085.8425528298353;10846.728831779268;11265.943670281596;11273;11280.943595281971;11283.210175287652;585692;590076;591815;599075.7330006239;607236;93868.53065734764;96443;96739;98654.50672746733;98985;1083.111848284415;1097.2812807611188;1153.4694040741185;1173.2139466557428;1177.1465687376583;17123.894901067433;17461.30154793794;17764.911175444042;17838.018908960134;17840.3755868544;37906;38651.6134838648;38897;39777.40333895052;40180.39729404003;52575.73712131568;57807.71096144492;57843;58042.709786452484;58056;8883.555822208993;9115.635374584943;9144.542772861463;9257.76855578589;9402.811943761224;11778.76442471163;14027.438902443788;14100.647483812987;14223;14283.500077497238;11298.378589177673;11662.70843228892;11795.823062653895;12023.146806320663;12459.626211213677;12139.393030348623;12257.080718945936;12415.75168496607;12510.749785004431;12569.1201615886;12096.758064838477;12399.938000309941;12593.370331483573;12745.808812867628;12751.80872286935;8619.166277834516;8982.955085224532;9001.36990410665;9253.259739220981;9399.295052870926;9224.677136300197;12231.388430578258;12232.755344892874;12477.93761031189;12521.624351269476 10:01:48 INFO - PROCESS | 18148 | |3;mootools.html;1437.4825062977334;1570.7328756187128;1592.0447731361185;1784.7679801625786;1903.6192761447705;7453.627318634067;8420.24217820396;8578;8578.571071446426;8588.957055214714;8452.28155606774;8644.265237454823;8644.783880402993;8651.74044778656;8670.566471676406;2473.7402572729875;2497.725250222474;2498.575242208829;2503.1364179358184;2504.6618706474665;2433.9391515212083;2501.2746303571944;2502.2868482482495;2505.7870081043134;2519.0553542421594;2454.460018795871;2455.7667021632915;2460.815438842085;2478.5538603051446;2509.912153074643;2428.465737537748;2447.657327974085;2450.0567281596623;2506.6616006839026;2508.4732206236713;2459.8032157427365;2468.518638865422;2511.3219430753593;2520.4581015081662;2520.7101183363966;8428.8314233715;8601.95699021507;8757.47455152693;8790.077041910636;8800.16398442147;5563.054280772279;5664.348599911022;5675.971620141873;5678.9432105678825;5679.091345384719;3680.6135355787524;3688.8524459021874;3722.4416337549583;3756.8442508293165;3772.245550889833;1155.8439610652622;1166.8483097197395;1174.1311429542163;1177.2406797615577;1224.3878060969516;11918.284902905853;12239.755204895851;12325.815112773225;12338.75322493554;12361.75276494474;4688.859334219979;4746.382970213919;4788.688735232268;4800.183968725325;4829.13075646387;9395.859062114074;9415;9425.811483770287;9429.52852357393;9445.19715824149;5532;5556.694381809039;5576.888462230814;5578.860528486739;5588;4532.592066713945;4648.302754586839;5027.095122877844;5057.69653820772;5204.375474943031;3968.2261958917734;4024.7383920045104;4061.147159096623;4087.7547347159266;4153.646940010072;1207.402335843763;1212.7938250497436;1213;1217.738186289952;1233.6422437493027;943.4103685196752;1069.8555694981233;1080.9135269178446;1085.5006696919347;1089.9400532970603;6314.842128946813;6370.968145159337;6392.360763923571;6448.806535803933;6506.544541882117;480.2436163043221;485.7959656944092;490.4237520912913;491.6189952786619;496.8757810547363;4266.253405653998;4385.122975404868;4435.933460998088;4482.058767658828;4510.616597589176;10490.42302673345;10855.457227138611;10881.891181088246;10915.181361397927;10922.836157457645;10596.947015265028;10693.304935179189;10698.946505267424;10718.464076796128;10742.3017503862;7976.082750483769;8196.672133114727;8202.26179643835;8207.876881846778;8209;5856.59003869725;6182.69086545662;6183.0107182850525;6188.783392581238;6253.874922501615;9531.237501000041;9532.428054316762;9565.091316324939;9716.611335546499;9722.319437639297;9624.518774061129;9769.755756106155;9831.115199632068;10035.297529172887;10041.196704263495;6888.965555172192;6954.687039083355;7397.889031664422;7825.882611760714;8007.879881801894;8292.253697167283;8364.456310339809;8398.370122240734;8442.366822488215;8478.067412584487;7546.169921308761;7761.7671469855995;7841.4118941078505;7888;7907.367410607253;7638.8090297743;7703.768886933401;7707.152213256425;7773.222677732181;7859.331956783509;7165.211826698955;7204.783856484314;7213.6032518212005;7245.5652660840515;7251.927480725125;4661.394018777537;4800.303955926441;4836.709797412166;5187.740612969412;5336.012837625051;5339.3058902344;5346.705931173823;5354.9464505354445;5378.97310513445;5480.095784195563 10:01:48 INFO - PROCESS | 18148 | |4;prototype.html;353.3727633450625;353.45214916878814;354.3338523575677;357.91410061585213;358.67539876411854;6054.909176362353;6058.3941605839445;6069.302030266521;6130.632162070267;6165.136880836675;6069.848253793657;6080.391960803918;6087.117367981651;6099.359567245442;6105.023196288595;4437.290033594618;4591.609713174367;4678.90642187156;4698;4709.740964246965;4668.019715859674;4678.929816052762;4692.835750748724;4704.1062198182235;4711.835085771999;4390.473143222818;4634.2353511670535;4640.930386044212;4649.302604609302;4655.557722016403;4509.4814096379005;4628.976855115703;4636.814527418899;4641.582257596799;4662.603678687298;4074.0833312504747;4083.081306705997;4090.447789548403;4092;4094.160697057096;5840.211571437844;5841.1238314253205;5842.386549412336;5846.532277417797;5859.560532960045;5390.865228369283;5424.1321388577635;5429.429909859447;5431.21247419122;5438.347398312228;6424.325445828167;6433.613983161025;6439.484841212692;6444.581102228341;6456.515761317873;4285.185814695229;4385.311655012812;4441.533638967894;4442.444694413199;4444.911101777946;6616.371444712745;6709.664516774142;6713.832154196135;6724.058631791553;6726.293739157416;4569.908601827945;4575.816967321336;4577.290519969343;4579.358889755437;4586.72479651222;4637.814487420465;4641.489436162019;4644.117617652635;4644.16405047088;4645.349651048856;5368.91946620801;5369.973150134224;5370.570354371641;5375.086235340002;5375.892482150335;6235.376462353728;6375.489960803125;6411.294757576663;6494.772682956168;6501.609903405811;1599.872010239178;1609.1230279497702;1620.1980019889995;1620.69206850698;1622.4321487479524;999.3454287441738;1045.2683121814607;1064.1912146768511;1065.5311662868314;1073.7208325835338;6174.783882564088;6178.969105154445;6180.721867515973;6181.258249010148;6182.876342473215;6480.31956644555;6593.80218593443;6614.404703576605;6619.602823830489;6623.602583844985;6260.186175797117;6261.467775239155;6262.091996660459;6272.247330320391;6280.654563998933;3522.5068490411363;3559.6974257187912;3564.2336897567147;3570.428731403015;3573.446115852047;6800.979853022086;6942.271061538567;7096.077509923677;7098.751543695946;7124.8575028499135;6866.485013623998;6887.793366199022;6890.44876409886;6891;6893.655317234118;7073.434125269966;7076.433885289164;7089.89365159523;7092.361687448154;7096.432285417154;6713.395794378529;6719.126513553207;6724.865502689821;6728.327167283428;6729.596224226562;6476.902846457213;6601.570897891814;6608.735650574115;6631.204255489372;6635.966820165868;7008.544444611084;7037.612931288828;7039.084918960502;7049.682764275723;7053.894191587027;4487.371767952424;4530.569595888385;4535.501094879494;4536.818527259004;4537.500874903824;6661.300563440963;6679.899801503078;6710.932890671031;6750.0212469192675;6755.729770809113;6368.1532355616355;6439.67801609927;6480;6488.9026664601015;6491.28595854465;6468.935310646833;6522.934770652422;6548.443382312556;6552.443042341454;6554.639494827639;6371.426571608577;6375.489960803217;6375.776847810304;6376.107344971615;6385;6527.412532872065;6530.771423000172;6532.771353002622;6540.117084193573;6544.574602650812;6032.90950635732;6116.908246376219;6317.336679648754;6399;6420.550561460653 10:01:48 INFO - PROCESS | 18148 | |5;yui.html;864.6411739128262;907.3149771922202;925.2644147902417;930.9627614895396;934.5093825741487;16049.358025678974;16137.596560085989;16171.676566468663;17371.999999999967;17735;16283.511494655178;16379.672406551861;16437.342506299763;16440.588985275375;16459.094749788786;789.7867575754572;929.7675581104724;935.9344845860793;936.0171819589438;938.2306508662899;918.2516249256835;919.5080631861955;920.2270093121776;921.2261700171854;921.5760750054983;973.4062222044547;979.7207795778205;979.7844474215661;979.9167070798991;980.3186785184299;816.3183741575821;966.4491239993137;966.5022513405602;968.4963818814213;980.4215512847454;721.2318880392418;722.1370462297557;727.705279361854;727.9417646588261;728.5191773429511;14663.41346346145;14681.926590367086;14715.11709297435;14721.852781472155;14732.484363047242;13994.510192143227;14335.56993290203;14610.926945365312;15105.622359440991;15190.316435760416;12358.876411235862;12403.503859845596;12438.253704777742;12453.066020048533;12648.936755316257;3929.587393323717;3959.366501359769;3992.7803970781597;3996.9600303997167;4022.4368588397647;57053;57065.71467142638;57256;57262.427375726125;57412.425875741545;11439.485223164978;11509.597164099216;11559.36423496699;11680;11754.471048802825;20088.39734807958;20155.193792248145;20163.495912602008;20165.09257083435;20167.59664806725;8721.30229581632;9022.323325750594;9070.818583628423;9448.244140468883;9476.573554190078;4905.754712264373;5064.569511591482;5201.167813149954;5284.04887120322;5295.311609490742;3775.301569209705;3855.4987851579117;3856.826442810024;3860.6718428933855;3862.729608927348;639.6194264412667;680.3298750730527;695.2526034512919;701.0185739964091;707.784125841613;694.2467422846167;750.3696894608446;817.9918200817916;848.6520526584071;850.2347886901838;9870.25973052024;10063.798724025624;10369.896301037044;10442.947785261025;10459.68620941373;768.8663957517932;771.864923638361;793.0919097633293;798.6246464161835;828.941974061822;4783.1868582341085;4821.710697358099;4856.41722993236;4899.069176856386;4954.851354459372;67219;67812;68028.31971680319;68029.65985170043;68129.3187068123;56901.723931043125;58303.41696583065;59144.40855591475;59407;59622.40377596255;52566.47433525692;53163;53262;53596.464035359924;54387;9801.411915285105;9869.950650246703;9879.456629885426;9912.801743965225;9930.404175749478;39769.60230397659;40026.799866001646;40384.37501562389;40398.19203615852;40537.79731101326;47328;47810.521894780606;51845.7407712959;52315.73842130765;52539;11935.283882967049;12042.473454091192;12432.191907525981;12908.16096953695;13154.73690526165;14276.286185690882;14462.421503139756;14955.102693838404;15237;15541.067535947426;13202.141860779018;14014.36935337892;14257.358418870968;14555.92722036383;14795.038322509003;13317.600471985856;13441.865581344062;13733;14238.359273832495;14556.563303100924;13630.46904614659;13739;13925.232245279243;14069.577912662637;14551.126932384092;11175.273607215506;11341.20611557216;11384.943075284571;11427.542898284308;11583.247088939192;11842.407879606157;11964.58123965657;12064.698382540155;12237.938810305892;12268.202566833485 10:01:48 INFO - PROCESS | 18148 | __end_tp_report 10:01:48 INFO - PROCESS | 18148 | __start_cc_report 10:01:48 INFO - PROCESS | 18148 | _x_x_mozilla_cycle_collect,840 10:01:48 INFO - PROCESS | 18148 | __end_cc_report 10:01:48 INFO - PROCESS | 18148 | __startTimestamp1466701308182__endTimestamp 10:01:48 INFO - PROCESS | 18148 | 10:01:48 INFO - PROCESS | 18148 | ------- Summary: start ------- 10:01:48 INFO - PROCESS | 18148 | Number of tests: 6 10:01:48 INFO - PROCESS | 18148 | 10:01:48 INFO - PROCESS | 18148 | [#0] dojo.html Cycles:165 Average:5495.23 Median:5663.15 stddev:609.25 (10.8%) stddev-sans-first:585.15 10:01:48 INFO - PROCESS | 18148 | Values: 3252.0 3311.9 3322.3 3337.5 3362.6 5472.6 5484.8 5507.4 5508.0 5509.0 5479.0 5521.8 5522.9 5535.0 5558.0 4879.0 4966.5 5048.1 5094.3 5128.6 4959.8 5044.1 5082.2 5087.4 5095.5 4975.3 5016.4 5082.0 5099.2 5126.7 5107.8 5149.2 5159.3 5159.9 5189.7 4902.5 4950.2 4962.0 5044.5 5067.7 5326.1 5382.3 5405.4 5414.8 5416.3 5849.5 5908.5 5912.5 5913.4 5915.7 5934.4 5961.9 6030.3 6066.6 6077.5 5547.1 5550.9 5575.3 5575.6 5582.6 5785.7 6040.3 6047.7 6053.2 6058.1 5829.2 5897.7 5900.1 5910.6 5914.1 5805.5 5811.0 5813.9 5817.2 5819.9 5695.7 5788.4 5790.2 5796.6 5802.5 5891.4 5931.1 5937.5 5938.4 5978.7 4543.0 4562.8 4564.0 4564.5 4591.4 4024.5 4042.3 4069.3 4090.5 4120.4 5657.9 5673.6 5679.9 5685.1 5688.5 5914.9 5917.1 5919.6 5922.6 5924.2 5478.8 5571.6 5576.7 5663.2 5668.8 5049.2 5074.6 5098.7 5099.5 5103.2 6246.7 6286.5 6294.1 6295.9 6297.2 5735.1 5928.9 6010.1 6024.3 6049.4 6247.5 6258.6 6279.5 6292.6 6295.6 5612.6 5826.1 5836.5 5850.1 5891.1 5843.5 5881.1 5894.7 5903.8 5935.7 5653.2 5665.9 5677.3 5681.1 5689.3 5597.5 5626.4 5688.3 5695.8 5704.3 5600.2 5613.5 5618.7 5619.1 5651.4 5725.6 5762.9 5764.5 5770.0 5773.6 5558.2 5558.6 5633.8 5660.9 5701.6 10:01:48 INFO - PROCESS | 18148 | 10:01:48 INFO - PROCESS | 18148 | [#1] ext.html Cycles:180 Average:54932.01 Median:3597.01 stddev:107107.80 (2977.7%) stddev-sans-first:107330.77 10:01:48 INFO - PROCESS | 18148 | Values: 664.0 670.7 675.3 736.3 749.9 33596.8 33772.2 34092.7 39444.2 40327.8 43826.0 44329.8 44398.7 44406.8 44541.0 8332.4 8902.0 9081.7 9089.1 9090.3 10795.9 11073.3 11075.0 11075.8 11076.6 10616.3 10622.8 10637.3 10697.8 10702.7 10749.6 10831.6 10834.1 10836.3 10855.4 10357.4 10430.1 10461.7 10766.5 10769.8 43341.3 43720.0 43742.8 43803.8 43884.6 3774.5 3816.3 3906.6 4234.4 4642.2 30031.2 30034.0 30108.0 30468.4 31170.7 3951.5 4602.2 4617.5 4652.6 4770.5 278652.0 279770.0 282007.0 282300.0 283814.0 38612.6 39549.2 60855.0 62018.8 62066.0 37444.4 37597.0 37636.1 37651.2 37660.6 16760.9 16847.3 16873.6 16890.1 16930.7 13215.4 14197.3 14352.8 14361.3 14409.6 8956.0 9031.7 9073.9 9093.0 9128.0 3519.8 3589.2 3604.8 3607.5 3613.9 1087.9 1094.8 1107.9 1145.0 1192.9 28452.6 29692.9 31374.5 31602.2 31642.5 1222.4 1239.7 1271.3 1288.3 1292.7 16766.5 16926.0 17078.8 17267.7 17385.5 503255.0 536861.0 537599.0 538336.0 539404.0 56928.4 57544.4 57683.0 57726.0 57750.0 1503.7 1505.2 1531.0 1567.7 1606.3 30038.7 30746.1 33606.3 33755.7 33899.8 51412.0 51853.7 51947.2 52227.0 52257.7 356550.0 357499.0 357801.0 357846.0 357951.0 26985.7 29633.4 29890.0 30552.2 30636.5 42460.8 42504.0 43779.8 46131.8 48487.0 39538.2 39928.6 40615.4 40686.4 41305.2 38892.8 39702.2 39797.2 39804.8 40384.6 41831.4 41862.4 44539.3 45264.8 45474.8 35116.0 36838.8 37329.0 37773.6 38221.4 28992.6 29138.0 29428.7 29431.4 29521.6 10:01:48 INFO - PROCESS | 18148 | 10:01:48 INFO - PROCESS | 18148 | [#2] jquery.html Cycles:180 Average:32331.54 Median:13446.91 stddev:97579.92 (725.7%) stddev-sans-first:97824.22 10:01:48 INFO - PROCESS | 18148 | Values: 410.9 413.7 414.4 422.3 426.3 13665.0 18893.1 19458.3 19487.1 19698.9 16540.3 19045.4 19342.7 19474.3 19761.6 5579.7 5777.0 5785.2 5810.4 5811.1 5659.0 5711.3 5716.5 5733.1 5738.7 5422.9 5664.7 5711.6 5713.5 5714.1 5742.2 5753.7 5801.3 5811.9 5822.6 5050.1 5200.6 5220.1 5222.7 5239.6 24318.8 24329.5 24415.4 24839.6 24954.8 2478.4 2612.6 2673.2 2676.9 2801.5 14855.0 15422.2 15523.5 15722.0 15728.1 2025.3 2098.4 2102.4 2114.7 2147.1 77057.6 78803.6 80329.6 81446.6 83414.0 11375.0 11822.5 11824.6 11923.8 12000.3 16895.7 17008.5 17011.9 17033.3 17056.1 8989.9 9140.9 9151.2 9188.8 9203.4 7960.5 8349.2 8811.6 9005.1 9169.2 4716.6 5035.2 5100.2 5137.6 5202.4 1984.3 2042.7 2094.0 2105.1 2133.1 954.2 1058.8 1071.3 1117.1 1138.6 19225.4 19325.7 19359.9 19748.7 20258.1 1039.5 1060.5 1065.2 1070.8 1085.8 10846.7 11265.9 11273.0 11280.9 11283.2 585692.0 590076.0 591815.0 599075.7 607236.0 93868.5 96443.0 96739.0 98654.5 98985.0 1083.1 1097.3 1153.5 1173.2 1177.1 17123.9 17461.3 17764.9 17838.0 17840.4 37906.0 38651.6 38897.0 39777.4 40180.4 52575.7 57807.7 57843.0 58042.7 58056.0 8883.6 9115.6 9144.5 9257.8 9402.8 11778.8 14027.4 14100.6 14223.0 14283.5 11298.4 11662.7 11795.8 12023.1 12459.6 12139.4 12257.1 12415.8 12510.7 12569.1 12096.8 12399.9 12593.4 12745.8 12751.8 8619.2 8983.0 9001.4 9253.3 9399.3 9224.7 12231.4 12232.8 12477.9 12521.6 10:01:48 INFO - PROCESS | 18148 | 10:01:48 INFO - PROCESS | 18148 | [#3] mootools.html Cycles:180 Average:5804.09 Median:2761.99 stddev:3172.47 (114.9%) stddev-sans-first:3164.39 10:01:48 INFO - PROCESS | 18148 | Values: 1437.5 1570.7 1592.0 1784.8 1903.6 7453.6 8420.2 8578.0 8578.6 8589.0 8452.3 8644.3 8644.8 8651.7 8670.6 2473.7 2497.7 2498.6 2503.1 2504.7 2433.9 2501.3 2502.3 2505.8 2519.1 2454.5 2455.8 2460.8 2478.6 2509.9 2428.5 2447.7 2450.1 2506.7 2508.5 2459.8 2468.5 2511.3 2520.5 2520.7 8428.8 8602.0 8757.5 8790.1 8800.2 5563.1 5664.3 5676.0 5678.9 5679.1 3680.6 3688.9 3722.4 3756.8 3772.2 1155.8 1166.8 1174.1 1177.2 1224.4 11918.3 12239.8 12325.8 12338.8 12361.8 4688.9 4746.4 4788.7 4800.2 4829.1 9395.9 9415.0 9425.8 9429.5 9445.2 5532.0 5556.7 5576.9 5578.9 5588.0 4532.6 4648.3 5027.1 5057.7 5204.4 3968.2 4024.7 4061.1 4087.8 4153.6 1207.4 1212.8 1213.0 1217.7 1233.6 943.4 1069.9 1080.9 1085.5 1089.9 6314.8 6371.0 6392.4 6448.8 6506.5 480.2 485.8 490.4 491.6 496.9 4266.3 4385.1 4435.9 4482.1 4510.6 10490.4 10855.5 10881.9 10915.2 10922.8 10596.9 10693.3 10698.9 10718.5 10742.3 7976.1 8196.7 8202.3 8207.9 8209.0 5856.6 6182.7 6183.0 6188.8 6253.9 9531.2 9532.4 9565.1 9716.6 9722.3 9624.5 9769.8 9831.1 10035.3 10041.2 6889.0 6954.7 7397.9 7825.9 8007.9 8292.3 8364.5 8398.4 8442.4 8478.1 7546.2 7761.8 7841.4 7888.0 7907.4 7638.8 7703.8 7707.2 7773.2 7859.3 7165.2 7204.8 7213.6 7245.6 7251.9 4661.4 4800.3 4836.7 5187.7 5336.0 5339.3 5346.7 5354.9 5379.0 5480.1 10:01:48 INFO - PROCESS | 18148 | 10:01:48 INFO - PROCESS | 18148 | [#4] prototype.html Cycles:180 Average:5414.83 Median:6169.96 stddev:1650.92 (26.8%) stddev-sans-first:1611.25 10:01:48 INFO - PROCESS | 18148 | Values: 353.4 353.5 354.3 357.9 358.7 6054.9 6058.4 6069.3 6130.6 6165.1 6069.8 6080.4 6087.1 6099.4 6105.0 4437.3 4591.6 4678.9 4698.0 4709.7 4668.0 4678.9 4692.8 4704.1 4711.8 4390.5 4634.2 4640.9 4649.3 4655.6 4509.5 4629.0 4636.8 4641.6 4662.6 4074.1 4083.1 4090.4 4092.0 4094.2 5840.2 5841.1 5842.4 5846.5 5859.6 5390.9 5424.1 5429.4 5431.2 5438.3 6424.3 6433.6 6439.5 6444.6 6456.5 4285.2 4385.3 4441.5 4442.4 4444.9 6616.4 6709.7 6713.8 6724.1 6726.3 4569.9 4575.8 4577.3 4579.4 4586.7 4637.8 4641.5 4644.1 4644.2 4645.3 5368.9 5370.0 5370.6 5375.1 5375.9 6235.4 6375.5 6411.3 6494.8 6501.6 1599.9 1609.1 1620.2 1620.7 1622.4 999.3 1045.3 1064.2 1065.5 1073.7 6174.8 6179.0 6180.7 6181.3 6182.9 6480.3 6593.8 6614.4 6619.6 6623.6 6260.2 6261.5 6262.1 6272.2 6280.7 3522.5 3559.7 3564.2 3570.4 3573.4 6801.0 6942.3 7096.1 7098.8 7124.9 6866.5 6887.8 6890.4 6891.0 6893.7 7073.4 7076.4 7089.9 7092.4 7096.4 6713.4 6719.1 6724.9 6728.3 6729.6 6476.9 6601.6 6608.7 6631.2 6636.0 7008.5 7037.6 7039.1 7049.7 7053.9 4487.4 4530.6 4535.5 4536.8 4537.5 6661.3 6679.9 6710.9 6750.0 6755.7 6368.2 6439.7 6480.0 6488.9 6491.3 6468.9 6522.9 6548.4 6552.4 6554.6 6371.4 6375.5 6375.8 6376.1 6385.0 6527.4 6530.8 6532.8 6540.1 6544.6 6032.9 6116.9 6317.3 6399.0 6420.6 10:01:48 INFO - PROCESS | 18148 | 10:01:48 INFO - PROCESS | 18148 | [#5] yui.html Cycles:180 Average:16165.67 Median:26296.85 stddev:18471.18 (70.2%) stddev-sans-first:18487.25 10:01:48 INFO - PROCESS | 18148 | Values: 864.6 907.3 925.3 931.0 934.5 16049.4 16137.6 16171.7 17372.0 17735.0 16283.5 16379.7 16437.3 16440.6 16459.1 789.8 929.8 935.9 936.0 938.2 918.3 919.5 920.2 921.2 921.6 973.4 979.7 979.8 979.9 980.3 816.3 966.4 966.5 968.5 980.4 721.2 722.1 727.7 727.9 728.5 14663.4 14681.9 14715.1 14721.9 14732.5 13994.5 14335.6 14610.9 15105.6 15190.3 12358.9 12403.5 12438.3 12453.1 12648.9 3929.6 3959.4 3992.8 3997.0 4022.4 57053.0 57065.7 57256.0 57262.4 57412.4 11439.5 11509.6 11559.4 11680.0 11754.5 20088.4 20155.2 20163.5 20165.1 20167.6 8721.3 9022.3 9070.8 9448.2 9476.6 4905.8 5064.6 5201.2 5284.0 5295.3 3775.3 3855.5 3856.8 3860.7 3862.7 639.6 680.3 695.3 701.0 707.8 694.2 750.4 818.0 848.7 850.2 9870.3 10063.8 10369.9 10442.9 10459.7 768.9 771.9 793.1 798.6 828.9 4783.2 4821.7 4856.4 4899.1 4954.9 67219.0 67812.0 68028.3 68029.7 68129.3 56901.7 58303.4 59144.4 59407.0 59622.4 52566.5 53163.0 53262.0 53596.5 54387.0 9801.4 9870.0 9879.5 9912.8 9930.4 39769.6 40026.8 40384.4 40398.2 40537.8 47328.0 47810.5 51845.7 52315.7 52539.0 11935.3 12042.5 12432.2 12908.2 13154.7 14276.3 14462.4 14955.1 15237.0 15541.1 13202.1 14014.4 14257.4 14555.9 14795.0 13317.6 13441.9 13733.0 14238.4 14556.6 13630.5 13739.0 13925.2 14069.6 14551.1 11175.3 11341.2 11384.9 11427.5 11583.2 11842.4 11964.6 12064.7 12237.9 12268.2 10:01:48 INFO - PROCESS | 18148 | -------- Summary: end -------- 10:01:48 INFO - PROCESS | 18148 | 10:01:48 INFO - TEST-INFO | 18148: exit 0 10:01:48 INFO - TEST-OK | dromaeo_css | took 1111014ms 10:01:48 INFO - TEST-START | kraken 10:01:48 INFO - operating with platform_type : linux_ 10:01:48 INFO - Initialising browser for kraken test... 10:01:48 INFO - TEST-INFO | started process 18337 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCGZZx0/profile http://localhost:58040/getInfo.html) 10:01:52 INFO - PROCESS | 18337 | __metrics Screen width/height:1600/1200 10:01:52 INFO - PROCESS | 18337 | colorDepth:24 10:01:52 INFO - PROCESS | 18337 | Browser inner width/height: 1024/697 10:01:52 INFO - PROCESS | 18337 | __metrics 10:01:53 ERROR - PROCESS | 18337 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:01:54 INFO - TEST-INFO | 18337: exit 0 10:01:54 INFO - Browser initialized. 10:01:54 INFO - Running cycle 1/1 for kraken test... 10:01:54 INFO - TEST-INFO | started process 18430 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCGZZx0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:02:06 INFO - PROCESS | 18430 | RSS: Main: 139894784 10:02:06 INFO - PROCESS | 18430 | 10:02:08 INFO - PROCESS | 18430 | Cycle 1(1): loaded http://localhost:58040/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58040/tests/kraken/driver.html?testName=audio-beat-detection) 10:02:09 INFO - PROCESS | 18430 | RSS: Main: 197652480 10:02:09 INFO - PROCESS | 18430 | 10:02:11 INFO - PROCESS | 18430 | Cycle 1(1): loaded http://localhost:58040/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58040/tests/kraken/driver.html?testName=audio-dft) 10:02:12 INFO - PROCESS | 18430 | RSS: Main: 184840192 10:02:12 INFO - PROCESS | 18430 | 10:02:15 INFO - PROCESS | 18430 | Cycle 1(1): loaded http://localhost:58040/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58040/tests/kraken/driver.html?testName=audio-fft) 10:02:15 INFO - PROCESS | 18430 | RSS: Main: 274276352 10:02:15 INFO - PROCESS | 18430 | 10:02:18 INFO - PROCESS | 18430 | Cycle 1(1): loaded http://localhost:58040/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58040/tests/kraken/driver.html?testName=audio-oscillator) 10:02:18 INFO - PROCESS | 18430 | RSS: Main: 180461568 10:02:18 INFO - PROCESS | 18430 | 10:02:20 INFO - PROCESS | 18430 | Cycle 1(1): loaded http://localhost:58040/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58040/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:02:21 INFO - PROCESS | 18430 | RSS: Main: 179326976 10:02:21 INFO - PROCESS | 18430 | 10:02:24 INFO - PROCESS | 18430 | Cycle 1(1): loaded http://localhost:58040/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58040/tests/kraken/driver.html?testName=imaging-darkroom) 10:02:24 INFO - PROCESS | 18430 | RSS: Main: 213991424 10:02:24 INFO - PROCESS | 18430 | 10:02:28 INFO - PROCESS | 18430 | Cycle 1(1): loaded http://localhost:58040/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58040/tests/kraken/driver.html?testName=imaging-desaturate) 10:02:28 INFO - PROCESS | 18430 | RSS: Main: 213176320 10:02:28 INFO - PROCESS | 18430 | 10:02:31 INFO - PROCESS | 18430 | Cycle 1(1): loaded http://localhost:58040/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58040/tests/kraken/driver.html?testName=json-parse-financial) 10:02:32 INFO - PROCESS | 18430 | RSS: Main: 213282816 10:02:32 INFO - PROCESS | 18430 | 10:02:33 INFO - PROCESS | 18430 | Cycle 1(1): loaded http://localhost:58040/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58040/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:02:34 INFO - PROCESS | 18430 | RSS: Main: 193097728 10:02:34 INFO - PROCESS | 18430 | 10:02:35 INFO - PROCESS | 18430 | Cycle 1(1): loaded http://localhost:58040/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58040/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:02:36 INFO - PROCESS | 18430 | RSS: Main: 197758976 10:02:36 INFO - PROCESS | 18430 | 10:02:38 INFO - PROCESS | 18430 | Cycle 1(1): loaded http://localhost:58040/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58040/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:02:39 INFO - PROCESS | 18430 | RSS: Main: 210673664 10:02:39 INFO - PROCESS | 18430 | 10:02:41 INFO - PROCESS | 18430 | Cycle 1(1): loaded http://localhost:58040/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58040/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:02:42 INFO - PROCESS | 18430 | RSS: Main: 218947584 10:02:42 INFO - PROCESS | 18430 | 10:02:44 INFO - PROCESS | 18430 | Cycle 1(1): loaded http://localhost:58040/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58040/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:02:45 INFO - PROCESS | 18430 | RSS: Main: 213819392 10:02:45 INFO - PROCESS | 18430 | 10:02:47 INFO - PROCESS | 18430 | Cycle 1(1): loaded http://localhost:58040/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58040/tests/kraken/driver.html?testName=ai-astar) 10:02:47 INFO - PROCESS | 18430 | RSS: Main: 274444288 10:02:47 INFO - PROCESS | 18430 | 10:02:47 INFO - PROCESS | 18430 | __start_tp_report 10:02:47 INFO - PROCESS | 18430 | _x_x_mozilla_page_load 10:02:47 INFO - PROCESS | 18430 | _x_x_mozilla_page_load_details 10:02:47 INFO - PROCESS | 18430 | |i|pagename|runs| 10:02:47 INFO - PROCESS | 18430 | |0;ai-astar;113;111;109;108;110;112;108;110;109;110 10:02:47 INFO - PROCESS | 18430 | |1;audio-beat-detection;160;124;163;180;129;155;152;127;194;126 10:02:47 INFO - PROCESS | 18430 | |2;audio-dft;162;162;161;161;161;162;164;160;162;160 10:02:47 INFO - PROCESS | 18430 | |3;audio-fft;76;76;76;168;76;75;76;77;165;76 10:02:47 INFO - PROCESS | 18430 | |4;audio-oscillator;93;93;152;91;92;93;146;91;92;152 10:02:47 INFO - PROCESS | 18430 | |5;imaging-gaussian-blur;117;117;117;116;116;116;116;117;117;116 10:02:47 INFO - PROCESS | 18430 | |6;imaging-darkroom;145;145;145;145;146;146;146;145;145;146 10:02:47 INFO - PROCESS | 18430 | |7;imaging-desaturate;94;101;95;95;95;96;95;96;94;95 10:02:47 INFO - PROCESS | 18430 | |8;json-parse-financial;54;55;56;54;57;55;55;74;53;54 10:02:47 INFO - PROCESS | 18430 | |9;json-stringify-tinderbox;57;61;59;59;59;58;58;61;59;58 10:02:47 INFO - PROCESS | 18430 | |10;stanford-crypto-aes;72;72;72;73;75;74;73;74;73;73 10:02:47 INFO - PROCESS | 18430 | |11;stanford-crypto-ccm;121;113;110;112;114;109;110;111;126;124 10:02:47 INFO - PROCESS | 18430 | |12;stanford-crypto-pbkdf2;160;158;160;156;156;160;163;157;156;159 10:02:47 INFO - PROCESS | 18430 | |13;stanford-crypto-sha256-iterative;67;66;66;67;68;66;70;67;65;66 10:02:47 INFO - PROCESS | 18430 | __end_tp_report 10:02:47 INFO - PROCESS | 18430 | __start_cc_report 10:02:47 INFO - PROCESS | 18430 | _x_x_mozilla_cycle_collect,1636 10:02:47 INFO - PROCESS | 18430 | __end_cc_report 10:02:47 INFO - PROCESS | 18430 | __startTimestamp1466701367296__endTimestamp 10:02:47 INFO - PROCESS | 18430 | 10:02:47 INFO - PROCESS | 18430 | ------- Summary: start ------- 10:02:47 INFO - PROCESS | 18430 | Number of tests: 14 10:02:47 INFO - PROCESS | 18430 | 10:02:47 INFO - PROCESS | 18430 | [#0] ai-astar Cycles:10 Average:110.00 Median:110.00 stddev:1.63 (1.5%) stddev-sans-first:1.32 10:02:47 INFO - PROCESS | 18430 | Values: 113.0 111.0 109.0 108.0 110.0 112.0 108.0 110.0 109.0 110.0 10:02:47 INFO - PROCESS | 18430 | 10:02:47 INFO - PROCESS | 18430 | [#1] audio-beat-detection Cycles:10 Average:151.00 Median:157.50 stddev:24.37 (15.5%) stddev-sans-first:25.63 10:02:47 INFO - PROCESS | 18430 | Values: 160.0 124.0 163.0 180.0 129.0 155.0 152.0 127.0 194.0 126.0 10:02:47 INFO - PROCESS | 18430 | 10:02:47 INFO - PROCESS | 18430 | [#2] audio-dft Cycles:10 Average:161.50 Median:162.00 stddev:1.18 (0.7%) stddev-sans-first:1.24 10:02:47 INFO - PROCESS | 18430 | Values: 162.0 162.0 161.0 161.0 161.0 162.0 164.0 160.0 162.0 160.0 10:02:47 INFO - PROCESS | 18430 | 10:02:47 INFO - PROCESS | 18430 | [#3] audio-fft Cycles:10 Average:94.10 Median:76.00 stddev:38.17 (50.2%) stddev-sans-first:39.92 10:02:47 INFO - PROCESS | 18430 | Values: 76.0 76.0 76.0 168.0 76.0 75.0 76.0 77.0 165.0 76.0 10:02:47 INFO - PROCESS | 18430 | 10:02:47 INFO - PROCESS | 18430 | [#4] audio-oscillator Cycles:10 Average:109.50 Median:92.00 stddev:28.00 (30.4%) stddev-sans-first:29.06 10:02:47 INFO - PROCESS | 18430 | Values: 93.0 93.0 152.0 91.0 92.0 93.0 146.0 91.0 92.0 152.0 10:02:47 INFO - PROCESS | 18430 | 10:02:47 INFO - PROCESS | 18430 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:117.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 10:02:47 INFO - PROCESS | 18430 | Values: 117.0 117.0 117.0 116.0 116.0 116.0 116.0 117.0 117.0 116.0 10:02:47 INFO - PROCESS | 18430 | 10:02:47 INFO - PROCESS | 18430 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 10:02:47 INFO - PROCESS | 18430 | Values: 145.0 145.0 145.0 145.0 146.0 146.0 146.0 145.0 145.0 146.0 10:02:47 INFO - PROCESS | 18430 | 10:02:47 INFO - PROCESS | 18430 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:95.00 stddev:2.01 (2.1%) stddev-sans-first:2.05 10:02:47 INFO - PROCESS | 18430 | Values: 94.0 101.0 95.0 95.0 95.0 96.0 95.0 96.0 94.0 95.0 10:02:47 INFO - PROCESS | 18430 | 10:02:47 INFO - PROCESS | 18430 | [#8] json-parse-financial Cycles:10 Average:56.70 Median:55.00 stddev:6.18 (11.2%) stddev-sans-first:6.48 10:02:47 INFO - PROCESS | 18430 | Values: 54.0 55.0 56.0 54.0 57.0 55.0 55.0 74.0 53.0 54.0 10:02:47 INFO - PROCESS | 18430 | 10:02:47 INFO - PROCESS | 18430 | [#9] json-stringify-tinderbox Cycles:10 Average:58.90 Median:59.00 stddev:1.29 (2.2%) stddev-sans-first:1.17 10:02:47 INFO - PROCESS | 18430 | Values: 57.0 61.0 59.0 59.0 59.0 58.0 58.0 61.0 59.0 58.0 10:02:47 INFO - PROCESS | 18430 | 10:02:47 INFO - PROCESS | 18430 | [#10] stanford-crypto-aes Cycles:10 Average:73.10 Median:73.00 stddev:0.99 (1.4%) stddev-sans-first:0.97 10:02:47 INFO - PROCESS | 18430 | Values: 72.0 72.0 72.0 73.0 75.0 74.0 73.0 74.0 73.0 73.0 10:02:47 INFO - PROCESS | 18430 | 10:02:47 INFO - PROCESS | 18430 | [#11] stanford-crypto-ccm Cycles:10 Average:115.00 Median:113.50 stddev:6.27 (5.5%) stddev-sans-first:6.26 10:02:47 INFO - PROCESS | 18430 | Values: 121.0 113.0 110.0 112.0 114.0 109.0 110.0 111.0 126.0 124.0 10:02:47 INFO - PROCESS | 18430 | 10:02:47 INFO - PROCESS | 18430 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.50 Median:159.50 stddev:2.32 (1.5%) stddev-sans-first:2.40 10:02:47 INFO - PROCESS | 18430 | Values: 160.0 158.0 160.0 156.0 156.0 160.0 163.0 157.0 156.0 159.0 10:02:47 INFO - PROCESS | 18430 | 10:02:47 INFO - PROCESS | 18430 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:67.00 stddev:1.40 (2.1%) stddev-sans-first:1.48 10:02:47 INFO - PROCESS | 18430 | Values: 67.0 66.0 66.0 67.0 68.0 66.0 70.0 67.0 65.0 66.0 10:02:47 INFO - PROCESS | 18430 | -------- Summary: end -------- 10:02:47 INFO - PROCESS | 18430 | 10:02:48 INFO - TEST-INFO | 18430: exit 0 10:02:48 INFO - TEST-OK | kraken | took 59313ms 10:02:48 INFO - SUITE-END | took 1170s 10:02:48 INFO - Completed test suite (00:19:30) 10:02:48 INFO - javascript benchmark 10:02:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3252.0406480088373, 3311.917202069948, 3322.269100797824, 3337.46600543913, 3362.562866827312, 5472.616916815825, 5484.808031718886, 5507.421720719327, 5508.0, 5509.035918714219, 5478.972605136979, 5521.834344969648, 5522.861928451791, 5534.972325138378, 5557.972210138943, 4879.0, 4966.52817982292, 5048.066107770056, 5094.31226784383, 5128.5640720538795, 4959.752012399384, 5044.092063428581, 5082.186850103984, 5087.389513258414, 5095.464976177504, 4975.328330675348, 5016.372953380827, 5081.974590127044, 5099.209622508499, 5126.666766660173, 5107.8467645970495, 5149.227615857614, 5159.303494028296, 5159.948400515985, 5189.662671926331, 4902.509749025105, 4950.183219768734, 4962.0075984802825, 5044.470330615306, 5067.670601410933, 5326.094563924142, 5382.327209098863, 5405.405405405402, 5414.7834086636485, 5416.322959630046, 5849.502792262663, 5908.468237858613, 5912.4974377178, 5913.408659134096, 5915.674637894914, 5934.43622855828, 5961.8807623847715, 6030.306514750816, 6066.575339726221, 6077.453029227391, 5547.11246200606, 5550.86122846928, 5575.330960284751, 5575.581831362664, 5582.609217354787, 5785.71071446426, 6040.335563088057, 6047.667378294236, 6053.243344581927, 6058.0610005449225, 5829.213056237439, 5897.734601942923, 5900.114982752536, 5910.586258961917, 5914.142449344907, 5805.506531944748, 5811.0121279381765, 5813.88372232553, 5817.214676018768, 5819.912701309484, 5695.658260504383, 5788.363280039192, 5790.247267855152, 5796.62321949072, 5802.47777700009, 5891.3814049525035, 5931.110333450017, 5937.495312898452, 5938.435848594377, 5978.701064946736, 4542.954570454319, 4562.771861406916, 4564.018735971716, 4564.452265728134, 4591.403117594691, 4024.4566983456857, 4042.2521833460905, 4069.267531844237, 4090.5295890972325, 4120.381942708617, 5657.858553536113, 5673.574481913873, 5679.943200568024, 5685.090385538377, 5688.459596338341, 5914.9112763308585, 5917.112433135064, 5919.585629005928, 5922.585419020627, 5924.170616113747, 5478.808241711521, 5571.582131340166, 5576.749046292926, 5663.150527420919, 5668.829935101953, 5049.2426136079885, 5074.594032477393, 5098.745062746848, 5099.5410413063, 5103.209002604603, 6246.656433896089, 6286.49708023357, 6294.118823364733, 6295.937040629627, 6297.181366422427, 5735.139729040594, 5928.9110663339225, 6010.128531363015, 6024.307204671343, 6049.3950604939155, 6247.5001999840815, 6258.571250467523, 6279.466245369012, 6292.590981586182, 6295.622262664072, 5612.579056570692, 5826.126081087871, 5836.503897168618, 5850.063989761617, 5891.086881533369, 5843.532517398683, 5881.088431292986, 5894.70526473666, 5903.822885313276, 5935.673537955454, 5653.236813030353, 5665.915011274917, 5677.318721753416, 5681.119426488901, 5689.34572524165, 5597.468240517144, 5626.409227031103, 5688.317401911797, 5695.800646977336, 5704.258446401941, 5600.215969764317, 5613.494785469327, 5618.69097199658, 5619.072852979212, 5651.406602306863, 5725.5992080555625, 5762.94237057624, 5764.481196692318, 5770.0, 5773.624714393551, 5558.221848941071, 5558.583106266965, 5633.774649014157, 5660.85847853807, 5701.600887937971], "value": 5455.907350726968, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [663.9535232533722, 670.6814263224967, 675.3179288918197, 736.3005145112145, 749.898763666905, 33596.832015839915, 33772.15569610761, 34092.65907340926, 39444.21111577774, 40327.79836100816, 43826.0, 44329.7783511082, 44398.66803995885, 44406.7779661102, 44541.0, 8332.416730828845, 8902.0, 9081.682141125062, 9089.136532029446, 9090.272778177763, 10795.892041079607, 11073.335599863995, 11075.0, 11075.833862492069, 11076.556937722482, 10616.256862019662, 10622.78754424911, 10637.308574942643, 10697.83953240702, 10702.678919632424, 10749.570017199303, 10831.566737330537, 10834.133269338434, 10836.349819010884, 10855.40295283759, 10357.430341331225, 10430.061294483457, 10461.686149415453, 10766.461676916122, 10769.83845242322, 43341.349879751826, 43720.0, 43742.78128609368, 43803.78098109489, 43884.561154388364, 3774.45270435788, 3816.274907767543, 3906.58980807014, 4234.386014027979, 4642.210824159867, 30031.249218769488, 30034.0, 30108.0, 30468.39063218723, 31170.688293117004, 3951.5455722591696, 4602.1946159422305, 4617.492075871652, 4652.649772462724, 4770.475247722748, 278652.0, 279770.0, 282007.0, 282300.0, 283813.99999999796, 38612.61387386146, 39549.209015820095, 60855.0, 62018.75962480815, 62066.0, 37444.43833342502, 37597.0, 37636.05909852275, 37651.24697506035, 37660.62339376571, 16760.916195419188, 16847.32610695583, 16873.578160546083, 16890.071046092336, 16930.661386772197, 13215.405306761219, 14197.290135493184, 14352.784708229385, 14361.281935903373, 14409.567712968628, 8956.0, 9031.729048128567, 9073.911130664363, 9093.0, 9128.041555636695, 3519.8416071276856, 3589.246258285737, 3604.7837129772297, 3607.458881167793, 3613.9277214456088, 1087.9075278601408, 1094.7646256054827, 1107.9474499225769, 1144.9942750286361, 1192.8568571771443, 28452.573211401846, 29692.851535742182, 31374.52938205929, 31602.209944751565, 31642.525362119126, 1222.358261912503, 1239.7334573066835, 1271.332550411023, 1288.310753746741, 1292.689754458923, 16766.497005089866, 16926.0, 17078.829211707973, 17267.65464690699, 17385.47843564695, 503255.0, 536861.0, 537599.0, 538336.0, 539404.0, 56928.43071569314, 57544.42455575475, 57683.0, 57726.0, 57750.0, 1503.6842263124647, 1505.1796770759963, 1530.958947915406, 1567.6629524652026, 1606.32534335577, 30038.699613004464, 30746.077617671504, 33606.32787344191, 33755.66244337525, 33899.83050084734, 51412.0, 51853.7407312961, 51947.220791687396, 52227.0, 52257.7387113062, 356550.0, 357499.0, 357801.0, 357846.0, 357951.0, 26985.73014269832, 29633.407331853672, 29890.0, 30552.236194095327, 30636.540451892793, 42460.78769606256, 42504.0, 43779.78110109556, 46131.76934115308, 48487.0, 39538.209235814546, 39928.60071399249, 40615.3907691379, 40686.389704153866, 41305.1738965225, 38892.80553597327, 39702.2059558813, 39797.2040559193, 39804.80097599609, 40384.59615403926, 41831.37252941269, 41862.372064419666, 44539.33191002073, 45264.77367613141, 45474.772626136655, 35116.0, 36838.8158059208, 37329.0, 37773.62226377701, 38221.42667859929, 28992.565111522923, 29138.0, 29428.705712943454, 29431.411371772872, 29521.557176641938], "value": 19544.314577983758, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [410.9054917369004, 413.72280572016746, 414.42188147534193, 422.3474731539771, 426.2817153097031, 13664.9751268655, 18893.149808258626, 19458.318958836444, 19487.123079461442, 19698.90150549249, 16540.33838646456, 19045.428637140907, 19342.709859352122, 19474.31839885604, 19761.604767904635, 5579.7489112990015, 5777.0, 5785.190073389729, 5810.360860305363, 5811.0702287633985, 5658.971705141468, 5711.343195532505, 5716.485516303532, 5733.111367738007, 5738.741756620962, 5422.945770542284, 5664.660120392769, 5711.571632127586, 5713.514351280146, 5714.142878568227, 5742.196092547047, 5753.712314384264, 5801.274840644919, 5811.883762324751, 5822.592418530726, 5050.116229659795, 5200.583953283766, 5220.138677118271, 5222.738863056832, 5239.554637855748, 24318.756812431828, 24329.513409731884, 24415.389615259584, 24839.62740558893, 24954.750452495424, 2478.429961108937, 2612.6472926154916, 2673.2247648182006, 2676.866156692158, 2801.523740964041, 14855.034422762486, 15422.228888555639, 15523.534293971086, 15722.0, 15728.05631662104, 2025.3417639267298, 2098.4229336932467, 2102.432343267309, 2114.68279758036, 2147.1304121830685, 77057.61471192609, 78803.60598196973, 80329.59835200846, 81446.59276703697, 83414.0, 11375.0, 11822.467988940518, 11824.645260642195, 11923.821142682868, 12000.339981300938, 16895.662086758442, 17008.48974530766, 17011.914940425468, 17033.318667253418, 17056.06191659446, 8989.865152022725, 9140.90859091414, 9151.17639412456, 9188.770280743034, 9203.355765096512, 7960.4825686330205, 8349.165083491724, 8811.647534098563, 9005.054469280762, 9169.220616247694, 4716.551927566876, 5035.219540971156, 5100.2349647553165, 5137.614678899023, 5202.4277329493725, 1984.3253293879861, 2042.6629606114825, 2093.979060209409, 2105.0842883345795, 2133.0827744070198, 954.1841725324886, 1058.7829494953517, 1071.3143588103464, 1117.0672488472055, 1138.6014894786924, 19225.423237302904, 19325.710114348298, 19359.903200483906, 19748.70376944347, 20258.088386022664, 1039.5322105052755, 1060.4538662588773, 1065.2064212161833, 1070.8340207267886, 1085.8425528298353, 10846.728831779268, 11265.943670281596, 11273.0, 11280.943595281971, 11283.210175287652, 585692.0, 590076.0, 591815.0, 599075.7330006239, 607236.0, 93868.53065734764, 96443.0, 96739.0, 98654.50672746733, 98985.0, 1083.111848284415, 1097.2812807611188, 1153.4694040741185, 1173.2139466557428, 1177.1465687376583, 17123.894901067433, 17461.30154793794, 17764.911175444042, 17838.018908960134, 17840.3755868544, 37906.0, 38651.6134838648, 38897.0, 39777.40333895052, 40180.39729404003, 52575.73712131568, 57807.71096144492, 57843.0, 58042.709786452484, 58056.0, 8883.555822208993, 9115.635374584943, 9144.542772861463, 9257.76855578589, 9402.811943761224, 11778.76442471163, 14027.438902443788, 14100.647483812987, 14223.0, 14283.500077497238, 11298.378589177673, 11662.70843228892, 11795.823062653895, 12023.146806320663, 12459.626211213677, 12139.393030348623, 12257.080718945936, 12415.75168496607, 12510.749785004431, 12569.1201615886, 12096.758064838477, 12399.938000309941, 12593.370331483573, 12745.808812867628, 12751.80872286935, 8619.166277834516, 8982.955085224532, 9001.36990410665, 9253.259739220981, 9399.295052870926, 9224.677136300197, 12231.388430578258, 12232.755344892874, 12477.93761031189, 12521.624351269476], "value": 9713.376843028025, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1437.4825062977334, 1570.7328756187128, 1592.0447731361185, 1784.7679801625786, 1903.6192761447705, 7453.627318634067, 8420.24217820396, 8578.0, 8578.571071446426, 8588.957055214714, 8452.28155606774, 8644.265237454823, 8644.783880402993, 8651.74044778656, 8670.566471676406, 2473.7402572729875, 2497.725250222474, 2498.575242208829, 2503.1364179358184, 2504.6618706474665, 2433.9391515212083, 2501.2746303571944, 2502.2868482482495, 2505.7870081043134, 2519.0553542421594, 2454.460018795871, 2455.7667021632915, 2460.815438842085, 2478.5538603051446, 2509.912153074643, 2428.465737537748, 2447.657327974085, 2450.0567281596623, 2506.6616006839026, 2508.4732206236713, 2459.8032157427365, 2468.518638865422, 2511.3219430753593, 2520.4581015081662, 2520.7101183363966, 8428.8314233715, 8601.95699021507, 8757.47455152693, 8790.077041910636, 8800.16398442147, 5563.054280772279, 5664.348599911022, 5675.971620141873, 5678.9432105678825, 5679.091345384719, 3680.6135355787524, 3688.8524459021874, 3722.4416337549583, 3756.8442508293165, 3772.245550889833, 1155.8439610652622, 1166.8483097197395, 1174.1311429542163, 1177.2406797615577, 1224.3878060969516, 11918.284902905853, 12239.755204895851, 12325.815112773225, 12338.75322493554, 12361.75276494474, 4688.859334219979, 4746.382970213919, 4788.688735232268, 4800.183968725325, 4829.13075646387, 9395.859062114074, 9415.0, 9425.811483770287, 9429.52852357393, 9445.19715824149, 5532.0, 5556.694381809039, 5576.888462230814, 5578.860528486739, 5588.0, 4532.592066713945, 4648.302754586839, 5027.095122877844, 5057.69653820772, 5204.375474943031, 3968.2261958917734, 4024.7383920045104, 4061.147159096623, 4087.7547347159266, 4153.646940010072, 1207.402335843763, 1212.7938250497436, 1213.0, 1217.738186289952, 1233.6422437493027, 943.4103685196752, 1069.8555694981233, 1080.9135269178446, 1085.5006696919347, 1089.9400532970603, 6314.842128946813, 6370.968145159337, 6392.360763923571, 6448.806535803933, 6506.544541882117, 480.2436163043221, 485.7959656944092, 490.4237520912913, 491.6189952786619, 496.8757810547363, 4266.253405653998, 4385.122975404868, 4435.933460998088, 4482.058767658828, 4510.616597589176, 10490.42302673345, 10855.457227138611, 10881.891181088246, 10915.181361397927, 10922.836157457645, 10596.947015265028, 10693.304935179189, 10698.946505267424, 10718.464076796128, 10742.3017503862, 7976.082750483769, 8196.672133114727, 8202.26179643835, 8207.876881846778, 8209.0, 5856.59003869725, 6182.69086545662, 6183.0107182850525, 6188.783392581238, 6253.874922501615, 9531.237501000041, 9532.428054316762, 9565.091316324939, 9716.611335546499, 9722.319437639297, 9624.518774061129, 9769.755756106155, 9831.115199632068, 10035.297529172887, 10041.196704263495, 6888.965555172192, 6954.687039083355, 7397.889031664422, 7825.882611760714, 8007.879881801894, 8292.253697167283, 8364.456310339809, 8398.370122240734, 8442.366822488215, 8478.067412584487, 7546.169921308761, 7761.7671469855995, 7841.4118941078505, 7888.0, 7907.367410607253, 7638.8090297743, 7703.768886933401, 7707.152213256425, 7773.222677732181, 7859.331956783509, 7165.211826698955, 7204.783856484314, 7213.6032518212005, 7245.5652660840515, 7251.927480725125, 4661.394018777537, 4800.303955926441, 4836.709797412166, 5187.740612969412, 5336.012837625051, 5339.3058902344, 5346.705931173823, 5354.9464505354445, 5378.97310513445, 5480.095784195563], "value": 4646.794074900272, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [353.3727633450625, 353.45214916878814, 354.3338523575677, 357.91410061585213, 358.67539876411854, 6054.909176362353, 6058.3941605839445, 6069.302030266521, 6130.632162070267, 6165.136880836675, 6069.848253793657, 6080.391960803918, 6087.117367981651, 6099.359567245442, 6105.023196288595, 4437.290033594618, 4591.609713174367, 4678.90642187156, 4698.0, 4709.740964246965, 4668.019715859674, 4678.929816052762, 4692.835750748724, 4704.1062198182235, 4711.835085771999, 4390.473143222818, 4634.2353511670535, 4640.930386044212, 4649.302604609302, 4655.557722016403, 4509.4814096379005, 4628.976855115703, 4636.814527418899, 4641.582257596799, 4662.603678687298, 4074.0833312504747, 4083.081306705997, 4090.447789548403, 4092.0, 4094.160697057096, 5840.211571437844, 5841.1238314253205, 5842.386549412336, 5846.532277417797, 5859.560532960045, 5390.865228369283, 5424.1321388577635, 5429.429909859447, 5431.21247419122, 5438.347398312228, 6424.325445828167, 6433.613983161025, 6439.484841212692, 6444.581102228341, 6456.515761317873, 4285.185814695229, 4385.311655012812, 4441.533638967894, 4442.444694413199, 4444.911101777946, 6616.371444712745, 6709.664516774142, 6713.832154196135, 6724.058631791553, 6726.293739157416, 4569.908601827945, 4575.816967321336, 4577.290519969343, 4579.358889755437, 4586.72479651222, 4637.814487420465, 4641.489436162019, 4644.117617652635, 4644.16405047088, 4645.349651048856, 5368.91946620801, 5369.973150134224, 5370.570354371641, 5375.086235340002, 5375.892482150335, 6235.376462353728, 6375.489960803125, 6411.294757576663, 6494.772682956168, 6501.609903405811, 1599.872010239178, 1609.1230279497702, 1620.1980019889995, 1620.69206850698, 1622.4321487479524, 999.3454287441738, 1045.2683121814607, 1064.1912146768511, 1065.5311662868314, 1073.7208325835338, 6174.783882564088, 6178.969105154445, 6180.721867515973, 6181.258249010148, 6182.876342473215, 6480.31956644555, 6593.80218593443, 6614.404703576605, 6619.602823830489, 6623.602583844985, 6260.186175797117, 6261.467775239155, 6262.091996660459, 6272.247330320391, 6280.654563998933, 3522.5068490411363, 3559.6974257187912, 3564.2336897567147, 3570.428731403015, 3573.446115852047, 6800.979853022086, 6942.271061538567, 7096.077509923677, 7098.751543695946, 7124.8575028499135, 6866.485013623998, 6887.793366199022, 6890.44876409886, 6891.0, 6893.655317234118, 7073.434125269966, 7076.433885289164, 7089.89365159523, 7092.361687448154, 7096.432285417154, 6713.395794378529, 6719.126513553207, 6724.865502689821, 6728.327167283428, 6729.596224226562, 6476.902846457213, 6601.570897891814, 6608.735650574115, 6631.204255489372, 6635.966820165868, 7008.544444611084, 7037.612931288828, 7039.084918960502, 7049.682764275723, 7053.894191587027, 4487.371767952424, 4530.569595888385, 4535.501094879494, 4536.818527259004, 4537.500874903824, 6661.300563440963, 6679.899801503078, 6710.932890671031, 6750.0212469192675, 6755.729770809113, 6368.1532355616355, 6439.67801609927, 6480.0, 6488.9026664601015, 6491.28595854465, 6468.935310646833, 6522.934770652422, 6548.443382312556, 6552.443042341454, 6554.639494827639, 6371.426571608577, 6375.489960803217, 6375.776847810304, 6376.107344971615, 6385.0, 6527.412532872065, 6530.771423000172, 6532.771353002622, 6540.117084193573, 6544.574602650812, 6032.90950635732, 6116.908246376219, 6317.336679648754, 6399.0, 6420.550561460653], "value": 4878.278841962826, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [864.6411739128262, 907.3149771922202, 925.2644147902417, 930.9627614895396, 934.5093825741487, 16049.358025678974, 16137.596560085989, 16171.676566468663, 17371.999999999967, 17735.0, 16283.511494655178, 16379.672406551861, 16437.342506299763, 16440.588985275375, 16459.094749788786, 789.7867575754572, 929.7675581104724, 935.9344845860793, 936.0171819589438, 938.2306508662899, 918.2516249256835, 919.5080631861955, 920.2270093121776, 921.2261700171854, 921.5760750054983, 973.4062222044547, 979.7207795778205, 979.7844474215661, 979.9167070798991, 980.3186785184299, 816.3183741575821, 966.4491239993137, 966.5022513405602, 968.4963818814213, 980.4215512847454, 721.2318880392418, 722.1370462297557, 727.705279361854, 727.9417646588261, 728.5191773429511, 14663.41346346145, 14681.926590367086, 14715.11709297435, 14721.852781472155, 14732.484363047242, 13994.510192143227, 14335.56993290203, 14610.926945365312, 15105.622359440991, 15190.316435760416, 12358.876411235862, 12403.503859845596, 12438.253704777742, 12453.066020048533, 12648.936755316257, 3929.587393323717, 3959.366501359769, 3992.7803970781597, 3996.9600303997167, 4022.4368588397647, 57053.0, 57065.71467142638, 57256.0, 57262.427375726125, 57412.425875741545, 11439.485223164978, 11509.597164099216, 11559.36423496699, 11680.0, 11754.471048802825, 20088.39734807958, 20155.193792248145, 20163.495912602008, 20165.09257083435, 20167.59664806725, 8721.30229581632, 9022.323325750594, 9070.818583628423, 9448.244140468883, 9476.573554190078, 4905.754712264373, 5064.569511591482, 5201.167813149954, 5284.04887120322, 5295.311609490742, 3775.301569209705, 3855.4987851579117, 3856.826442810024, 3860.6718428933855, 3862.729608927348, 639.6194264412667, 680.3298750730527, 695.2526034512919, 701.0185739964091, 707.784125841613, 694.2467422846167, 750.3696894608446, 817.9918200817916, 848.6520526584071, 850.2347886901838, 9870.25973052024, 10063.798724025624, 10369.896301037044, 10442.947785261025, 10459.68620941373, 768.8663957517932, 771.864923638361, 793.0919097633293, 798.6246464161835, 828.941974061822, 4783.1868582341085, 4821.710697358099, 4856.41722993236, 4899.069176856386, 4954.851354459372, 67219.0, 67812.0, 68028.31971680319, 68029.65985170043, 68129.3187068123, 56901.723931043125, 58303.41696583065, 59144.40855591475, 59407.0, 59622.40377596255, 52566.47433525692, 53163.0, 53262.0, 53596.464035359924, 54387.0, 9801.411915285105, 9869.950650246703, 9879.456629885426, 9912.801743965225, 9930.404175749478, 39769.60230397659, 40026.799866001646, 40384.37501562389, 40398.19203615852, 40537.79731101326, 47328.0, 47810.521894780606, 51845.7407712959, 52315.73842130765, 52539.0, 11935.283882967049, 12042.473454091192, 12432.191907525981, 12908.16096953695, 13154.73690526165, 14276.286185690882, 14462.421503139756, 14955.102693838404, 15237.0, 15541.067535947426, 13202.141860779018, 14014.36935337892, 14257.358418870968, 14555.92722036383, 14795.038322509003, 13317.600471985856, 13441.865581344062, 13733.0, 14238.359273832495, 14556.563303100924, 13630.46904614659, 13739.0, 13925.232245279243, 14069.577912662637, 14551.126932384092, 11175.273607215506, 11341.20611557216, 11384.943075284571, 11427.542898284308, 11583.247088939192, 11842.407879606157, 11964.58123965657, 12064.698382540155, 12237.938810305892, 12268.202566833485], "value": 7434.109879075645, "unit": "score"}], "name": "dromaeo_css", "value": 7475.798613055056, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 111.0, 109.0, 108.0, 110.0, 112.0, 108.0, 110.0, 109.0, 110.0], "value": 110.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 124.0, 163.0, 180.0, 129.0, 155.0, 152.0, 127.0, 194.0, 126.0], "value": 151.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 161.0, 161.0, 161.0, 162.0, 164.0, 160.0, 162.0, 160.0], "value": 161.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 168.0, 76.0, 75.0, 76.0, 77.0, 165.0, 76.0], "value": 94.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 152.0, 91.0, 92.0, 93.0, 146.0, 91.0, 92.0, 152.0], "value": 109.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 116.0, 116.0, 116.0, 117.0, 117.0, 116.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 145.0, 145.0, 146.0, 146.0, 146.0, 145.0, 145.0, 146.0], "value": 145.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 101.0, 95.0, 95.0, 95.0, 96.0, 95.0, 96.0, 94.0, 95.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 56.0, 54.0, 57.0, 55.0, 55.0, 74.0, 53.0, 54.0], "value": 56.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 61.0, 59.0, 59.0, 59.0, 58.0, 58.0, 61.0, 59.0, 58.0], "value": 58.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 72.0, 72.0, 73.0, 75.0, 74.0, 73.0, 74.0, 73.0, 73.0], "value": 73.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 113.0, 110.0, 112.0, 114.0, 109.0, 110.0, 111.0, 126.0, 124.0], "value": 115.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 158.0, 160.0, 156.0, 156.0, 160.0, 163.0, 157.0, 156.0, 159.0], "value": 158.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 66.0, 67.0, 68.0, 66.0, 70.0, 67.0, 65.0, 66.0], "value": 66.8, "unit": "score"}], "name": "kraken", "value": 1512.6, "alertThreshold": 2.0}]} 10:02:48 INFO - Return code: 0 10:02:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:02:48 ERROR - # TBPL SUCCESS # 10:02:48 INFO - Running post-action listener: _resource_record_post_action 10:02:48 INFO - Running post-run listener: _resource_record_post_run 10:02:49 INFO - Total resource usage - Wall time: 1185s; CPU: 13.0%; Read bytes: 4096; Write bytes: 477351936; Read time: 8; Write time: 411280 10:02:49 INFO - install - Wall time: 14s; CPU: 16.0%; Read bytes: 0; Write bytes: 254156800; Read time: 0; Write time: 312820 10:02:49 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 4096; Write bytes: 223195136; Read time: 8; Write time: 98460 10:02:49 INFO - Running post-run listener: _upload_blobber_files 10:02:49 INFO - Blob upload gear active. 10:02:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:02:49 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 10:02:49 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'] 10:02:49 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 10:02:50 INFO - (blobuploader) - INFO - Open directory for files ... 10:02:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:02:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:02:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:02:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:02:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:02:50 INFO - (blobuploader) - INFO - Done attempting. 10:02:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:02:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:02:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:02:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:02:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:02:51 INFO - (blobuploader) - INFO - Done attempting. 10:02:51 INFO - (blobuploader) - INFO - Iteration through files over. 10:02:51 INFO - Return code: 0 10:02:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:02:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:02:51 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/893c597402326b2b86bcd31376fe24fa6440a787feb2af1a8a39ead8ab4894a92d0b1d9394528a9e6ef58dc1157e178ed3fef44ad690a4c70e3e278f5f93b4b9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/95ec6d366afb6cf4a6084a9e6f45025f7c0c2f6db69423f8405d04cd6361c67dfd4d8e643622a6d2014c77a2d30258e07a9b9a55c30a2c6e7b47c3bd42252f65"} 10:02:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:02:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:02:51 INFO - Contents: 10:02:51 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/893c597402326b2b86bcd31376fe24fa6440a787feb2af1a8a39ead8ab4894a92d0b1d9394528a9e6ef58dc1157e178ed3fef44ad690a4c70e3e278f5f93b4b9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/95ec6d366afb6cf4a6084a9e6f45025f7c0c2f6db69423f8405d04cd6361c67dfd4d8e643622a6d2014c77a2d30258e07a9b9a55c30a2c6e7b47c3bd42252f65"} 10:02:51 INFO - Running post-run listener: copy_logs_to_upload_dir 10:02:51 INFO - Copying logs to upload dir... 10:02:51 INFO - mkdir: /builds/slave/test/build/upload/logs 10:02:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1224.943270 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 24 secs) (at 2016-06-23 10:02:51.542573) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-23 10:02:51.546268) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1466700047.74863-1396451921 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/893c597402326b2b86bcd31376fe24fa6440a787feb2af1a8a39ead8ab4894a92d0b1d9394528a9e6ef58dc1157e178ed3fef44ad690a4c70e3e278f5f93b4b9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/95ec6d366afb6cf4a6084a9e6f45025f7c0c2f6db69423f8405d04cd6361c67dfd4d8e643622a6d2014c77a2d30258e07a9b9a55c30a2c6e7b47c3bd42252f65"} build_url:https://queue.taskcluster.net/v1/task/EcAS53vgTEqzzX_U6f1uLw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011271 build_url: 'https://queue.taskcluster.net/v1/task/EcAS53vgTEqzzX_U6f1uLw/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/893c597402326b2b86bcd31376fe24fa6440a787feb2af1a8a39ead8ab4894a92d0b1d9394528a9e6ef58dc1157e178ed3fef44ad690a4c70e3e278f5f93b4b9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/95ec6d366afb6cf4a6084a9e6f45025f7c0c2f6db69423f8405d04cd6361c67dfd4d8e643622a6d2014c77a2d30258e07a9b9a55c30a2c6e7b47c3bd42252f65"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-23 10:02:51.578282) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 10:02:51.578870) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1466700047.74863-1396451921 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004547 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 10:02:51.661314) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-23 10:02:51.661843) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-23 10:02:51.662201) ========= ========= Total master_lag: 0.19 =========