builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-064 starttime: 1464644357.66 results: success (0) buildid: 20160530120549 builduid: 7997d47d310b490c9d491deb39fe4327 revision: 3c7a33fe0b6472bf47264c2390c5bc19f1a6dce4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-30 14:39:17.662798) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-30 14:39:17.663435) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-30 14:39:17.663757) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-30 14:39:17.686176) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 14:39:17.686623) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a12cd81e0ef515edd9e0d800000001bb-1464644336.425281-1609355336 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-30 14:39:18-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 25.6M=0s 2016-05-30 14:39:18 (25.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.112214 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 14:39:17.813228) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 14:39:17.813582) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a12cd81e0ef515edd9e0d800000001bb-1464644336.425281-1609355336 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022900 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 14:39:17.863545) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 14:39:17.863907) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 3c7a33fe0b6472bf47264c2390c5bc19f1a6dce4 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 3c7a33fe0b6472bf47264c2390c5bc19f1a6dce4 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a12cd81e0ef515edd9e0d800000001bb-1464644336.425281-1609355336 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-30 14:39:18,638 truncating revision to first 12 chars 2016-05-30 14:39:18,638 Setting DEBUG logging. 2016-05-30 14:39:18,638 attempt 1/10 2016-05-30 14:39:18,638 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/3c7a33fe0b64?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-30 14:39:18,968 unpacking tar archive at: mozilla-aurora-3c7a33fe0b64/testing/mozharness/ program finished with exit code 0 elapsedTime=0.668754 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 14:39:18.546354) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-30 14:39:18.546687) ========= script_repo_revision: 3c7a33fe0b6472bf47264c2390c5bc19f1a6dce4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-30 14:39:18.547095) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-30 14:39:18.547377) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-30 14:39:18.557824) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-05-30 14:39:18.558252) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a12cd81e0ef515edd9e0d800000001bb-1464644336.425281-1609355336 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:39:19 INFO - MultiFileLogger online at 20160530 14:39:19 in /builds/slave/test 14:39:19 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 14:39:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:39:19 INFO - {'append_to_log': False, 14:39:19 INFO - 'base_work_dir': '/builds/slave/test', 14:39:19 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 14:39:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:39:19 INFO - 'branch': 'Mozilla-Aurora', 14:39:19 INFO - 'buildbot_json_path': 'buildprops.json', 14:39:19 INFO - 'config_files': ('talos/linux_config.py',), 14:39:19 INFO - 'default_actions': ('clobber', 14:39:19 INFO - 'read-buildbot-config', 14:39:19 INFO - 'download-and-extract', 14:39:19 INFO - 'populate-webroot', 14:39:19 INFO - 'create-virtualenv', 14:39:19 INFO - 'install', 14:39:19 INFO - 'run-tests'), 14:39:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:39:19 INFO - 'download_minidump_stackwalk': True, 14:39:19 INFO - 'download_symbols': 'ondemand', 14:39:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:39:19 INFO - 'tooltool.py': '/tools/tooltool.py', 14:39:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:39:19 INFO - '/tools/misc-python/virtualenv.py')}, 14:39:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:39:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:39:19 INFO - 'installer_path': 'installer.exe', 14:39:19 INFO - 'log_level': 'info', 14:39:19 INFO - 'log_name': 'talos', 14:39:19 INFO - 'log_to_console': True, 14:39:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:39:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:39:19 INFO - 'opt_config_files': (), 14:39:19 INFO - 'pip_index': False, 14:39:19 INFO - 'sps_profile': False, 14:39:19 INFO - 'sps_profile_interval': 0, 14:39:19 INFO - 'suite': 'dromaeojs-e10s', 14:39:19 INFO - 'system_bits': '32', 14:39:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:39:19 INFO - 'title': 'talos-linux64-ix-064', 14:39:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:39:19 INFO - 'use_talos_json': True, 14:39:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:39:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:39:19 INFO - 'work_dir': 'build'} 14:39:19 INFO - ##### 14:39:19 INFO - ##### Running clobber step. 14:39:19 INFO - ##### 14:39:19 INFO - Running pre-action listener: _resource_record_pre_action 14:39:19 INFO - Running main action method: clobber 14:39:19 INFO - rmtree: /builds/slave/test/build 14:39:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:39:19 INFO - Running post-action listener: _resource_record_post_action 14:39:19 INFO - ##### 14:39:19 INFO - ##### Running read-buildbot-config step. 14:39:19 INFO - ##### 14:39:19 INFO - Running pre-action listener: _resource_record_pre_action 14:39:19 INFO - Running main action method: read_buildbot_config 14:39:19 INFO - Using buildbot properties: 14:39:19 INFO - { 14:39:19 INFO - "project": "", 14:39:19 INFO - "product": "firefox", 14:39:19 INFO - "script_repo_revision": "production", 14:39:19 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 14:39:19 INFO - "repository": "", 14:39:19 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 14:39:19 INFO - "buildid": "20160530120549", 14:39:19 INFO - "pgo_build": "True", 14:39:19 INFO - "basedir": "/builds/slave/test", 14:39:19 INFO - "buildnumber": 312, 14:39:19 INFO - "slavename": "talos-linux64-ix-064", 14:39:19 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 14:39:19 INFO - "platform": "ubuntu64_hw", 14:39:19 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 14:39:19 INFO - "branch": "mozilla-aurora", 14:39:19 INFO - "repo_path": "releases/mozilla-aurora", 14:39:19 INFO - "revision": "3c7a33fe0b6472bf47264c2390c5bc19f1a6dce4", 14:39:19 INFO - "stage_platform": "linux64-pgo", 14:39:19 INFO - "builduid": "7997d47d310b490c9d491deb39fe4327", 14:39:19 INFO - "slavebuilddir": "test" 14:39:19 INFO - } 14:39:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 14:39:19 INFO - Running post-action listener: _resource_record_post_action 14:39:19 INFO - ##### 14:39:19 INFO - ##### Running download-and-extract step. 14:39:19 INFO - ##### 14:39:19 INFO - Running pre-action listener: _resource_record_pre_action 14:39:19 INFO - Running main action method: download_and_extract 14:39:19 INFO - mkdir: /builds/slave/test/build/tests 14:39:19 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')]} 14:39:19 INFO - https://queue.taskcluster.net/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 14:39:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 14:39:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 14:39:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 14:39:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 14:39:20 INFO - Downloaded 1361 bytes. 14:39:20 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 14:39:20 INFO - Using the following test package requirements: 14:39:20 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 14:39:20 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 14:39:20 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 14:39:20 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 14:39:20 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 14:39:20 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 14:39:20 INFO - u'jsshell-linux-x86_64.zip'], 14:39:20 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 14:39:20 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 14:39:20 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 14:39:20 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 14:39:20 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 14:39:20 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 14:39:20 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 14:39:20 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 14:39:20 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 14:39:20 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 14:39:20 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 14:39:20 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:39:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:39:20 INFO - https://queue.taskcluster.net/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:39:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 14:39:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 14:39:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 14:39:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:39:23 INFO - Downloaded 24173994 bytes. 14:39:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:39:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:39:25 INFO - Return code: 0 14:39:25 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 14:39:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:39:25 INFO - https://queue.taskcluster.net/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:39:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 14:39:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 14:39:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 14:39:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:39:28 INFO - Downloaded 24173994 bytes. 14:39:28 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:39:28 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:39:29 INFO - Return code: 0 14:39:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:39:29 INFO - https://queue.taskcluster.net/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:39:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 14:39:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 14:39:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 14:39:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 14:39:30 INFO - Downloaded 10840145 bytes. 14:39:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:39:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 14:39:31 INFO - Return code: 0 14:39:31 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')]} 14:39:31 INFO - https://queue.taskcluster.net/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:39:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 14:39:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 14:39:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 14:39:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 14:39:32 INFO - Downloaded 62800628 bytes. 14:39:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 14:39:32 INFO - mkdir: /builds/slave/test/properties 14:39:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:39:32 INFO - Writing to file /builds/slave/test/properties/build_url 14:39:32 INFO - Contents: 14:39:32 INFO - build_url:https://queue.taskcluster.net/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 14:39:33 INFO - Running post-action listener: _resource_record_post_action 14:39:33 INFO - Running post-action listener: set_extra_try_arguments 14:39:33 INFO - ##### 14:39:33 INFO - ##### Running populate-webroot step. 14:39:33 INFO - ##### 14:39:33 INFO - Running pre-action listener: _resource_record_pre_action 14:39:33 INFO - Running main action method: populate_webroot 14:39:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:39:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:39:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:39:33 INFO - '--tppagecycles', 14:39:33 INFO - '7'], 14:39:33 INFO - 'tests': ['tsvgm']}}, 14:39:33 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:39:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:39:33 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:39:33 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:39:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:39:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:39:33 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:39:33 INFO - 'talos_options': ['--disable-e10s'], 14:39:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:39:33 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:39:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:39:33 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:39:33 INFO - 'talos_options': ['--disable-e10s'], 14:39:33 INFO - 'tests': ['damp', 'tps']}, 14:39:33 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:39:33 INFO - 'tests': ['damp', 'tps']}, 14:39:33 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:39:33 INFO - 'tests': ['dromaeo_dom']}, 14:39:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:39:33 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:39:33 INFO - 'tests': ['a11yr', 14:39:33 INFO - 'ts_paint', 14:39:33 INFO - 'tpaint', 14:39:33 INFO - 'sessionrestore', 14:39:33 INFO - 'sessionrestore_no_auto_restore', 14:39:33 INFO - 'tabpaint']}, 14:39:33 INFO - 'other-e10s': {'tests': ['a11yr', 14:39:33 INFO - 'ts_paint', 14:39:33 INFO - 'tpaint', 14:39:33 INFO - 'sessionrestore', 14:39:33 INFO - 'sessionrestore_no_auto_restore', 14:39:33 INFO - 'tabpaint']}, 14:39:33 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:39:33 INFO - 'ts_paint', 14:39:33 INFO - 'tpaint', 14:39:33 INFO - 'sessionrestore', 14:39:33 INFO - 'sessionrestore_no_auto_restore', 14:39:33 INFO - 'tabpaint']}, 14:39:33 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:39:33 INFO - 'ts_paint', 14:39:33 INFO - 'tpaint', 14:39:33 INFO - 'sessionrestore', 14:39:33 INFO - 'sessionrestore_no_auto_restore', 14:39:33 INFO - 'tabpaint']}, 14:39:33 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:39:33 INFO - 'tests': ['a11yr', 14:39:33 INFO - 'ts_paint', 14:39:33 INFO - 'tpaint', 14:39:33 INFO - 'sessionrestore', 14:39:33 INFO - 'sessionrestore_no_auto_restore', 14:39:33 INFO - 'tabpaint']}, 14:39:33 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:39:33 INFO - 'tests': ['a11yr', 14:39:33 INFO - 'ts_paint', 14:39:33 INFO - 'tpaint', 14:39:33 INFO - 'sessionrestore', 14:39:33 INFO - 'sessionrestore_no_auto_restore', 14:39:33 INFO - 'tabpaint']}, 14:39:33 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:39:33 INFO - 'tests': ['tsvgx', 14:39:33 INFO - 'tsvgr_opacity', 14:39:33 INFO - 'tart', 14:39:33 INFO - 'tscrollx', 14:39:33 INFO - 'cart']}, 14:39:33 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:39:33 INFO - 'tsvgr_opacity', 14:39:33 INFO - 'tart', 14:39:33 INFO - 'tscrollx', 14:39:33 INFO - 'cart']}, 14:39:33 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:39:33 INFO - 'talos_options': ['--disable-e10s'], 14:39:33 INFO - 'tests': ['tp5o']}, 14:39:33 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:39:33 INFO - 'tests': ['tp5o']}, 14:39:33 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:39:33 INFO - 'talos_options': ['--disable-e10s', 14:39:33 INFO - '--xperf_path', 14:39:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:39:33 INFO - 'tests': ['tp5n']}, 14:39:33 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:39:33 INFO - 'talos_options': ['--xperf_path', 14:39:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:39:33 INFO - 'tests': ['tp5n']}}, 14:39:33 INFO - 'talos.zip': {'path': '', 14:39:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:39:33 INFO - Running post-action listener: _resource_record_post_action 14:39:33 INFO - ##### 14:39:33 INFO - ##### Running create-virtualenv step. 14:39:33 INFO - ##### 14:39:33 INFO - Running pre-action listener: _resource_record_pre_action 14:39:33 INFO - Running main action method: create_virtualenv 14:39:33 INFO - Creating virtualenv /builds/slave/test/build/venv 14:39:33 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 14:39:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:39:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:39:33 INFO - Using real prefix '/usr' 14:39:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:39:34 INFO - Installing distribute.............................................................................................................................................................................................done. 14:39:36 INFO - Installing pip.................done. 14:39:36 INFO - Return code: 0 14:39:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:39:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:39:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:39:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:39:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:39:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:36 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 0x7f4dfca3df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdd08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe9b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf2a410>, '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 0xf2b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf2b7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1464644336.425281-1609355336', '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 14:39:36 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 14:39:36 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 14:39:36 INFO - Using env: {'DISPLAY': ':0', 14:39:36 INFO - 'HOME': '/home/cltbld', 14:39:36 INFO - 'LANG': 'en_US.UTF-8', 14:39:36 INFO - 'LANGUAGE': 'en_US:en', 14:39:36 INFO - 'LOGNAME': 'cltbld', 14:39:36 INFO - 'MAIL': '/var/mail/cltbld', 14:39:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:39:36 INFO - 'MOZ_NO_REMOTE': '1', 14:39:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:39:36 INFO - 'NO_EM_RESTART': '1', 14:39:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:39:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:39:36 INFO - 'PWD': '/builds/slave/test', 14:39:36 INFO - 'SHELL': '/bin/bash', 14:39:36 INFO - 'SHLVL': '1', 14:39:36 INFO - 'TERM': 'linux', 14:39:36 INFO - 'TMOUT': '86400', 14:39:36 INFO - 'USER': 'cltbld', 14:39:36 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1464644336.425281-1609355336', 14:39:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:39:36 INFO - '_': '/tools/buildbot/bin/python'} 14:39:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:39:36 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 14:39:36 INFO - Cleaning up... 14:39:36 INFO - Return code: 0 14:39:36 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 14:39:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:39:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:39:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:39:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:39:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:36 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 0x7f4dfca3df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdd08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe9b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf2a410>, '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 0xf2b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf2b7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1464644336.425281-1609355336', '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 14:39:36 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 14:39:36 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 14:39:36 INFO - Using env: {'DISPLAY': ':0', 14:39:36 INFO - 'HOME': '/home/cltbld', 14:39:36 INFO - 'LANG': 'en_US.UTF-8', 14:39:36 INFO - 'LANGUAGE': 'en_US:en', 14:39:36 INFO - 'LOGNAME': 'cltbld', 14:39:36 INFO - 'MAIL': '/var/mail/cltbld', 14:39:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:39:36 INFO - 'MOZ_NO_REMOTE': '1', 14:39:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:39:36 INFO - 'NO_EM_RESTART': '1', 14:39:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:39:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:39:36 INFO - 'PWD': '/builds/slave/test', 14:39:36 INFO - 'SHELL': '/bin/bash', 14:39:36 INFO - 'SHLVL': '1', 14:39:36 INFO - 'TERM': 'linux', 14:39:36 INFO - 'TMOUT': '86400', 14:39:36 INFO - 'USER': 'cltbld', 14:39:36 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1464644336.425281-1609355336', 14:39:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:39:36 INFO - '_': '/tools/buildbot/bin/python'} 14:39:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:39:36 INFO - Downloading/unpacking psutil>=0.7.1 14:39:36 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 14:39:36 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 14:39:36 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 14:39:36 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 14:39:36 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 14:39:36 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 14:39:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:39:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:39:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:39:38 INFO - Installing collected packages: psutil 14:39:38 INFO - Running setup.py install for psutil 14:39:38 INFO - building 'psutil._psutil_linux' extension 14:39:38 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 14:39:38 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 14:39:38 INFO - building 'psutil._psutil_posix' extension 14:39:38 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 14:39:39 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 14:39:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:39:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:39:39 INFO - Successfully installed psutil 14:39:39 INFO - Cleaning up... 14:39:39 INFO - Return code: 0 14:39:39 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 14:39:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:39:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:39:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:39:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:39:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:39 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 0x7f4dfca3df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdd08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe9b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf2a410>, '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 0xf2b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf2b7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1464644336.425281-1609355336', '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 14:39:39 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 14:39:39 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 14:39:39 INFO - Using env: {'DISPLAY': ':0', 14:39:39 INFO - 'HOME': '/home/cltbld', 14:39:39 INFO - 'LANG': 'en_US.UTF-8', 14:39:39 INFO - 'LANGUAGE': 'en_US:en', 14:39:39 INFO - 'LOGNAME': 'cltbld', 14:39:39 INFO - 'MAIL': '/var/mail/cltbld', 14:39:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:39:39 INFO - 'MOZ_NO_REMOTE': '1', 14:39:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:39:39 INFO - 'NO_EM_RESTART': '1', 14:39:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:39:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:39:39 INFO - 'PWD': '/builds/slave/test', 14:39:39 INFO - 'SHELL': '/bin/bash', 14:39:39 INFO - 'SHLVL': '1', 14:39:39 INFO - 'TERM': 'linux', 14:39:39 INFO - 'TMOUT': '86400', 14:39:39 INFO - 'USER': 'cltbld', 14:39:39 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1464644336.425281-1609355336', 14:39:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:39:39 INFO - '_': '/tools/buildbot/bin/python'} 14:39:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:39:39 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:39:39 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 14:39:39 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 14:39:39 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 14:39:39 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 14:39:39 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 14:39:39 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 14:39:41 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:39:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:39:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:39:41 INFO - Installing collected packages: mozsystemmonitor 14:39:41 INFO - Running setup.py install for mozsystemmonitor 14:39:41 INFO - Successfully installed mozsystemmonitor 14:39:41 INFO - Cleaning up... 14:39:41 INFO - Return code: 0 14:39:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:39:41 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')]} 14:39:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:39:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:41 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')]} 14:39:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:39:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:41 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 0x7f4dfca3df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdd08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe9b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf2a410>, '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 0xf2b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf2b7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1464644336.425281-1609355336', '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 14:39:41 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 14:39:41 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 14:39:41 INFO - Using env: {'DISPLAY': ':0', 14:39:41 INFO - 'HOME': '/home/cltbld', 14:39:41 INFO - 'LANG': 'en_US.UTF-8', 14:39:41 INFO - 'LANGUAGE': 'en_US:en', 14:39:41 INFO - 'LOGNAME': 'cltbld', 14:39:41 INFO - 'MAIL': '/var/mail/cltbld', 14:39:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:39:41 INFO - 'MOZ_NO_REMOTE': '1', 14:39:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:39:41 INFO - 'NO_EM_RESTART': '1', 14:39:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:39:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:39:41 INFO - 'PWD': '/builds/slave/test', 14:39:41 INFO - 'SHELL': '/bin/bash', 14:39:41 INFO - 'SHLVL': '1', 14:39:41 INFO - 'TERM': 'linux', 14:39:41 INFO - 'TMOUT': '86400', 14:39:41 INFO - 'USER': 'cltbld', 14:39:41 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1464644336.425281-1609355336', 14:39:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:39:41 INFO - '_': '/tools/buildbot/bin/python'} 14:39:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:39:41 INFO - Downloading/unpacking blobuploader==1.2.4 14:39:41 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 14:39:41 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 14:39:41 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 14:39:41 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 14:39:41 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 14:39:41 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 14:39:43 INFO - Downloading blobuploader-1.2.4.tar.gz 14:39:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:39:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:39: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 14:39: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 14:39: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 14:39: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 14:39: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 14:39: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 14:39:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:39:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:39:44 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 14:39:44 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 14:39:44 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 14:39:44 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 14:39:44 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 14:39:44 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 14:39:44 INFO - Downloading docopt-0.6.1.tar.gz 14:39:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:39:44 INFO - Installing collected packages: blobuploader, requests, docopt 14:39:44 INFO - Running setup.py install for blobuploader 14:39:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:39:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:39:44 INFO - Running setup.py install for requests 14:39:44 INFO - Running setup.py install for docopt 14:39:44 INFO - Successfully installed blobuploader requests docopt 14:39:44 INFO - Cleaning up... 14:39:44 INFO - Return code: 0 14:39:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:39:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:39:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:39:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:39:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:39:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:44 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 0x7f4dfca3df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdd08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe9b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf2a410>, '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 0xf2b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf2b7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1464644336.425281-1609355336', '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 14:39:44 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 14:39:44 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 14:39:44 INFO - Using env: {'DISPLAY': ':0', 14:39:44 INFO - 'HOME': '/home/cltbld', 14:39:44 INFO - 'LANG': 'en_US.UTF-8', 14:39:44 INFO - 'LANGUAGE': 'en_US:en', 14:39:44 INFO - 'LOGNAME': 'cltbld', 14:39:44 INFO - 'MAIL': '/var/mail/cltbld', 14:39:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:39:44 INFO - 'MOZ_NO_REMOTE': '1', 14:39:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:39:44 INFO - 'NO_EM_RESTART': '1', 14:39:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:39:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:39:44 INFO - 'PWD': '/builds/slave/test', 14:39:44 INFO - 'SHELL': '/bin/bash', 14:39:44 INFO - 'SHLVL': '1', 14:39:44 INFO - 'TERM': 'linux', 14:39:44 INFO - 'TMOUT': '86400', 14:39:44 INFO - 'USER': 'cltbld', 14:39:44 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1464644336.425281-1609355336', 14:39:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:39:44 INFO - '_': '/tools/buildbot/bin/python'} 14:39:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:39:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:39:45 INFO - Running setup.py (path:/tmp/pip-5yEAtu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:39:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:39:45 INFO - Running setup.py (path:/tmp/pip-n6cYKZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:39:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:39:45 INFO - Running setup.py (path:/tmp/pip-0OroOR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:39:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:39:45 INFO - Running setup.py (path:/tmp/pip-pSevML-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:39:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:39:45 INFO - Running setup.py (path:/tmp/pip-zMzdSd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:39:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:39:45 INFO - Running setup.py (path:/tmp/pip-3fKgOS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:39:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:39:45 INFO - Running setup.py (path:/tmp/pip-c0sWnd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:39:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:39:45 INFO - Running setup.py (path:/tmp/pip-JC4d8a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:39:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:39:45 INFO - Running setup.py (path:/tmp/pip-6EsDMf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:39:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:39:45 INFO - Running setup.py (path:/tmp/pip-y0KOZm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:39:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:39:45 INFO - Running setup.py (path:/tmp/pip-nqJC11-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:39:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:39:45 INFO - Running setup.py (path:/tmp/pip-X0ZHjQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:39:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:39:46 INFO - Running setup.py (path:/tmp/pip-Npsh9c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:39:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:39:46 INFO - Running setup.py (path:/tmp/pip-jj1A9l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:39:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:39:46 INFO - Running setup.py (path:/tmp/pip-9DD0At-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:39:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:39:46 INFO - Running setup.py (path:/tmp/pip-OEC01G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:39:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:39:46 INFO - Running setup.py (path:/tmp/pip-tAhN8m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:39:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:39:46 INFO - Running setup.py install for manifestparser 14:39:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:39:46 INFO - Running setup.py install for mozcrash 14:39:46 INFO - Running setup.py install for mozdebug 14:39:46 INFO - Running setup.py install for mozdevice 14:39:46 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:39:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:39:46 INFO - Running setup.py install for mozfile 14:39:46 INFO - Running setup.py install for mozhttpd 14:39:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:39:47 INFO - Running setup.py install for mozinfo 14:39:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:39:47 INFO - Running setup.py install for mozInstall 14:39:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:39:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:39:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:39:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:39:47 INFO - Running setup.py install for mozleak 14:39:47 INFO - Running setup.py install for mozlog 14:39:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:39:47 INFO - Running setup.py install for moznetwork 14:39:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:39:47 INFO - Running setup.py install for mozprocess 14:39:47 INFO - Running setup.py install for mozprofile 14:39:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:39:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:39:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:39:47 INFO - Running setup.py install for mozrunner 14:39:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:39:47 INFO - Running setup.py install for mozscreenshot 14:39:47 INFO - Running setup.py install for moztest 14:39:48 INFO - Running setup.py install for mozversion 14:39:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:39:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:39:48 INFO - Cleaning up... 14:39:48 INFO - Return code: 0 14:39:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:39:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:39:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:39:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:39:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:39:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:48 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 0x7f4dfca3df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdd08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe9b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf2a410>, '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 0xf2b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf2b7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1464644336.425281-1609355336', '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 14:39:48 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 14:39:48 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 14:39:48 INFO - Using env: {'DISPLAY': ':0', 14:39:48 INFO - 'HOME': '/home/cltbld', 14:39:48 INFO - 'LANG': 'en_US.UTF-8', 14:39:48 INFO - 'LANGUAGE': 'en_US:en', 14:39:48 INFO - 'LOGNAME': 'cltbld', 14:39:48 INFO - 'MAIL': '/var/mail/cltbld', 14:39:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:39:48 INFO - 'MOZ_NO_REMOTE': '1', 14:39:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:39:48 INFO - 'NO_EM_RESTART': '1', 14:39:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:39:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:39:48 INFO - 'PWD': '/builds/slave/test', 14:39:48 INFO - 'SHELL': '/bin/bash', 14:39:48 INFO - 'SHLVL': '1', 14:39:48 INFO - 'TERM': 'linux', 14:39:48 INFO - 'TMOUT': '86400', 14:39:48 INFO - 'USER': 'cltbld', 14:39:48 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1464644336.425281-1609355336', 14:39:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:39:48 INFO - '_': '/tools/buildbot/bin/python'} 14:39:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:39:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:39:48 INFO - Running setup.py (path:/tmp/pip-UJm3wH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:39:48 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)) 14:39:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:39:48 INFO - Running setup.py (path:/tmp/pip-IMw0dd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:39:48 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)) 14:39:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:39:48 INFO - Running setup.py (path:/tmp/pip-hM0qP0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:39:48 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)) 14:39:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:39:48 INFO - Running setup.py (path:/tmp/pip-MH9zzw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:39:48 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)) 14:39:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:39:48 INFO - Running setup.py (path:/tmp/pip-UkM7_P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:39:48 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)) 14:39:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:39:48 INFO - Running setup.py (path:/tmp/pip-_2k7f2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:39:48 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)) 14:39:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:39:48 INFO - Running setup.py (path:/tmp/pip-yOYYLH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:39:48 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)) 14:39:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:39:48 INFO - Running setup.py (path:/tmp/pip-QAmFOp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:39:48 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)) 14:39:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:39:49 INFO - Running setup.py (path:/tmp/pip-SzXOC8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:39:49 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)) 14:39:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:39:49 INFO - Running setup.py (path:/tmp/pip-mXGw5A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:39:49 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)) 14:39:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:39:49 INFO - Running setup.py (path:/tmp/pip-MGCl1T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:39:49 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)) 14:39:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:39:49 INFO - Running setup.py (path:/tmp/pip-UMyjAf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:39:49 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)) 14:39:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:39:49 INFO - Running setup.py (path:/tmp/pip-peOAMZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:39:49 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)) 14:39:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:39:49 INFO - Running setup.py (path:/tmp/pip-XmeZfU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:39:49 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)) 14:39:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:39:49 INFO - Running setup.py (path:/tmp/pip-9Rr7dB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:39:49 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)) 14:39:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:39:49 INFO - Running setup.py (path:/tmp/pip-Hw1xQL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:39:49 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)) 14:39:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:39:49 INFO - Running setup.py (path:/tmp/pip-ymOdfT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:39:49 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)) 14:39:49 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)) 14:39:49 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)) 14:39:49 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)) 14:39:49 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)) 14:39:49 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)) 14:39:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:39: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 14:39: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 14:39: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 14:39: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 14:39: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 14:39: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 14:39:51 INFO - Downloading blessings-1.6.tar.gz 14:39:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:39:51 INFO - Installing collected packages: blessings 14:39:51 INFO - Running setup.py install for blessings 14:39:51 INFO - Successfully installed blessings 14:39:51 INFO - Cleaning up... 14:39:51 INFO - Return code: 0 14:39:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:39:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:39:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:39:51 INFO - Reading from file tmpfile_stdout 14:39:52 INFO - Current package versions: 14:39:52 INFO - argparse == 1.2.1 14:39:52 INFO - blessings == 1.6 14:39:52 INFO - blobuploader == 1.2.4 14:39:52 INFO - docopt == 0.6.1 14:39:52 INFO - manifestparser == 1.1 14:39:52 INFO - mozInstall == 1.12 14:39:52 INFO - mozcrash == 0.17 14:39:52 INFO - mozdebug == 0.1 14:39:52 INFO - mozdevice == 0.48 14:39:52 INFO - mozfile == 1.2 14:39:52 INFO - mozhttpd == 0.7 14:39:52 INFO - mozinfo == 0.9 14:39:52 INFO - mozleak == 0.1 14:39:52 INFO - mozlog == 3.1 14:39:52 INFO - moznetwork == 0.27 14:39:52 INFO - mozprocess == 0.22 14:39:52 INFO - mozprofile == 0.28 14:39:52 INFO - mozrunner == 6.11 14:39:52 INFO - mozscreenshot == 0.1 14:39:52 INFO - mozsystemmonitor == 0.0 14:39:52 INFO - moztest == 0.7 14:39:52 INFO - mozversion == 1.4 14:39:52 INFO - psutil == 3.1.1 14:39:52 INFO - requests == 1.2.3 14:39:52 INFO - wsgiref == 0.1.2 14:39:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:39:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:39:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:39:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:39:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:39:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:52 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 0x7f4dfca3df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdd08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe9b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf2a410>, '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 0xf2b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf2b7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1464644336.425281-1609355336', '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 14:39:52 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 14:39:52 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 14:39:52 INFO - Using env: {'DISPLAY': ':0', 14:39:52 INFO - 'HOME': '/home/cltbld', 14:39:52 INFO - 'LANG': 'en_US.UTF-8', 14:39:52 INFO - 'LANGUAGE': 'en_US:en', 14:39:52 INFO - 'LOGNAME': 'cltbld', 14:39:52 INFO - 'MAIL': '/var/mail/cltbld', 14:39:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:39:52 INFO - 'MOZ_NO_REMOTE': '1', 14:39:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:39:52 INFO - 'NO_EM_RESTART': '1', 14:39:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:39:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:39:52 INFO - 'PWD': '/builds/slave/test', 14:39:52 INFO - 'SHELL': '/bin/bash', 14:39:52 INFO - 'SHLVL': '1', 14:39:52 INFO - 'TERM': 'linux', 14:39:52 INFO - 'TMOUT': '86400', 14:39:52 INFO - 'USER': 'cltbld', 14:39:52 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1464644336.425281-1609355336', 14:39:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:39:52 INFO - '_': '/tools/buildbot/bin/python'} 14:39:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:39:52 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)) 14:39:52 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)) 14:39:52 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)) 14:39:52 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)) 14:39:52 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)) 14:39:52 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)) 14:39:52 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)) 14:39:52 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)) 14:39:52 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)) 14:39:52 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)) 14:39:52 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)) 14:39:52 INFO - Cleaning up... 14:39:52 INFO - Return code: 0 14:39:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:39:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:39:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:39:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:39:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:39:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:52 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 0x7f4dfca3df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdd08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe9b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf2a410>, '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 0xf2b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf2b7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1464644336.425281-1609355336', '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 14:39:52 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 14:39:52 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 14:39:52 INFO - Using env: {'DISPLAY': ':0', 14:39:52 INFO - 'HOME': '/home/cltbld', 14:39:52 INFO - 'LANG': 'en_US.UTF-8', 14:39:52 INFO - 'LANGUAGE': 'en_US:en', 14:39:52 INFO - 'LOGNAME': 'cltbld', 14:39:52 INFO - 'MAIL': '/var/mail/cltbld', 14:39:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:39:52 INFO - 'MOZ_NO_REMOTE': '1', 14:39:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:39:52 INFO - 'NO_EM_RESTART': '1', 14:39:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:39:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:39:52 INFO - 'PWD': '/builds/slave/test', 14:39:52 INFO - 'SHELL': '/bin/bash', 14:39:52 INFO - 'SHLVL': '1', 14:39:52 INFO - 'TERM': 'linux', 14:39:52 INFO - 'TMOUT': '86400', 14:39:52 INFO - 'USER': 'cltbld', 14:39:52 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1464644336.425281-1609355336', 14:39:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:39:52 INFO - '_': '/tools/buildbot/bin/python'} 14:39:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:39:52 INFO - Downloading/unpacking jsonschema 14:39:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:39:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:39:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:39:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:39:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:39:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:39:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:39:54 INFO - Downloading/unpacking functools32 (from jsonschema) 14:39: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 14:39: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 14:39: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 14:39: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 14:39: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 14:39: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 14:39:54 INFO - Downloading functools32-3.2.3-2.tar.gz 14:39:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:39:54 INFO - warning: no files found matching '*.txt' 14:39:54 INFO - no previously-included directories found matching 'build' 14:39:54 INFO - no previously-included directories found matching 'dist' 14:39:54 INFO - no previously-included directories found matching '.git*' 14:39:54 INFO - Installing collected packages: jsonschema, functools32 14:39:54 INFO - Running setup.py install for functools32 14:39:54 INFO - warning: no files found matching '*.txt' 14:39:54 INFO - no previously-included directories found matching 'build' 14:39:54 INFO - no previously-included directories found matching 'dist' 14:39:54 INFO - no previously-included directories found matching '.git*' 14:39:54 INFO - Successfully installed jsonschema functools32 14:39:54 INFO - Cleaning up... 14:39:54 INFO - Return code: 0 14:39:54 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:39:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:39:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:39:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:39:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:39:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:54 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 0x7f4dfca3df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdd08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe9b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf2a410>, '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 0xf2b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf2b7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1464644336.425281-1609355336', '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 14:39:54 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 14:39:54 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 14:39:54 INFO - Using env: {'DISPLAY': ':0', 14:39:54 INFO - 'HOME': '/home/cltbld', 14:39:54 INFO - 'LANG': 'en_US.UTF-8', 14:39:54 INFO - 'LANGUAGE': 'en_US:en', 14:39:54 INFO - 'LOGNAME': 'cltbld', 14:39:54 INFO - 'MAIL': '/var/mail/cltbld', 14:39:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:39:54 INFO - 'MOZ_NO_REMOTE': '1', 14:39:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:39:54 INFO - 'NO_EM_RESTART': '1', 14:39:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:39:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:39:54 INFO - 'PWD': '/builds/slave/test', 14:39:54 INFO - 'SHELL': '/bin/bash', 14:39:54 INFO - 'SHLVL': '1', 14:39:54 INFO - 'TERM': 'linux', 14:39:54 INFO - 'TMOUT': '86400', 14:39:54 INFO - 'USER': 'cltbld', 14:39:54 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1464644336.425281-1609355336', 14:39:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:39:54 INFO - '_': '/tools/buildbot/bin/python'} 14:39:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:39:55 INFO - Downloading/unpacking flake8 14:39:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:39:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:39:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:39:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:39:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:39:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:39:56 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:39:56 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:39:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:39:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:39:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:39:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:39:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:39:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:39:57 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:39:57 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:39: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 14:39: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 14:39: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 14:39: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 14:39: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 14:39: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 14:39:57 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:39: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 14:39: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 14:39: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 14:39: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 14:39: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 14:39: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 14:39:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:39:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:39:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:39:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:39:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:39:57 INFO - no previously-included directories found matching 'docs/_build' 14:39:57 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:39:57 INFO - Running setup.py install for pep8 14:39:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:39:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:39:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:39:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:39:57 INFO - no previously-included directories found matching 'docs/_build' 14:39:57 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:39:57 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:39:57 INFO - Cleaning up... 14:39:57 INFO - Return code: 0 14:39:57 INFO - Running post-action listener: _resource_record_post_action 14:39:57 INFO - Running post-action listener: _start_resource_monitoring 14:39:57 INFO - Starting resource monitoring. 14:39:57 INFO - ##### 14:39:57 INFO - ##### Running install step. 14:39:57 INFO - ##### 14:39:57 INFO - Running pre-action listener: _resource_record_pre_action 14:39:57 INFO - Running main action method: install 14:39:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:39:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:39:58 INFO - Reading from file tmpfile_stdout 14:39:58 INFO - Detecting whether we're running mozinstall >=1.0... 14:39:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:39:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:39:58 INFO - Reading from file tmpfile_stdout 14:39:58 INFO - Output received: 14:39:58 INFO - Usage: mozinstall [options] installer 14:39:58 INFO - Options: 14:39:58 INFO - -h, --help show this help message and exit 14:39:58 INFO - -d DEST, --destination=DEST 14:39:58 INFO - Directory to install application into. [default: 14:39:58 INFO - "/builds/slave/test"] 14:39:58 INFO - --app=APP Application being installed. [default: firefox] 14:39:58 INFO - mkdir: /builds/slave/test/build/application 14:39:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 14:39:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 14:40:13 INFO - Reading from file tmpfile_stdout 14:40:13 INFO - Output received: 14:40:13 INFO - /builds/slave/test/build/application/firefox/firefox 14:40:13 INFO - Running post-action listener: _resource_record_post_action 14:40:13 INFO - ##### 14:40:13 INFO - ##### Running run-tests step. 14:40:13 INFO - ##### 14:40:13 INFO - Running pre-action listener: _resource_record_pre_action 14:40:13 INFO - Running main action method: run_tests 14:40:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:40:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:40:13 INFO - Python 2.7.3 14:40:13 INFO - Return code: 0 14:40:13 INFO - grabbing minidump binary from tooltool 14:40:13 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')]} 14:40:13 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 0xf2a410>, '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 0xf2b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf2b7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:40:13 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 14:40:13 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 14:40:13 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:40:13 INFO - Return code: 0 14:40:13 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:40:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:40:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:40:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:40:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:40:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:40:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:40:14 INFO - Return code: 0 14:40:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 14:40:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-064 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 14:40:14 INFO - Using env: {'DISPLAY': ':0', 14:40:14 INFO - 'HOME': '/home/cltbld', 14:40:14 INFO - 'LANG': 'en_US.UTF-8', 14:40:14 INFO - 'LANGUAGE': 'en_US:en', 14:40:14 INFO - 'LOGNAME': 'cltbld', 14:40:14 INFO - 'MAIL': '/var/mail/cltbld', 14:40:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:40:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:40:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:40:14 INFO - 'MOZ_NO_REMOTE': '1', 14:40:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:40:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:40:14 INFO - 'NO_EM_RESTART': '1', 14:40:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:40:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:40:14 INFO - 'PWD': '/builds/slave/test', 14:40:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:40:14 INFO - 'SHELL': '/bin/bash', 14:40:14 INFO - 'SHLVL': '1', 14:40:14 INFO - 'TERM': 'linux', 14:40:14 INFO - 'TMOUT': '86400', 14:40:14 INFO - 'USER': 'cltbld', 14:40:14 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1464644336.425281-1609355336', 14:40:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:40:14 INFO - '_': '/tools/buildbot/bin/python'} 14:40:14 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 14:40:14 INFO - mozversion application_buildid: 20160530120549 14:40:14 INFO - mozversion application_changeset: 3c7a33fe0b6472bf47264c2390c5bc19f1a6dce4 14:40:14 INFO - mozversion application_display_name: FirefoxDeveloperEdition 14:40:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:40:14 INFO - mozversion application_name: Firefox 14:40:14 INFO - mozversion application_remotingname: firefox-dev 14:40:14 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 14:40:14 INFO - mozversion application_vendor: Mozilla 14:40:14 INFO - mozversion application_version: 48.0a2 14:40:14 INFO - mozversion platform_buildid: 20160530120549 14:40:14 INFO - mozversion platform_changeset: 3c7a33fe0b6472bf47264c2390c5bc19f1a6dce4 14:40:14 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 14:40:14 INFO - mozversion platform_version: 48.0a2 14:40:14 INFO - using testdate: 1464644414 14:40:14 INFO - actual date: 1464644414 14:40:14 INFO - starting webserver on 'localhost:40004' 14:40:14 INFO - SUITE-START | Running 2 tests 14:40:14 INFO - TEST-START | dromaeo_css 14:40:14 INFO - operating with platform_type : linux_ 14:40:14 INFO - Initialising browser for dromaeo_css test... 14:40:14 INFO - TEST-INFO | started process 13872 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmRUhR6/profile http://localhost:40004/getInfo.html) 14:40:19 INFO - PROCESS | 13872 | 14:40:19 INFO - PROCESS | 13872 | (process:13950): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 14:40:19 INFO - PROCESS | 13872 | __metrics Screen width/height:1600/1200 14:40:19 INFO - PROCESS | 13872 | colorDepth:24 14:40:19 INFO - PROCESS | 13872 | Browser inner width/height: 1024/697 14:40:19 INFO - PROCESS | 13872 | __metrics 14:40:20 ERROR - PROCESS | 13872 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2940: TypeError: this.tabs is undefined 14:40:21 INFO - TEST-INFO | 13872: exit 0 14:40:21 INFO - Browser initialized. 14:40:21 INFO - Running cycle 1/1 for dromaeo_css test... 14:40:21 INFO - TEST-INFO | started process 14001 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmRUhR6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:40:23 INFO - PROCESS | 14001 | 14:40:23 INFO - PROCESS | 14001 | (process:14068): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 14:40:33 INFO - PROCESS | 14001 | RSS: Main: 151912448 14:40:33 INFO - PROCESS | 14001 | 14:41:22 INFO - PROCESS | 14001 | 1464644482844 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] 14:43:30 INFO - PROCESS | 14001 | Cycle 1(1): loaded http://localhost:40004/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40004/tests/dromaeo/cssquery-ext.html) 14:43:31 INFO - PROCESS | 14001 | RSS: Main: 156246016 14:43:31 INFO - PROCESS | 14001 | 14:46:33 INFO - PROCESS | 14001 | Cycle 1(1): loaded http://localhost:40004/tests/dromaeo/cssquery-ext.html (next: http://localhost:40004/tests/dromaeo/cssquery-jquery.html) 14:46:33 INFO - PROCESS | 14001 | RSS: Main: 153444352 14:46:33 INFO - PROCESS | 14001 | 14:49:35 INFO - PROCESS | 14001 | Cycle 1(1): loaded http://localhost:40004/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40004/tests/dromaeo/cssquery-mootools.html) 14:49:36 INFO - PROCESS | 14001 | RSS: Main: 153206784 14:49:36 INFO - PROCESS | 14001 | 14:52:37 INFO - PROCESS | 14001 | Cycle 1(1): loaded http://localhost:40004/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40004/tests/dromaeo/cssquery-prototype.html) 14:52:38 INFO - PROCESS | 14001 | RSS: Main: 152686592 14:52:38 INFO - PROCESS | 14001 | 14:55:40 INFO - PROCESS | 14001 | Cycle 1(1): loaded http://localhost:40004/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40004/tests/dromaeo/cssquery-yui.html) 14:55:41 INFO - PROCESS | 14001 | RSS: Main: 154378240 14:55:41 INFO - PROCESS | 14001 | 14:58:43 INFO - PROCESS | 14001 | Cycle 1(1): loaded http://localhost:40004/tests/dromaeo/cssquery-yui.html (next: http://localhost:40004/tests/dromaeo/cssquery-dojo.html) 14:58:43 INFO - PROCESS | 14001 | RSS: Main: 155914240 14:58:43 INFO - PROCESS | 14001 | 14:58:43 INFO - PROCESS | 14001 | __start_tp_report 14:58:43 INFO - PROCESS | 14001 | _x_x_mozilla_page_load 14:58:43 INFO - PROCESS | 14001 | _x_x_mozilla_page_load_details 14:58:43 INFO - PROCESS | 14001 | |i|pagename|runs| 14:58:43 INFO - PROCESS | 14001 | |0;dojo.html;3368.9831550842246;3423.863045478181;3440.7935523868587;3456.9135771605706;3465.8613655453782;5737.34020587632;5742.4831765141125;5753.108268218432;5772.105323674832;5776.508996735282;5680.289963754531;5696.373398926125;5723.570732195081;5750.597458177929;5781.161731548933;5184.818531351403;5188.8702782430555;5220.243064755608;5256.789728410859;5266.710330931797;5100.438951715309;5191.299174611436;5201.947980520203;5357.303550538424;5362.785488580472;5066.18940969445;5228.843134705965;5232.45059268777;5236.738163091849;5290.7354632268425;5190.039842629107;5205.375354957391;5209.114450543417;5220.634555581111;5220.981908527839;5054.772535235887;5059.671121377099;5121.462246464105;5174.353205849269;5193.8961220775755;5579.609427340088;5642.802501912454;5662.716864156776;5679.233303504016;5714.1428785682065;6151.753929842801;6167.537434692371;6177.814665559996;6194.442500175006;6196.659183744892;5945.197398351211;6037.973544497446;6214.627122372627;6242.781502647431;6262.060690896356;5713.085906255021;5716.428357164292;5720.1991721159075;5748.42515748426;5749.856253593652;6236.126942228092;6248.4376406123665;6275.403836635513;6286.277078135981;6293.874122517524;5858.707064646751;5995;6035.275766907999;6037.366076561898;6070.939290607126;6142.232220972379;6142.621558143003;6144.109104179958;6152.630842149396;6160.9383906160365;6031.24609423822;6085.257248556763;6109.11417844419;6110.694465276719;6140.907886381708;5890.4993075589055;6059.575829691879;6107.175531303306;6112.473085128069;6161.691915404212;4624.838130665411;4639.327297541838;4641.86074417768;4658.440987081572;4667.229907065364;4129.566395528426;4177.143685544517;4180.665546756252;4184.205001049791;4203.32746760523;5738.397468265855;5867.677277749679;5893.410658934073;5925.288965324189;5954.136650185699;6079;6144.692765361803;6147.44672979434;6154.846128846725;6156.815295541141;5792.797252096157;5879.118132280107;5885.146653735184;5897.32180799205;5924.851878703067;5272.525472707474;5319.893602127936;5325.573954083664;5334.973325133349;5350.170723537858;6321;6383.872322553523;6386.329435409308;6393.136926514954;6398.744050238031;5878.911816322673;6112.541559382975;6152;6160.907586386118;6184.319724830265;6296.212973378328;6356.173697419306;6363.713632886624;6383.36166383358;6391.904121438275;5926.348101708722;5981.521478281814;6017.939820601738;6045.455908968214;6045.576809623284;6013.188219590475;6089.269287685506;6144.709610981744;6153.476954458921;6223.813285601439;5978.611390259619;5990.281166260077;5996.700164991646;6064.909026364519;6067.059605761114;5995.190649262294;6015.72929218195;6040.818775436744;6041.607295525777;6059.606125601822;5717.313922329347;5856.238688970577;5898.292204935436;5953.1367951647635;5961.225040744675;6079.878402431838;6089.117078023751;6099.085137229451;6124.755009799558;6127.84680382994;5929.16991621182;5952.434518720715;5960.672163031075;5963.552733545088;5977.491913187254 14:58:43 INFO - PROCESS | 14001 | |1;ext.html;673.6261374936909;681.2880539835871;695.8295217671671;744.5160645580376;749.5764892835548;38747;39577.208455830936;39652.60347396525;39698.603013969885;39708.80145599268;43412.131757364834;43972.780136099274;44144.3378349325;44165;44273.77863110688;8773.649054037847;8902.465852048865;8945.15021072997;9004.8649270261;9012.77468063297;8798.076201998794;8863.468191908474;8905.332100092486;8919.197272245498;8919.331050171231;9073.41022833517;9132;9144.72565823023;9198;9218.76953076175;8956.686515971942;9135.40619859707;9168.26653867689;9171.266298696088;9190.678326258583;8790.56047197644;9057.411268267608;9069.637214511478;9077.500737459437;9078;43819.78090109561;44079.559204407866;44419;44450.55549444529;44532.3320150198;3922.8038598069984;3990.082281075369;4045.1707399982934;4075.8777236682945;4290.29210180323;33723.325533489195;33828.661713383044;34603;34687.30625387503;35657.64342356569;4611.907761844778;4632.652551058651;4647.883802904955;4654.25531914892;4690;318055;318400;320191.3990430056;320838;321077;39173.80413097973;63709.36290637127;64230.67884660547;64248.357516425174;64272.357276427574;37769;37951.81024094862;37989.43015854764;38030.42954355687;38044;16144.112073836051;16493.092879891483;16503.33986640545;16529.33882644681;16560.917195413946;12804.103712740205;12842.550510732266;12890.355482225852;12906.67733306656;12928.676783080311;9237.90762092384;9293.117153870508;9320.254379649747;9324.347295689373;9331;3572.678109099598;3612.5303710517464;3635.4728564358547;3639.94540081899;3653.159773252167;1136.9488373023069;1164.988350116488;1168.0363699947577;1249.6625911003978;1257.9182353147016;33085.83457082699;33266.334673306395;33506.32987340288;33793.15517112043;33805.15487112842;1255.7237407770276;1260.489501751792;1290.4902563487558;1354.7696891528465;1360.5782207515701;16974;17140;17369.4789156323;17414.409912071915;17735.379261726037;496348;505019;515859;516447;792669;62071.37928620656;63264;63775.36224637694;63878;63888.68055659692;1563.8905276630753;1570.4424929150216;1571.8506741859505;1579.0525684589154;1639.3442622950677;32647;33949.83025084859;33949.83025084859;34203.657963420046;34794.13014674653;54051.72974135104;55073.724631376586;55165.17252241139;55178.79284828562;55212.72393638006;430742;432542;434914;435285;436364;30286.69713302927;31084.37831243317;31300;31309.217269567533;31438.842805785825;50963.74518127534;51052.744736277564;51346.486535135664;52991.735041324544;53357.733211335246;43036.78481607572;43270;43291.78354108209;43567.78216109026;44795.328070079624;42103.31586736496;42650.573494265904;42674.57325426706;43763.56236437722;44096;41697.79151104225;43131.568684314014;43472.130557389304;43930.12139757251;44175.77912110419;35124.473132903535;35795;36454.906352809456;36572.63427365692;38138;29073.383395494508;30421.391572168875;30601.23496912595;31556.842215788773;32318.83840580782 14:58:43 INFO - PROCESS | 14001 | |2;jquery.html;426.7716771527233;429.7335651895824;435.52161596255695;437.35490152025767;448.4215362182782;19105.14026868791;19695.606087878234;19730.210791568337;19999.300024499145;20469.590608187864;19081.332153374635;19434.90282548589;20859.165633374683;20896.477588060305;20957.790422095775;5748.137779333092;5796.188533605288;5814.738336774855;5896.23348964634;5963.582549221556;5838.562107841907;5851.093080572497;5885.234919460464;5893;5897.911531327012;5739.770409183628;5778.59549831512;5865.560082993771;5898.174255604219;5907.88184236315;5806.1000544915605;5819.73811178498;5824.912626310609;5853.824385268449;5889.440503152194;5290.127129023706;5307.734613269321;5313.574914006909;5353.9196912046355;5361.437049109826;24227.152049678352;24594.754052459426;24640;25014.874925625438;25039;2589.909353172649;3154.7003034711665;3284.8029118252744;3289.358575077837;3348.1294863335465;15312.923435382752;15358.155301458528;15370;15518.922405388013;15881.444149454714;2019.6667549854255;2140.090461553849;2150.483883867876;2178.0525471419983;2207.724034495688;81401;82443;84251.5787421065;84710.57644711738;85337;11272.323660580392;11341.829872551918;11601.477933493014;11715.297082175097;12162.939185304194;15476.148811815458;15579.688406231811;15600.453984110502;15611;15664.451744188898;8623.137686231326;8773.122687731176;8783.780405489786;8882.51146186953;9036.593353298986;8295.8340833183;8354.8329033419;8366.790830229293;8366.916330836613;8396.538190399464;5030.84907452777;5098.490150984946;5135.537801597874;5159.974200128975;5183.403908550565;2043.9182432702823;2160.611090003783;2183.4541364658835;2210.624193887043;2221.600111979827;999.7050869993369;1053.847192157133;1073.838924161382;1119.6249256499002;1133.3256712256195;19398.70901936472;19892.204311827656;19960;20184.36109345198;20393.796062039488;1068.0547715271884;1088.77135801481;1098.4288170151476;1127.7349822791637;1142.7086093046387;10755.83866242007;11409.942950285362;11439.142064345207;11542.538298468135;11576.305421674726;178570;497969;501914;509710;518060;73344;85091.57454212813;85846.57076714576;93057;94250.5287473572;1129.5312445335094;1144.2333636463422;1146.5184622458587;1162.2329262686756;1175.059952038366;18540;18671.34650287288;18726.71909921325;18789.530261743566;19300.613987720448;41022.17955640811;41353.379699303936;41620.58379416167;41911;43009.56990430056;58951.705241473515;59385.703071486096;59493.405065948784;60095;60883.39116608777;8948.68679596237;9123.908760912305;9141.77145571366;9244.815103698023;9269.490178040003;13558.457661693421;14045;14202.92898535542;14279.64300892486;14365.425382984564;11823.290602563873;12132.939335303266;12372.1958072725;12475.189112707645;12697.238165710087;11342.319460832046;11636.883631163919;11800.70498237551;11811.940940295244;12044.457999389873;12408.131430800118;12453.501859925502;12483.438245279165;12520.248785072561;12541.184822986477;8515.659373624985;8667.566621669017;8794.648214071365;8885;9008.099190080939;11820.645380638594;12075.57735479254;12101.576444824388;12173.878261217274;12220.87779122233 14:58:43 INFO - PROCESS | 14001 | |3;mootools.html;1610.9194540272983;1637.4105322084051;1904.352520143151;1967.5081229692569;1988.691752778318;7457.813554661137;8528.403011789178;8593.226609605133;8779.517126558037;8844.867326990092;8179.222973817493;8202.91797082029;8246.134155913633;8280.585970701455;8297;2443.364725171459;2456.6437866509345;2471.3574470637673;2474.9628755568683;2476.826622136451;2387.4986252886915;2492.190038237571;2499.950000999979;2502.8122890783175;2502.924912252626;2429.3197904586655;2429.6355546667965;2438.5001074779716;2448.2777580613674;2454.0306578901414;2388.2238272561485;2390.378576456661;2394.6168613022005;2411.1199412214505;2490.86300253486;2422.7577242275806;2426.6845310109748;2434.1967150840355;2435.622478515833;2440.0727723465147;8866.822663546758;8886.06696296886;8923.821523569557;8926.419782714167;8934.06192349807;5241.659292145999;5353.411124776271;5383.542398896098;5384.057789886754;5389.326334208224;3433.4334834752235;3537.4340105582983;3551.378508760982;3558.5195998540385;3590.35373632746;1124.4082390090837;1127.5433449452985;1133.1388145009769;1139.1114930354338;1145.8911403416746;12267.815982760265;12314.568990085394;12331.321777302244;12339;12437.191582547106;4599.770011499479;4753.572178503951;4772.379590653193;4812.06164797868;4833.202521583899;10410.791784164274;10443.32118412316;10453.529591168415;10465.581376744845;10481.842772358421;5395;5398.973005134949;5419.295491586068;5434.91847622286;5438.129899216106;4271.893202669896;4849.587785038311;4984.700917944935;4987.226979818134;5003.024410239968;4182.811773470201;4224.176285624335;4264.914701705949;4304.655627549789;4321.827126914888;1399.720055988786;1420.013090901834;1428.028940320592;1429.0425414971994;1439.100562148657;1066.3282132256784;1074.355386767933;1083.6911480228255;1100.0594491709633;1104.8563686720674;6181.474574661204;6254.061890716429;6305.3379395163765;6369.9681501592195;6389.616623002635;1061.2093989977516;1129.9096072314196;1155.5435602936961;1163.2962057954985;1165.918385712992;4255.4255175551525;4284.507281662586;4316.417283666665;4316.913661726748;4389.253826849444;10281.691549253534;10513.52689128991;10636.840447393295;10772.946135269274;10796.730081747863;10430.791384172275;10508.369497830156;10598.31110977784;10627.309224900357;10630.362178269328;7682.654280557388;8463.322934165251;8492.363072769567;8574.742757717278;8586;5972.223610930551;6010.368911264254;6053.243344581927;6133.417325354084;6170.290416601969;9027.32295077885;9287.582058807506;9417;9515.857262140935;9619.90380096218;9414.293927955294;9940.353876997971;10049.497525123568;10140.391576505433;10220.540075696463;7045.753398631024;7389.224131466119;7523.924760752322;7603.505772124794;7700.3454706350585;8139.918600814153;8146.877796832934;8165.79585510367;8186.590670466572;8203.958980205061;7318.3047610476915;7623.580703061385;7643.5796031218815;7657;7734.806629834299;7528.397728181842;7590.430717696085;7673.462857599914;7753;7758.9612051939375;7195.632829762329;7257.129144502694;7374.1151061872915;7412.555246685216;7422.257774222535;5380.973095134499;5410.513053825174;5521.061419558604;5531.612787104864;5575.4424557543925;5394.136938089887;5507.7246137693755;5542.806001789918;5545.805896793593;5555.861103472445 14:58:43 INFO - PROCESS | 14001 | |4;prototype.html;341.45196958880996;344.77417291673953;351.73795522335865;362.650042708786;365.82988910156774;6538.444232240259;6578.60528368297;6609.239937407194;6665.4667626589935;6685.69914353854;6690.364415380531;6694.899576506356;6699.263081061079;6700.430463410616;6704.430123439502;5051.621128415374;5058.266551350052;5065.189569668853;5066.645334826564;5070.594352451795;5047.49525047496;5064.189729643258;5073.974630126844;5086.97456512717;5090.414602320743;5033.848984530452;5034.370703662043;5036.84889453317;5037.596992240612;5048.4951504849405;4940.685829450554;4979.526944940225;5030.119729047438;5043.697378157304;5044.772985215655;4372.846950356754;4384.145091707119;4394.077243778778;4395.37371172665;4400.933985990213;6404.647744374058;6412.871742565123;6431;6433.967830160819;6451.41937225652;5844.094165404326;5853.180554722342;5855.209546711182;5857.297124345063;5858.2677165354335;7027.89458158128;7054.894176587355;7062.293770622948;7064;7068.39918606919;4641.071785642885;4778.259369797687;4830.420349558076;4897.7795999180125;4904.950950490485;7108.537945033608;7211.423086153095;7241.782746517613;7249.275072492708;7255.818604534928;4904.92642610354;4915.090708218991;4954.455009948902;4966.15575352191;4996.275540046673;5043.5965122790085;5052.368453943257;5054.393472783289;5055.671381360274;5059.645824792229;5800.01399762033;5806.912896306559;5810.5061069809535;5821.039528477754;5821.476067153892;6880.724771009203;6974.755883544153;6999.335063168991;7018.157821061505;7025.613591252531;1746.7729195204543;1764.7529345891585;1768.7170052791491;1772.512559046247;1774.2814160265114;1109.1570406491126;1161.4425075963584;1171.9296842189497;1184.7926612842718;1198.7602479504135;6830.282820303896;6930.722771089201;6936.757213497604;6937.375636192767;6962.199347075049;7375.151857536452;7380.926190738024;7393.963030184815;7422.109346878301;7423.48035637511;6911.308869113049;6919.135108111486;6935.410490108397;6937.653117344214;6938.06336144614;3907.1404291055924;3959.4852669152824;3988.8205030773684;3990.20195960809;3995.9810248386475;7714.691412343555;7729.458937874295;7730.381569474429;7732.30409263169;7739;7415.629218539051;7418.591977441292;7440.590767507839;7497.137829149718;7509.62451877404;7652.311291983637;7670.156282808886;7672.73145439907;7689.38484921205;7707.653155608011;7114.964425177841;7289.088863892013;7369.410447164107;7377.3360397564475;7377.926220737724;7260.782176534713;7276.96361518189;7277.16312624055;7278.053852999076;7290.635468226674;7664.11862635804;7666.4633475656165;7723.227677232457;7731.226877312449;7739.3034626883855;4825.5898248649255;4882.5361590650255;4884.511548845229;4886.169351210232;4886.364772579542;7104.928950710427;7351.4118870489165;7360.631968401452;7366.337029667356;7389.224131466119;7075.71697132109;7144.678489467882;7189.352958233784;7189.7483588074165;7202.71189152428;7095.503314767917;7113.679884405111;7114.395276401357;7115.252898445796;7141.892871607034;6989.126359205099;7014.123234595676;7024.5082844200415;7032.945058241305;7050.753223637148;6920.927256275286;7211.350978411968;7213.60325182099;7222.89165662526;7225.1329840419485;6820.897686534607;6958;6968.721251149897;7018.438524918097;7023.297670232936 14:58:43 INFO - PROCESS | 14001 | |5;yui.html;839.4795226959278;868.3617541107285;927.3925578745922;937.8780758501393;945.418567580938;14964;15240.923795381008;15245;15293.311800968955;15383.846161538382;14002.789958150635;14118.08232464889;14172.220527870963;14189.43242270308;14192.503262385819;734.0274136768803;866.2333834556431;909.5088652127843;910.8178364327127;911.1298709732223;904.1139683110556;908.609298001859;911.6900253913668;913;917.4862077236735;946.1248345280623;950.496236994394;953.4327075390132;954.0888451528808;958.104172598619;944.6788092048668;946.4179529589322;947.6304241345846;947.8909925358603;949.103097572794;678.0270312102149;678.6097993653669;679.8810208213592;688.6074937285749;696.3871792822284;14221.075630084115;14283.571492855232;14302.856971430256;14378.424863005468;14393.352299146563;15014.324355404033;15120.924395377953;15210.16344101074;15295.694086118327;15392.692146157126;11926.582569610022;11963.1625786195;12092.274463532216;12234.08244381666;12269.631911042594;4041.4139949707424;4055.3511438170044;4109.486314210723;4220.198162349144;4250.213710463543;51022.7448862757;51526;54360.18459723108;54758.72620636911;54952.17571736387;11897.88102118985;11986.700332491757;12055.819162712567;12149.392530373447;12174.695632609255;21182.15271389158;21309.36071917845;21327.146914123263;21507;21608;8579.313654907592;8708.564571771387;8824.691135810215;8841.336899732418;8873.91126088731;4966.528179822911;5041.974790126099;5105.157648987875;5107.387113546398;5137.871553211125;3660.9633903660624;3677.282929828711;3702.851885924533;3703.407454807218;3714.257148570297;748.5396481164154;751.0649241694126;755.3541721827868;763.4579448591451;781.7342103684774;815.38031096366;841.0958219913617;859.9312055035582;865.7835541114721;871.6426265231224;9907.207423406111;10625.309354891908;10627.775134792193;10693.625723099654;10750.78498430027;665.8102440804347;788.5505262000719;797.5852556670499;797.6649807081039;811.9188081191834;4701.905961880743;4773.236282194902;4832.347633069561;4864.902701945941;4904.43598986114;60913.39086609077;61380.69309653423;63063.36936630575;63312;63469.68265158737;55129.448705513234;56718.14922776162;57348.71325643345;57429.42570574324;57669.71165144231;50066.24900626494;51151.74424127855;51690;51794.22308665373;52324.73837630863;9588.76028099303;9623.518824058909;9723.124918757347;9935.602575896883;9999.200063994718;37662.05844853791;37965.24069518649;38321;38831.41752873653;40231.396529051504;46011.53988460072;48513.757431212616;48884.75557622189;49036.2644560339;49449;11781.23421977603;12177.33024683651;12262.325572093263;12271.75456490883;12272.263664180178;12669.949364060561;12971.805422918853;13147.276899770604;13349.132306400053;13394.531191408254;12555.93722031384;12802.231866088065;12881.549145779853;12882.35588220604;12996.805047924478;12005.939970300093;12011.879881201427;12035.157538972187;12137.817932730839;12320.260784352968;12296.262224266573;12378.75242495127;12418.379081046092;12619.684507887376;12735.80896286538;10481.528331225265;10572.995565421274;10594.788104237718;10647.467626618483;10699.786004280026;10496.947515262375;10542.376756275838;10574.471276435994;10677.46612669379;10709.464526773785 14:58:43 INFO - PROCESS | 14001 | __end_tp_report 14:58:43 INFO - PROCESS | 14001 | __start_cc_report 14:58:43 INFO - PROCESS | 14001 | _x_x_mozilla_cycle_collect,332 14:58:43 INFO - PROCESS | 14001 | __end_cc_report 14:58:43 INFO - PROCESS | 14001 | __startTimestamp1464645523739__endTimestamp 14:58:43 INFO - PROCESS | 14001 | 14:58:43 INFO - PROCESS | 14001 | ------- Summary: start ------- 14:58:43 INFO - PROCESS | 14001 | Number of tests: 6 14:58:43 INFO - PROCESS | 14001 | 14:58:43 INFO - PROCESS | 14001 | [#0] dojo.html Cycles:165 Average:5702.47 Median:5945.20 stddev:640.53 (10.8%) stddev-sans-first:615.78 14:58:43 INFO - PROCESS | 14001 | Values: 3369.0 3423.9 3440.8 3456.9 3465.9 5737.3 5742.5 5753.1 5772.1 5776.5 5680.3 5696.4 5723.6 5750.6 5781.2 5184.8 5188.9 5220.2 5256.8 5266.7 5100.4 5191.3 5201.9 5357.3 5362.8 5066.2 5228.8 5232.5 5236.7 5290.7 5190.0 5205.4 5209.1 5220.6 5221.0 5054.8 5059.7 5121.5 5174.4 5193.9 5579.6 5642.8 5662.7 5679.2 5714.1 6151.8 6167.5 6177.8 6194.4 6196.7 5945.2 6038.0 6214.6 6242.8 6262.1 5713.1 5716.4 5720.2 5748.4 5749.9 6236.1 6248.4 6275.4 6286.3 6293.9 5858.7 5995.0 6035.3 6037.4 6070.9 6142.2 6142.6 6144.1 6152.6 6160.9 6031.2 6085.3 6109.1 6110.7 6140.9 5890.5 6059.6 6107.2 6112.5 6161.7 4624.8 4639.3 4641.9 4658.4 4667.2 4129.6 4177.1 4180.7 4184.2 4203.3 5738.4 5867.7 5893.4 5925.3 5954.1 6079.0 6144.7 6147.4 6154.8 6156.8 5792.8 5879.1 5885.1 5897.3 5924.9 5272.5 5319.9 5325.6 5335.0 5350.2 6321.0 6383.9 6386.3 6393.1 6398.7 5878.9 6112.5 6152.0 6160.9 6184.3 6296.2 6356.2 6363.7 6383.4 6391.9 5926.3 5981.5 6017.9 6045.5 6045.6 6013.2 6089.3 6144.7 6153.5 6223.8 5978.6 5990.3 5996.7 6064.9 6067.1 5995.2 6015.7 6040.8 6041.6 6059.6 5717.3 5856.2 5898.3 5953.1 5961.2 6079.9 6089.1 6099.1 6124.8 6127.8 5929.2 5952.4 5960.7 5963.6 5977.5 14:58:43 INFO - PROCESS | 14001 | 14:58:43 INFO - PROCESS | 14001 | [#1] ext.html Cycles:180 Average:60064.57 Median:236889.39 stddev:121332.19 (51.2%) stddev-sans-first:121590.62 14:58:43 INFO - PROCESS | 14001 | Values: 673.6 681.3 695.8 744.5 749.6 38747.0 39577.2 39652.6 39698.6 39708.8 43412.1 43972.8 44144.3 44165.0 44273.8 8773.6 8902.5 8945.2 9004.9 9012.8 8798.1 8863.5 8905.3 8919.2 8919.3 9073.4 9132.0 9144.7 9198.0 9218.8 8956.7 9135.4 9168.3 9171.3 9190.7 8790.6 9057.4 9069.6 9077.5 9078.0 43819.8 44079.6 44419.0 44450.6 44532.3 3922.8 3990.1 4045.2 4075.9 4290.3 33723.3 33828.7 34603.0 34687.3 35657.6 4611.9 4632.7 4647.9 4654.3 4690.0 318055.0 318400.0 320191.4 320838.0 321077.0 39173.8 63709.4 64230.7 64248.4 64272.4 37769.0 37951.8 37989.4 38030.4 38044.0 16144.1 16493.1 16503.3 16529.3 16560.9 12804.1 12842.6 12890.4 12906.7 12928.7 9237.9 9293.1 9320.3 9324.3 9331.0 3572.7 3612.5 3635.5 3639.9 3653.2 1136.9 1165.0 1168.0 1249.7 1257.9 33085.8 33266.3 33506.3 33793.2 33805.2 1255.7 1260.5 1290.5 1354.8 1360.6 16974.0 17140.0 17369.5 17414.4 17735.4 496348.0 505019.0 515859.0 516447.0 792669.0 62071.4 63264.0 63775.4 63878.0 63888.7 1563.9 1570.4 1571.9 1579.1 1639.3 32647.0 33949.8 33949.8 34203.7 34794.1 54051.7 55073.7 55165.2 55178.8 55212.7 430742.0 432542.0 434914.0 435285.0 436364.0 30286.7 31084.4 31300.0 31309.2 31438.8 50963.7 51052.7 51346.5 52991.7 53357.7 43036.8 43270.0 43291.8 43567.8 44795.3 42103.3 42650.6 42674.6 43763.6 44096.0 41697.8 43131.6 43472.1 43930.1 44175.8 35124.5 35795.0 36454.9 36572.6 38138.0 29073.4 30421.4 30601.2 31556.8 32318.8 14:58:43 INFO - PROCESS | 14001 | 14:58:43 INFO - PROCESS | 14001 | [#2] jquery.html Cycles:180 Average:28142.06 Median:24410.95 stddev:76137.12 (311.9%) stddev-sans-first:76322.27 14:58:43 INFO - PROCESS | 14001 | Values: 426.8 429.7 435.5 437.4 448.4 19105.1 19695.6 19730.2 19999.3 20469.6 19081.3 19434.9 20859.2 20896.5 20957.8 5748.1 5796.2 5814.7 5896.2 5963.6 5838.6 5851.1 5885.2 5893.0 5897.9 5739.8 5778.6 5865.6 5898.2 5907.9 5806.1 5819.7 5824.9 5853.8 5889.4 5290.1 5307.7 5313.6 5353.9 5361.4 24227.2 24594.8 24640.0 25014.9 25039.0 2589.9 3154.7 3284.8 3289.4 3348.1 15312.9 15358.2 15370.0 15518.9 15881.4 2019.7 2140.1 2150.5 2178.1 2207.7 81401.0 82443.0 84251.6 84710.6 85337.0 11272.3 11341.8 11601.5 11715.3 12162.9 15476.1 15579.7 15600.5 15611.0 15664.5 8623.1 8773.1 8783.8 8882.5 9036.6 8295.8 8354.8 8366.8 8366.9 8396.5 5030.8 5098.5 5135.5 5160.0 5183.4 2043.9 2160.6 2183.5 2210.6 2221.6 999.7 1053.8 1073.8 1119.6 1133.3 19398.7 19892.2 19960.0 20184.4 20393.8 1068.1 1088.8 1098.4 1127.7 1142.7 10755.8 11409.9 11439.1 11542.5 11576.3 178570.0 497969.0 501914.0 509710.0 518060.0 73344.0 85091.6 85846.6 93057.0 94250.5 1129.5 1144.2 1146.5 1162.2 1175.1 18540.0 18671.3 18726.7 18789.5 19300.6 41022.2 41353.4 41620.6 41911.0 43009.6 58951.7 59385.7 59493.4 60095.0 60883.4 8948.7 9123.9 9141.8 9244.8 9269.5 13558.5 14045.0 14202.9 14279.6 14365.4 11823.3 12132.9 12372.2 12475.2 12697.2 11342.3 11636.9 11800.7 11811.9 12044.5 12408.1 12453.5 12483.4 12520.2 12541.2 8515.7 8667.6 8794.6 8885.0 9008.1 11820.6 12075.6 12101.6 12173.9 12220.9 14:58:43 INFO - PROCESS | 14001 | 14:58:43 INFO - PROCESS | 14001 | [#3] mootools.html Cycles:180 Average:5835.31 Median:4762.98 stddev:3157.71 (66.3%) stddev-sans-first:3150.61 14:58:43 INFO - PROCESS | 14001 | Values: 1610.9 1637.4 1904.4 1967.5 1988.7 7457.8 8528.4 8593.2 8779.5 8844.9 8179.2 8202.9 8246.1 8280.6 8297.0 2443.4 2456.6 2471.4 2475.0 2476.8 2387.5 2492.2 2500.0 2502.8 2502.9 2429.3 2429.6 2438.5 2448.3 2454.0 2388.2 2390.4 2394.6 2411.1 2490.9 2422.8 2426.7 2434.2 2435.6 2440.1 8866.8 8886.1 8923.8 8926.4 8934.1 5241.7 5353.4 5383.5 5384.1 5389.3 3433.4 3537.4 3551.4 3558.5 3590.4 1124.4 1127.5 1133.1 1139.1 1145.9 12267.8 12314.6 12331.3 12339.0 12437.2 4599.8 4753.6 4772.4 4812.1 4833.2 10410.8 10443.3 10453.5 10465.6 10481.8 5395.0 5399.0 5419.3 5434.9 5438.1 4271.9 4849.6 4984.7 4987.2 5003.0 4182.8 4224.2 4264.9 4304.7 4321.8 1399.7 1420.0 1428.0 1429.0 1439.1 1066.3 1074.4 1083.7 1100.1 1104.9 6181.5 6254.1 6305.3 6370.0 6389.6 1061.2 1129.9 1155.5 1163.3 1165.9 4255.4 4284.5 4316.4 4316.9 4389.3 10281.7 10513.5 10636.8 10772.9 10796.7 10430.8 10508.4 10598.3 10627.3 10630.4 7682.7 8463.3 8492.4 8574.7 8586.0 5972.2 6010.4 6053.2 6133.4 6170.3 9027.3 9287.6 9417.0 9515.9 9619.9 9414.3 9940.4 10049.5 10140.4 10220.5 7045.8 7389.2 7523.9 7603.5 7700.3 8139.9 8146.9 8165.8 8186.6 8204.0 7318.3 7623.6 7643.6 7657.0 7734.8 7528.4 7590.4 7673.5 7753.0 7759.0 7195.6 7257.1 7374.1 7412.6 7422.3 5381.0 5410.5 5521.1 5531.6 5575.4 5394.1 5507.7 5542.8 5545.8 5555.9 14:58:43 INFO - PROCESS | 14001 | 14:58:43 INFO - PROCESS | 14001 | [#4] prototype.html Cycles:180 Average:5924.70 Median:6825.59 stddev:1817.30 (26.6%) stddev-sans-first:1773.43 14:58:43 INFO - PROCESS | 14001 | Values: 341.5 344.8 351.7 362.7 365.8 6538.4 6578.6 6609.2 6665.5 6685.7 6690.4 6694.9 6699.3 6700.4 6704.4 5051.6 5058.3 5065.2 5066.6 5070.6 5047.5 5064.2 5074.0 5087.0 5090.4 5033.8 5034.4 5036.8 5037.6 5048.5 4940.7 4979.5 5030.1 5043.7 5044.8 4372.8 4384.1 4394.1 4395.4 4400.9 6404.6 6412.9 6431.0 6434.0 6451.4 5844.1 5853.2 5855.2 5857.3 5858.3 7027.9 7054.9 7062.3 7064.0 7068.4 4641.1 4778.3 4830.4 4897.8 4905.0 7108.5 7211.4 7241.8 7249.3 7255.8 4904.9 4915.1 4954.5 4966.2 4996.3 5043.6 5052.4 5054.4 5055.7 5059.6 5800.0 5806.9 5810.5 5821.0 5821.5 6880.7 6974.8 6999.3 7018.2 7025.6 1746.8 1764.8 1768.7 1772.5 1774.3 1109.2 1161.4 1171.9 1184.8 1198.8 6830.3 6930.7 6936.8 6937.4 6962.2 7375.2 7380.9 7394.0 7422.1 7423.5 6911.3 6919.1 6935.4 6937.7 6938.1 3907.1 3959.5 3988.8 3990.2 3996.0 7714.7 7729.5 7730.4 7732.3 7739.0 7415.6 7418.6 7440.6 7497.1 7509.6 7652.3 7670.2 7672.7 7689.4 7707.7 7115.0 7289.1 7369.4 7377.3 7377.9 7260.8 7277.0 7277.2 7278.1 7290.6 7664.1 7666.5 7723.2 7731.2 7739.3 4825.6 4882.5 4884.5 4886.2 4886.4 7104.9 7351.4 7360.6 7366.3 7389.2 7075.7 7144.7 7189.4 7189.7 7202.7 7095.5 7113.7 7114.4 7115.3 7141.9 6989.1 7014.1 7024.5 7032.9 7050.8 6920.9 7211.4 7213.6 7222.9 7225.1 6820.9 6958.0 6968.7 7018.4 7023.3 14:58:43 INFO - PROCESS | 14001 | 14:58:43 INFO - PROCESS | 14001 | [#5] yui.html Cycles:180 Average:15380.97 Median:4737.57 stddev:17477.43 (368.9%) stddev-sans-first:17492.34 14:58:43 INFO - PROCESS | 14001 | Values: 839.5 868.4 927.4 937.9 945.4 14964.0 15240.9 15245.0 15293.3 15383.8 14002.8 14118.1 14172.2 14189.4 14192.5 734.0 866.2 909.5 910.8 911.1 904.1 908.6 911.7 913.0 917.5 946.1 950.5 953.4 954.1 958.1 944.7 946.4 947.6 947.9 949.1 678.0 678.6 679.9 688.6 696.4 14221.1 14283.6 14302.9 14378.4 14393.4 15014.3 15120.9 15210.2 15295.7 15392.7 11926.6 11963.2 12092.3 12234.1 12269.6 4041.4 4055.4 4109.5 4220.2 4250.2 51022.7 51526.0 54360.2 54758.7 54952.2 11897.9 11986.7 12055.8 12149.4 12174.7 21182.2 21309.4 21327.1 21507.0 21608.0 8579.3 8708.6 8824.7 8841.3 8873.9 4966.5 5042.0 5105.2 5107.4 5137.9 3661.0 3677.3 3702.9 3703.4 3714.3 748.5 751.1 755.4 763.5 781.7 815.4 841.1 859.9 865.8 871.6 9907.2 10625.3 10627.8 10693.6 10750.8 665.8 788.6 797.6 797.7 811.9 4701.9 4773.2 4832.3 4864.9 4904.4 60913.4 61380.7 63063.4 63312.0 63469.7 55129.4 56718.1 57348.7 57429.4 57669.7 50066.2 51151.7 51690.0 51794.2 52324.7 9588.8 9623.5 9723.1 9935.6 9999.2 37662.1 37965.2 38321.0 38831.4 40231.4 46011.5 48513.8 48884.8 49036.3 49449.0 11781.2 12177.3 12262.3 12271.8 12272.3 12669.9 12971.8 13147.3 13349.1 13394.5 12555.9 12802.2 12881.5 12882.4 12996.8 12005.9 12011.9 12035.2 12137.8 12320.3 12296.3 12378.8 12418.4 12619.7 12735.8 10481.5 10573.0 10594.8 10647.5 10699.8 10496.9 10542.4 10574.5 10677.5 10709.5 14:58:43 INFO - PROCESS | 14001 | -------- Summary: end -------- 14:58:43 INFO - PROCESS | 14001 | 14:58:44 INFO - TEST-INFO | 14001: exit 0 14:58:44 INFO - TEST-OK | dromaeo_css | took 1109445ms 14:58:44 INFO - TEST-START | kraken 14:58:44 INFO - operating with platform_type : linux_ 14:58:44 INFO - Initialising browser for kraken test... 14:58:44 INFO - TEST-INFO | started process 14241 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDUmQWb/profile http://localhost:40004/getInfo.html) 14:58:48 INFO - PROCESS | 14241 | 14:58:48 INFO - PROCESS | 14241 | (process:14322): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 14:58:49 INFO - PROCESS | 14241 | __metrics Screen width/height:1600/1200 14:58:49 INFO - PROCESS | 14241 | colorDepth:24 14:58:49 INFO - PROCESS | 14241 | Browser inner width/height: 1024/697 14:58:49 INFO - PROCESS | 14241 | __metrics 14:58:49 ERROR - PROCESS | 14241 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2940: TypeError: this.tabs is undefined 14:58:50 INFO - TEST-INFO | 14241: exit 0 14:58:50 INFO - Browser initialized. 14:58:50 INFO - Running cycle 1/1 for kraken test... 14:58:50 INFO - TEST-INFO | started process 14373 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDUmQWb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:58:52 INFO - PROCESS | 14373 | 14:58:52 INFO - PROCESS | 14373 | (process:14442): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 14:59:02 INFO - PROCESS | 14373 | RSS: Main: 152006656 14:59:02 INFO - PROCESS | 14373 | 14:59:05 INFO - PROCESS | 14373 | Cycle 1(1): loaded http://localhost:40004/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40004/tests/kraken/driver.html?testName=audio-beat-detection) 14:59:05 INFO - PROCESS | 14373 | RSS: Main: 156856320 14:59:05 INFO - PROCESS | 14373 | 14:59:08 INFO - PROCESS | 14373 | Cycle 1(1): loaded http://localhost:40004/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40004/tests/kraken/driver.html?testName=audio-dft) 14:59:09 INFO - PROCESS | 14373 | RSS: Main: 157249536 14:59:09 INFO - PROCESS | 14373 | 14:59:11 INFO - PROCESS | 14373 | Cycle 1(1): loaded http://localhost:40004/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40004/tests/kraken/driver.html?testName=audio-fft) 14:59:12 INFO - PROCESS | 14373 | RSS: Main: 156966912 14:59:12 INFO - PROCESS | 14373 | 14:59:14 INFO - PROCESS | 14373 | Cycle 1(1): loaded http://localhost:40004/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40004/tests/kraken/driver.html?testName=audio-oscillator) 14:59:15 INFO - PROCESS | 14373 | RSS: Main: 157040640 14:59:15 INFO - PROCESS | 14373 | 14:59:17 INFO - PROCESS | 14373 | Cycle 1(1): loaded http://localhost:40004/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40004/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:59:18 INFO - PROCESS | 14373 | RSS: Main: 156733440 14:59:18 INFO - PROCESS | 14373 | 14:59:21 INFO - PROCESS | 14373 | Cycle 1(1): loaded http://localhost:40004/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40004/tests/kraken/driver.html?testName=imaging-darkroom) 14:59:21 INFO - PROCESS | 14373 | RSS: Main: 156971008 14:59:21 INFO - PROCESS | 14373 | 14:59:25 INFO - PROCESS | 14373 | Cycle 1(1): loaded http://localhost:40004/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40004/tests/kraken/driver.html?testName=imaging-desaturate) 14:59:25 INFO - PROCESS | 14373 | RSS: Main: 156979200 14:59:25 INFO - PROCESS | 14373 | 14:59:28 INFO - PROCESS | 14373 | Cycle 1(1): loaded http://localhost:40004/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40004/tests/kraken/driver.html?testName=json-parse-financial) 14:59:29 INFO - PROCESS | 14373 | RSS: Main: 157474816 14:59:29 INFO - PROCESS | 14373 | 14:59:30 INFO - PROCESS | 14373 | Cycle 1(1): loaded http://localhost:40004/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40004/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:59:31 INFO - PROCESS | 14373 | RSS: Main: 157499392 14:59:31 INFO - PROCESS | 14373 | 14:59:33 INFO - PROCESS | 14373 | Cycle 1(1): loaded http://localhost:40004/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40004/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:59:33 INFO - PROCESS | 14373 | RSS: Main: 157581312 14:59:33 INFO - PROCESS | 14373 | 14:59:35 INFO - PROCESS | 14373 | Cycle 1(1): loaded http://localhost:40004/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40004/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:59:36 INFO - PROCESS | 14373 | RSS: Main: 157585408 14:59:36 INFO - PROCESS | 14373 | 14:59:38 INFO - PROCESS | 14373 | Cycle 1(1): loaded http://localhost:40004/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40004/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:59:39 INFO - PROCESS | 14373 | RSS: Main: 158613504 14:59:39 INFO - PROCESS | 14373 | 14:59:42 INFO - PROCESS | 14373 | Cycle 1(1): loaded http://localhost:40004/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40004/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:59:42 INFO - PROCESS | 14373 | RSS: Main: 158003200 14:59:42 INFO - PROCESS | 14373 | 14:59:44 INFO - PROCESS | 14373 | Cycle 1(1): loaded http://localhost:40004/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40004/tests/kraken/driver.html?testName=ai-astar) 14:59:44 INFO - PROCESS | 14373 | RSS: Main: 159371264 14:59:44 INFO - PROCESS | 14373 | 14:59:44 INFO - PROCESS | 14373 | __start_tp_report 14:59:44 INFO - PROCESS | 14373 | _x_x_mozilla_page_load 14:59:44 INFO - PROCESS | 14373 | _x_x_mozilla_page_load_details 14:59:44 INFO - PROCESS | 14373 | |i|pagename|runs| 14:59:44 INFO - PROCESS | 14373 | |0;ai-astar;108;111;104;109;113;112;100;111;112;112 14:59:44 INFO - PROCESS | 14373 | |1;audio-beat-detection;156;127;156;184;127;157;153;131;180;134 14:59:44 INFO - PROCESS | 14373 | |2;audio-dft;162;162;162;161;166;162;162;161;161;164 14:59:44 INFO - PROCESS | 14373 | |3;audio-fft;73;77;76;167;77;77;75;77;160;75 14:59:44 INFO - PROCESS | 14373 | |4;audio-oscillator;92;93;161;92;93;92;150;92;92;152 14:59:44 INFO - PROCESS | 14373 | |5;imaging-gaussian-blur;118;118;117;117;117;117;118;117;117;117 14:59:44 INFO - PROCESS | 14373 | |6;imaging-darkroom;147;147;147;148;147;148;149;147;147;146 14:59:44 INFO - PROCESS | 14373 | |7;imaging-desaturate;95;95;95;98;95;95;95;96;96;95 14:59:44 INFO - PROCESS | 14373 | |8;json-parse-financial;59;55;55;55;54;58;55;74;53;54 14:59:44 INFO - PROCESS | 14373 | |9;json-stringify-tinderbox;57;57;57;57;57;57;57;57;57;57 14:59:44 INFO - PROCESS | 14373 | |10;stanford-crypto-aes;74;74;76;73;74;73;77;75;74;75 14:59:44 INFO - PROCESS | 14373 | |11;stanford-crypto-ccm;115;115;113;114;128;113;124;112;131;134 14:59:44 INFO - PROCESS | 14373 | |12;stanford-crypto-pbkdf2;158;156;157;161;158;162;157;158;162;160 14:59:44 INFO - PROCESS | 14373 | |13;stanford-crypto-sha256-iterative;68;67;67;69;66;74;68;66;70;65 14:59:44 INFO - PROCESS | 14373 | __end_tp_report 14:59:44 INFO - PROCESS | 14373 | __start_cc_report 14:59:44 INFO - PROCESS | 14373 | _x_x_mozilla_cycle_collect,822 14:59:44 INFO - PROCESS | 14373 | __end_cc_report 14:59:44 INFO - PROCESS | 14373 | __startTimestamp1464645584627__endTimestamp 14:59:44 INFO - PROCESS | 14373 | 14:59:44 INFO - PROCESS | 14373 | ------- Summary: start ------- 14:59:44 INFO - PROCESS | 14373 | Number of tests: 14 14:59:44 INFO - PROCESS | 14373 | 14:59:44 INFO - PROCESS | 14373 | [#0] ai-astar Cycles:10 Average:109.20 Median:111.50 stddev:4.18 (3.8%) stddev-sans-first:4.42 14:59:44 INFO - PROCESS | 14373 | Values: 108.0 111.0 104.0 109.0 113.0 112.0 100.0 111.0 112.0 112.0 14:59:44 INFO - PROCESS | 14373 | 14:59:44 INFO - PROCESS | 14373 | [#1] audio-beat-detection Cycles:10 Average:150.50 Median:156.00 stddev:20.71 (13.3%) stddev-sans-first:21.87 14:59:44 INFO - PROCESS | 14373 | Values: 156.0 127.0 156.0 184.0 127.0 157.0 153.0 131.0 180.0 134.0 14:59:44 INFO - PROCESS | 14373 | 14:59:44 INFO - PROCESS | 14373 | [#2] audio-dft Cycles:10 Average:162.30 Median:162.00 stddev:1.57 (1.0%) stddev-sans-first:1.66 14:59:44 INFO - PROCESS | 14373 | Values: 162.0 162.0 162.0 161.0 166.0 162.0 162.0 161.0 161.0 164.0 14:59:44 INFO - PROCESS | 14373 | 14:59:44 INFO - PROCESS | 14373 | [#3] audio-fft Cycles:10 Average:93.40 Median:76.50 stddev:37.01 (48.4%) stddev-sans-first:38.51 14:59:44 INFO - PROCESS | 14373 | Values: 73.0 77.0 76.0 167.0 77.0 77.0 75.0 77.0 160.0 75.0 14:59:44 INFO - PROCESS | 14373 | 14:59:44 INFO - PROCESS | 14373 | [#4] audio-oscillator Cycles:10 Average:110.90 Median:92.00 stddev:30.10 (32.7%) stddev-sans-first:31.14 14:59:44 INFO - PROCESS | 14373 | Values: 92.0 93.0 161.0 92.0 93.0 92.0 150.0 92.0 92.0 152.0 14:59:44 INFO - PROCESS | 14373 | 14:59:44 INFO - PROCESS | 14373 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 14:59:44 INFO - PROCESS | 14373 | Values: 118.0 118.0 117.0 117.0 117.0 117.0 118.0 117.0 117.0 117.0 14:59:44 INFO - PROCESS | 14373 | 14:59:44 INFO - PROCESS | 14373 | [#6] imaging-darkroom Cycles:10 Average:147.30 Median:147.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 14:59:44 INFO - PROCESS | 14373 | Values: 147.0 147.0 147.0 148.0 147.0 148.0 149.0 147.0 147.0 146.0 14:59:44 INFO - PROCESS | 14373 | 14:59:44 INFO - PROCESS | 14373 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:95.00 stddev:0.97 (1.0%) stddev-sans-first:1.01 14:59:44 INFO - PROCESS | 14373 | Values: 95.0 95.0 95.0 98.0 95.0 95.0 95.0 96.0 96.0 95.0 14:59:44 INFO - PROCESS | 14373 | 14:59:44 INFO - PROCESS | 14373 | [#8] json-parse-financial Cycles:10 Average:57.20 Median:55.00 stddev:6.18 (11.2%) stddev-sans-first:6.52 14:59:44 INFO - PROCESS | 14373 | Values: 59.0 55.0 55.0 55.0 54.0 58.0 55.0 74.0 53.0 54.0 14:59:44 INFO - PROCESS | 14373 | 14:59:44 INFO - PROCESS | 14373 | [#9] json-stringify-tinderbox Cycles:10 Average:57.00 Median:57.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 14:59:44 INFO - PROCESS | 14373 | Values: 57.0 57.0 57.0 57.0 57.0 57.0 57.0 57.0 57.0 57.0 14:59:44 INFO - PROCESS | 14373 | 14:59:44 INFO - PROCESS | 14373 | [#10] stanford-crypto-aes Cycles:10 Average:74.50 Median:74.50 stddev:1.27 (1.7%) stddev-sans-first:1.33 14:59:44 INFO - PROCESS | 14373 | Values: 74.0 74.0 76.0 73.0 74.0 73.0 77.0 75.0 74.0 75.0 14:59:44 INFO - PROCESS | 14373 | 14:59:44 INFO - PROCESS | 14373 | [#11] stanford-crypto-ccm Cycles:10 Average:119.90 Median:119.50 stddev:8.46 (7.1%) stddev-sans-first:8.79 14:59:44 INFO - PROCESS | 14373 | Values: 115.0 115.0 113.0 114.0 128.0 113.0 124.0 112.0 131.0 134.0 14:59:44 INFO - PROCESS | 14373 | 14:59:44 INFO - PROCESS | 14373 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.90 Median:159.00 stddev:2.18 (1.4%) stddev-sans-first:2.29 14:59:44 INFO - PROCESS | 14373 | Values: 158.0 156.0 157.0 161.0 158.0 162.0 157.0 158.0 162.0 160.0 14:59:44 INFO - PROCESS | 14373 | 14:59:44 INFO - PROCESS | 14373 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.00 Median:68.00 stddev:2.58 (3.8%) stddev-sans-first:2.74 14:59:44 INFO - PROCESS | 14373 | Values: 68.0 67.0 67.0 69.0 66.0 74.0 68.0 66.0 70.0 65.0 14:59:44 INFO - PROCESS | 14373 | -------- Summary: end -------- 14:59:44 INFO - PROCESS | 14373 | 14:59:45 INFO - TEST-INFO | 14373: exit 0 14:59:45 INFO - TEST-OK | kraken | took 61158ms 14:59:45 INFO - SUITE-END | took 1170s 14:59:45 INFO - Completed test suite (00:19:30) 14:59:45 INFO - javascript benchmark 14:59:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3368.9831550842246, 3423.863045478181, 3440.7935523868587, 3456.9135771605706, 3465.8613655453782, 5737.34020587632, 5742.4831765141125, 5753.108268218432, 5772.105323674832, 5776.508996735282, 5680.289963754531, 5696.373398926125, 5723.570732195081, 5750.597458177929, 5781.161731548933, 5184.818531351403, 5188.8702782430555, 5220.243064755608, 5256.789728410859, 5266.710330931797, 5100.438951715309, 5191.299174611436, 5201.947980520203, 5357.303550538424, 5362.785488580472, 5066.18940969445, 5228.843134705965, 5232.45059268777, 5236.738163091849, 5290.7354632268425, 5190.039842629107, 5205.375354957391, 5209.114450543417, 5220.634555581111, 5220.981908527839, 5054.772535235887, 5059.671121377099, 5121.462246464105, 5174.353205849269, 5193.8961220775755, 5579.609427340088, 5642.802501912454, 5662.716864156776, 5679.233303504016, 5714.1428785682065, 6151.753929842801, 6167.537434692371, 6177.814665559996, 6194.442500175006, 6196.659183744892, 5945.197398351211, 6037.973544497446, 6214.627122372627, 6242.781502647431, 6262.060690896356, 5713.085906255021, 5716.428357164292, 5720.1991721159075, 5748.42515748426, 5749.856253593652, 6236.126942228092, 6248.4376406123665, 6275.403836635513, 6286.277078135981, 6293.874122517524, 5858.707064646751, 5995.0, 6035.275766907999, 6037.366076561898, 6070.939290607126, 6142.232220972379, 6142.621558143003, 6144.109104179958, 6152.630842149396, 6160.9383906160365, 6031.24609423822, 6085.257248556763, 6109.11417844419, 6110.694465276719, 6140.907886381708, 5890.4993075589055, 6059.575829691879, 6107.175531303306, 6112.473085128069, 6161.691915404212, 4624.838130665411, 4639.327297541838, 4641.86074417768, 4658.440987081572, 4667.229907065364, 4129.566395528426, 4177.143685544517, 4180.665546756252, 4184.205001049791, 4203.32746760523, 5738.397468265855, 5867.677277749679, 5893.410658934073, 5925.288965324189, 5954.136650185699, 6079.0, 6144.692765361803, 6147.44672979434, 6154.846128846725, 6156.815295541141, 5792.797252096157, 5879.118132280107, 5885.146653735184, 5897.32180799205, 5924.851878703067, 5272.525472707474, 5319.893602127936, 5325.573954083664, 5334.973325133349, 5350.170723537858, 6321.0, 6383.872322553523, 6386.329435409308, 6393.136926514954, 6398.744050238031, 5878.911816322673, 6112.541559382975, 6152.0, 6160.907586386118, 6184.319724830265, 6296.212973378328, 6356.173697419306, 6363.713632886624, 6383.36166383358, 6391.904121438275, 5926.348101708722, 5981.521478281814, 6017.939820601738, 6045.455908968214, 6045.576809623284, 6013.188219590475, 6089.269287685506, 6144.709610981744, 6153.476954458921, 6223.813285601439, 5978.611390259619, 5990.281166260077, 5996.700164991646, 6064.909026364519, 6067.059605761114, 5995.190649262294, 6015.72929218195, 6040.818775436744, 6041.607295525777, 6059.606125601822, 5717.313922329347, 5856.238688970577, 5898.292204935436, 5953.1367951647635, 5961.225040744675, 6079.878402431838, 6089.117078023751, 6099.085137229451, 6124.755009799558, 6127.84680382994, 5929.16991621182, 5952.434518720715, 5960.672163031075, 5963.552733545088, 5977.491913187254], "value": 5660.3157881582065, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [673.6261374936909, 681.2880539835871, 695.8295217671671, 744.5160645580376, 749.5764892835548, 38747.0, 39577.208455830936, 39652.60347396525, 39698.603013969885, 39708.80145599268, 43412.131757364834, 43972.780136099274, 44144.3378349325, 44165.0, 44273.77863110688, 8773.649054037847, 8902.465852048865, 8945.15021072997, 9004.8649270261, 9012.77468063297, 8798.076201998794, 8863.468191908474, 8905.332100092486, 8919.197272245498, 8919.331050171231, 9073.41022833517, 9132.0, 9144.72565823023, 9198.0, 9218.76953076175, 8956.686515971942, 9135.40619859707, 9168.26653867689, 9171.266298696088, 9190.678326258583, 8790.56047197644, 9057.411268267608, 9069.637214511478, 9077.500737459437, 9078.0, 43819.78090109561, 44079.559204407866, 44419.0, 44450.55549444529, 44532.3320150198, 3922.8038598069984, 3990.082281075369, 4045.1707399982934, 4075.8777236682945, 4290.29210180323, 33723.325533489195, 33828.661713383044, 34603.0, 34687.30625387503, 35657.64342356569, 4611.907761844778, 4632.652551058651, 4647.883802904955, 4654.25531914892, 4690.0, 318055.0, 318400.0, 320191.3990430056, 320838.0, 321077.0, 39173.80413097973, 63709.36290637127, 64230.67884660547, 64248.357516425174, 64272.357276427574, 37769.0, 37951.81024094862, 37989.43015854764, 38030.42954355687, 38044.0, 16144.112073836051, 16493.092879891483, 16503.33986640545, 16529.33882644681, 16560.917195413946, 12804.103712740205, 12842.550510732266, 12890.355482225852, 12906.67733306656, 12928.676783080311, 9237.90762092384, 9293.117153870508, 9320.254379649747, 9324.347295689373, 9331.0, 3572.678109099598, 3612.5303710517464, 3635.4728564358547, 3639.94540081899, 3653.159773252167, 1136.9488373023069, 1164.988350116488, 1168.0363699947577, 1249.6625911003978, 1257.9182353147016, 33085.83457082699, 33266.334673306395, 33506.32987340288, 33793.15517112043, 33805.15487112842, 1255.7237407770276, 1260.489501751792, 1290.4902563487558, 1354.7696891528465, 1360.5782207515701, 16974.0, 17140.0, 17369.4789156323, 17414.409912071915, 17735.379261726037, 496348.0, 505019.0, 515859.0, 516447.0, 792669.0, 62071.37928620656, 63264.0, 63775.36224637694, 63878.0, 63888.68055659692, 1563.8905276630753, 1570.4424929150216, 1571.8506741859505, 1579.0525684589154, 1639.3442622950677, 32647.0, 33949.83025084859, 33949.83025084859, 34203.657963420046, 34794.13014674653, 54051.72974135104, 55073.724631376586, 55165.17252241139, 55178.79284828562, 55212.72393638006, 430742.0, 432542.0, 434914.0, 435285.0, 436364.0, 30286.69713302927, 31084.37831243317, 31300.0, 31309.217269567533, 31438.842805785825, 50963.74518127534, 51052.744736277564, 51346.486535135664, 52991.735041324544, 53357.733211335246, 43036.78481607572, 43270.0, 43291.78354108209, 43567.78216109026, 44795.328070079624, 42103.31586736496, 42650.573494265904, 42674.57325426706, 43763.56236437722, 44096.0, 41697.79151104225, 43131.568684314014, 43472.130557389304, 43930.12139757251, 44175.77912110419, 35124.473132903535, 35795.0, 36454.906352809456, 36572.63427365692, 38138.0, 29073.383395494508, 30421.391572168875, 30601.23496912595, 31556.842215788773, 32318.83840580782], "value": 19982.380724966122, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [426.7716771527233, 429.7335651895824, 435.52161596255695, 437.35490152025767, 448.4215362182782, 19105.14026868791, 19695.606087878234, 19730.210791568337, 19999.300024499145, 20469.590608187864, 19081.332153374635, 19434.90282548589, 20859.165633374683, 20896.477588060305, 20957.790422095775, 5748.137779333092, 5796.188533605288, 5814.738336774855, 5896.23348964634, 5963.582549221556, 5838.562107841907, 5851.093080572497, 5885.234919460464, 5893.0, 5897.911531327012, 5739.770409183628, 5778.59549831512, 5865.560082993771, 5898.174255604219, 5907.88184236315, 5806.1000544915605, 5819.73811178498, 5824.912626310609, 5853.824385268449, 5889.440503152194, 5290.127129023706, 5307.734613269321, 5313.574914006909, 5353.9196912046355, 5361.437049109826, 24227.152049678352, 24594.754052459426, 24640.0, 25014.874925625438, 25039.0, 2589.909353172649, 3154.7003034711665, 3284.8029118252744, 3289.358575077837, 3348.1294863335465, 15312.923435382752, 15358.155301458528, 15370.0, 15518.922405388013, 15881.444149454714, 2019.6667549854255, 2140.090461553849, 2150.483883867876, 2178.0525471419983, 2207.724034495688, 81401.0, 82443.0, 84251.5787421065, 84710.57644711738, 85337.0, 11272.323660580392, 11341.829872551918, 11601.477933493014, 11715.297082175097, 12162.939185304194, 15476.148811815458, 15579.688406231811, 15600.453984110502, 15611.0, 15664.451744188898, 8623.137686231326, 8773.122687731176, 8783.780405489786, 8882.51146186953, 9036.593353298986, 8295.8340833183, 8354.8329033419, 8366.790830229293, 8366.916330836613, 8396.538190399464, 5030.84907452777, 5098.490150984946, 5135.537801597874, 5159.974200128975, 5183.403908550565, 2043.9182432702823, 2160.611090003783, 2183.4541364658835, 2210.624193887043, 2221.600111979827, 999.7050869993369, 1053.847192157133, 1073.838924161382, 1119.6249256499002, 1133.3256712256195, 19398.70901936472, 19892.204311827656, 19960.0, 20184.36109345198, 20393.796062039488, 1068.0547715271884, 1088.77135801481, 1098.4288170151476, 1127.7349822791637, 1142.7086093046387, 10755.83866242007, 11409.942950285362, 11439.142064345207, 11542.538298468135, 11576.305421674726, 178570.0, 497969.0, 501914.0, 509710.0, 518060.0, 73344.0, 85091.57454212813, 85846.57076714576, 93057.0, 94250.5287473572, 1129.5312445335094, 1144.2333636463422, 1146.5184622458587, 1162.2329262686756, 1175.059952038366, 18540.0, 18671.34650287288, 18726.71909921325, 18789.530261743566, 19300.613987720448, 41022.17955640811, 41353.379699303936, 41620.58379416167, 41911.0, 43009.56990430056, 58951.705241473515, 59385.703071486096, 59493.405065948784, 60095.0, 60883.39116608777, 8948.68679596237, 9123.908760912305, 9141.77145571366, 9244.815103698023, 9269.490178040003, 13558.457661693421, 14045.0, 14202.92898535542, 14279.64300892486, 14365.425382984564, 11823.290602563873, 12132.939335303266, 12372.1958072725, 12475.189112707645, 12697.238165710087, 11342.319460832046, 11636.883631163919, 11800.70498237551, 11811.940940295244, 12044.457999389873, 12408.131430800118, 12453.501859925502, 12483.438245279165, 12520.248785072561, 12541.184822986477, 8515.659373624985, 8667.566621669017, 8794.648214071365, 8885.0, 9008.099190080939, 11820.645380638594, 12075.57735479254, 12101.576444824388, 12173.878261217274, 12220.87779122233], "value": 9794.28935853418, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1610.9194540272983, 1637.4105322084051, 1904.352520143151, 1967.5081229692569, 1988.691752778318, 7457.813554661137, 8528.403011789178, 8593.226609605133, 8779.517126558037, 8844.867326990092, 8179.222973817493, 8202.91797082029, 8246.134155913633, 8280.585970701455, 8297.0, 2443.364725171459, 2456.6437866509345, 2471.3574470637673, 2474.9628755568683, 2476.826622136451, 2387.4986252886915, 2492.190038237571, 2499.950000999979, 2502.8122890783175, 2502.924912252626, 2429.3197904586655, 2429.6355546667965, 2438.5001074779716, 2448.2777580613674, 2454.0306578901414, 2388.2238272561485, 2390.378576456661, 2394.6168613022005, 2411.1199412214505, 2490.86300253486, 2422.7577242275806, 2426.6845310109748, 2434.1967150840355, 2435.622478515833, 2440.0727723465147, 8866.822663546758, 8886.06696296886, 8923.821523569557, 8926.419782714167, 8934.06192349807, 5241.659292145999, 5353.411124776271, 5383.542398896098, 5384.057789886754, 5389.326334208224, 3433.4334834752235, 3537.4340105582983, 3551.378508760982, 3558.5195998540385, 3590.35373632746, 1124.4082390090837, 1127.5433449452985, 1133.1388145009769, 1139.1114930354338, 1145.8911403416746, 12267.815982760265, 12314.568990085394, 12331.321777302244, 12339.0, 12437.191582547106, 4599.770011499479, 4753.572178503951, 4772.379590653193, 4812.06164797868, 4833.202521583899, 10410.791784164274, 10443.32118412316, 10453.529591168415, 10465.581376744845, 10481.842772358421, 5395.0, 5398.973005134949, 5419.295491586068, 5434.91847622286, 5438.129899216106, 4271.893202669896, 4849.587785038311, 4984.700917944935, 4987.226979818134, 5003.024410239968, 4182.811773470201, 4224.176285624335, 4264.914701705949, 4304.655627549789, 4321.827126914888, 1399.720055988786, 1420.013090901834, 1428.028940320592, 1429.0425414971994, 1439.100562148657, 1066.3282132256784, 1074.355386767933, 1083.6911480228255, 1100.0594491709633, 1104.8563686720674, 6181.474574661204, 6254.061890716429, 6305.3379395163765, 6369.9681501592195, 6389.616623002635, 1061.2093989977516, 1129.9096072314196, 1155.5435602936961, 1163.2962057954985, 1165.918385712992, 4255.4255175551525, 4284.507281662586, 4316.417283666665, 4316.913661726748, 4389.253826849444, 10281.691549253534, 10513.52689128991, 10636.840447393295, 10772.946135269274, 10796.730081747863, 10430.791384172275, 10508.369497830156, 10598.31110977784, 10627.309224900357, 10630.362178269328, 7682.654280557388, 8463.322934165251, 8492.363072769567, 8574.742757717278, 8586.0, 5972.223610930551, 6010.368911264254, 6053.243344581927, 6133.417325354084, 6170.290416601969, 9027.32295077885, 9287.582058807506, 9417.0, 9515.857262140935, 9619.90380096218, 9414.293927955294, 9940.353876997971, 10049.497525123568, 10140.391576505433, 10220.540075696463, 7045.753398631024, 7389.224131466119, 7523.924760752322, 7603.505772124794, 7700.3454706350585, 8139.918600814153, 8146.877796832934, 8165.79585510367, 8186.590670466572, 8203.958980205061, 7318.3047610476915, 7623.580703061385, 7643.5796031218815, 7657.0, 7734.806629834299, 7528.397728181842, 7590.430717696085, 7673.462857599914, 7753.0, 7758.9612051939375, 7195.632829762329, 7257.129144502694, 7374.1151061872915, 7412.555246685216, 7422.257774222535, 5380.973095134499, 5410.513053825174, 5521.061419558604, 5531.612787104864, 5575.4424557543925, 5394.136938089887, 5507.7246137693755, 5542.806001789918, 5545.805896793593, 5555.861103472445], "value": 4779.395759316864, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [341.45196958880996, 344.77417291673953, 351.73795522335865, 362.650042708786, 365.82988910156774, 6538.444232240259, 6578.60528368297, 6609.239937407194, 6665.4667626589935, 6685.69914353854, 6690.364415380531, 6694.899576506356, 6699.263081061079, 6700.430463410616, 6704.430123439502, 5051.621128415374, 5058.266551350052, 5065.189569668853, 5066.645334826564, 5070.594352451795, 5047.49525047496, 5064.189729643258, 5073.974630126844, 5086.97456512717, 5090.414602320743, 5033.848984530452, 5034.370703662043, 5036.84889453317, 5037.596992240612, 5048.4951504849405, 4940.685829450554, 4979.526944940225, 5030.119729047438, 5043.697378157304, 5044.772985215655, 4372.846950356754, 4384.145091707119, 4394.077243778778, 4395.37371172665, 4400.933985990213, 6404.647744374058, 6412.871742565123, 6431.0, 6433.967830160819, 6451.41937225652, 5844.094165404326, 5853.180554722342, 5855.209546711182, 5857.297124345063, 5858.2677165354335, 7027.89458158128, 7054.894176587355, 7062.293770622948, 7064.0, 7068.39918606919, 4641.071785642885, 4778.259369797687, 4830.420349558076, 4897.7795999180125, 4904.950950490485, 7108.537945033608, 7211.423086153095, 7241.782746517613, 7249.275072492708, 7255.818604534928, 4904.92642610354, 4915.090708218991, 4954.455009948902, 4966.15575352191, 4996.275540046673, 5043.5965122790085, 5052.368453943257, 5054.393472783289, 5055.671381360274, 5059.645824792229, 5800.01399762033, 5806.912896306559, 5810.5061069809535, 5821.039528477754, 5821.476067153892, 6880.724771009203, 6974.755883544153, 6999.335063168991, 7018.157821061505, 7025.613591252531, 1746.7729195204543, 1764.7529345891585, 1768.7170052791491, 1772.512559046247, 1774.2814160265114, 1109.1570406491126, 1161.4425075963584, 1171.9296842189497, 1184.7926612842718, 1198.7602479504135, 6830.282820303896, 6930.722771089201, 6936.757213497604, 6937.375636192767, 6962.199347075049, 7375.151857536452, 7380.926190738024, 7393.963030184815, 7422.109346878301, 7423.48035637511, 6911.308869113049, 6919.135108111486, 6935.410490108397, 6937.653117344214, 6938.06336144614, 3907.1404291055924, 3959.4852669152824, 3988.8205030773684, 3990.20195960809, 3995.9810248386475, 7714.691412343555, 7729.458937874295, 7730.381569474429, 7732.30409263169, 7739.0, 7415.629218539051, 7418.591977441292, 7440.590767507839, 7497.137829149718, 7509.62451877404, 7652.311291983637, 7670.156282808886, 7672.73145439907, 7689.38484921205, 7707.653155608011, 7114.964425177841, 7289.088863892013, 7369.410447164107, 7377.3360397564475, 7377.926220737724, 7260.782176534713, 7276.96361518189, 7277.16312624055, 7278.053852999076, 7290.635468226674, 7664.11862635804, 7666.4633475656165, 7723.227677232457, 7731.226877312449, 7739.3034626883855, 4825.5898248649255, 4882.5361590650255, 4884.511548845229, 4886.169351210232, 4886.364772579542, 7104.928950710427, 7351.4118870489165, 7360.631968401452, 7366.337029667356, 7389.224131466119, 7075.71697132109, 7144.678489467882, 7189.352958233784, 7189.7483588074165, 7202.71189152428, 7095.503314767917, 7113.679884405111, 7114.395276401357, 7115.252898445796, 7141.892871607034, 6989.126359205099, 7014.123234595676, 7024.5082844200415, 7032.945058241305, 7050.753223637148, 6920.927256275286, 7211.350978411968, 7213.60325182099, 7222.89165662526, 7225.1329840419485, 6820.897686534607, 6958.0, 6968.721251149897, 7018.438524918097, 7023.297670232936], "value": 5323.523368248312, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [839.4795226959278, 868.3617541107285, 927.3925578745922, 937.8780758501393, 945.418567580938, 14964.0, 15240.923795381008, 15245.0, 15293.311800968955, 15383.846161538382, 14002.789958150635, 14118.08232464889, 14172.220527870963, 14189.43242270308, 14192.503262385819, 734.0274136768803, 866.2333834556431, 909.5088652127843, 910.8178364327127, 911.1298709732223, 904.1139683110556, 908.609298001859, 911.6900253913668, 913.0, 917.4862077236735, 946.1248345280623, 950.496236994394, 953.4327075390132, 954.0888451528808, 958.104172598619, 944.6788092048668, 946.4179529589322, 947.6304241345846, 947.8909925358603, 949.103097572794, 678.0270312102149, 678.6097993653669, 679.8810208213592, 688.6074937285749, 696.3871792822284, 14221.075630084115, 14283.571492855232, 14302.856971430256, 14378.424863005468, 14393.352299146563, 15014.324355404033, 15120.924395377953, 15210.16344101074, 15295.694086118327, 15392.692146157126, 11926.582569610022, 11963.1625786195, 12092.274463532216, 12234.08244381666, 12269.631911042594, 4041.4139949707424, 4055.3511438170044, 4109.486314210723, 4220.198162349144, 4250.213710463543, 51022.7448862757, 51526.0, 54360.18459723108, 54758.72620636911, 54952.17571736387, 11897.88102118985, 11986.700332491757, 12055.819162712567, 12149.392530373447, 12174.695632609255, 21182.15271389158, 21309.36071917845, 21327.146914123263, 21507.0, 21608.0, 8579.313654907592, 8708.564571771387, 8824.691135810215, 8841.336899732418, 8873.91126088731, 4966.528179822911, 5041.974790126099, 5105.157648987875, 5107.387113546398, 5137.871553211125, 3660.9633903660624, 3677.282929828711, 3702.851885924533, 3703.407454807218, 3714.257148570297, 748.5396481164154, 751.0649241694126, 755.3541721827868, 763.4579448591451, 781.7342103684774, 815.38031096366, 841.0958219913617, 859.9312055035582, 865.7835541114721, 871.6426265231224, 9907.207423406111, 10625.309354891908, 10627.775134792193, 10693.625723099654, 10750.78498430027, 665.8102440804347, 788.5505262000719, 797.5852556670499, 797.6649807081039, 811.9188081191834, 4701.905961880743, 4773.236282194902, 4832.347633069561, 4864.902701945941, 4904.43598986114, 60913.39086609077, 61380.69309653423, 63063.36936630575, 63312.0, 63469.68265158737, 55129.448705513234, 56718.14922776162, 57348.71325643345, 57429.42570574324, 57669.71165144231, 50066.24900626494, 51151.74424127855, 51690.0, 51794.22308665373, 52324.73837630863, 9588.76028099303, 9623.518824058909, 9723.124918757347, 9935.602575896883, 9999.200063994718, 37662.05844853791, 37965.24069518649, 38321.0, 38831.41752873653, 40231.396529051504, 46011.53988460072, 48513.757431212616, 48884.75557622189, 49036.2644560339, 49449.0, 11781.23421977603, 12177.33024683651, 12262.325572093263, 12271.75456490883, 12272.263664180178, 12669.949364060561, 12971.805422918853, 13147.276899770604, 13349.132306400053, 13394.531191408254, 12555.93722031384, 12802.231866088065, 12881.549145779853, 12882.35588220604, 12996.805047924478, 12005.939970300093, 12011.879881201427, 12035.157538972187, 12137.817932730839, 12320.260784352968, 12296.262224266573, 12378.75242495127, 12418.379081046092, 12619.684507887376, 12735.80896286538, 10481.528331225265, 10572.995565421274, 10594.788104237718, 10647.467626618483, 10699.786004280026, 10496.947515262375, 10542.376756275838, 10574.471276435994, 10677.46612669379, 10709.464526773785], "value": 7187.2882289309755, "unit": "score"}], "name": "dromaeo_css", "value": 7663.70799891844, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 111.0, 104.0, 109.0, 113.0, 112.0, 100.0, 111.0, 112.0, 112.0], "value": 109.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 127.0, 156.0, 184.0, 127.0, 157.0, 153.0, 131.0, 180.0, 134.0], "value": 150.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 161.0, 166.0, 162.0, 162.0, 161.0, 161.0, 164.0], "value": 162.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 77.0, 76.0, 167.0, 77.0, 77.0, 75.0, 77.0, 160.0, 75.0], "value": 93.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 93.0, 161.0, 92.0, 93.0, 92.0, 150.0, 92.0, 92.0, 152.0], "value": 110.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 148.0, 147.0, 148.0, 149.0, 147.0, 147.0, 146.0], "value": 147.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 98.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 55.0, 55.0, 55.0, 54.0, 58.0, 55.0, 74.0, 53.0, 54.0], "value": 57.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 57.0, 57.0, 57.0, 57.0, 57.0, 57.0, 57.0, 57.0], "value": 57.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 76.0, 73.0, 74.0, 73.0, 77.0, 75.0, 74.0, 75.0], "value": 74.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 115.0, 113.0, 114.0, 128.0, 113.0, 124.0, 112.0, 131.0, 134.0], "value": 119.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 156.0, 157.0, 161.0, 158.0, 162.0, 157.0, 158.0, 162.0, 160.0], "value": 158.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 67.0, 69.0, 66.0, 74.0, 68.0, 66.0, 70.0, 65.0], "value": 68.0, "unit": "score"}], "name": "kraken", "value": 1521.9, "alertThreshold": 2.0}]} 14:59:45 INFO - Return code: 0 14:59:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 14:59:45 ERROR - # TBPL SUCCESS # 14:59:45 INFO - Running post-action listener: _resource_record_post_action 14:59:45 INFO - Running post-run listener: _resource_record_post_run 14:59:47 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 4096; Write bytes: 505806848; Read time: 12; Write time: 552864 14:59:47 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 258322432; Read time: 0; Write time: 341168 14:59:47 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 4096; Write bytes: 247484416; Read time: 12; Write time: 211696 14:59:47 INFO - Running post-run listener: _upload_blobber_files 14:59:47 INFO - Blob upload gear active. 14:59:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:59:47 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 14:59:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:59:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:59:47 INFO - (blobuploader) - INFO - Open directory for files ... 14:59:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:59:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:59:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:59:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:59:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:59:48 INFO - (blobuploader) - INFO - Done attempting. 14:59:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:59:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:59:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:59:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:59:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:59:49 INFO - (blobuploader) - INFO - Done attempting. 14:59:49 INFO - (blobuploader) - INFO - Iteration through files over. 14:59:49 INFO - Return code: 0 14:59:49 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:59:49 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:59:49 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/386dce9b7dfc66ec80611ab297749d5d7e86f24267f9e7d2ed8c651250771968bcfa4033f56ea161ac46932ff84c8ae2ca666e1b0487b39bdb30c0e06116a2d5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f46f46da2716eeb45b121e9d2bb4f70e8cabedb93467238c22f853db29d55dc60433f512e9a02724452d12cc05ff17e30a58e0c42c65d1e98d3c5a9bcbe0e8ae"} 14:59:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:59:49 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:59:49 INFO - Contents: 14:59:49 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/386dce9b7dfc66ec80611ab297749d5d7e86f24267f9e7d2ed8c651250771968bcfa4033f56ea161ac46932ff84c8ae2ca666e1b0487b39bdb30c0e06116a2d5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f46f46da2716eeb45b121e9d2bb4f70e8cabedb93467238c22f853db29d55dc60433f512e9a02724452d12cc05ff17e30a58e0c42c65d1e98d3c5a9bcbe0e8ae"} 14:59:49 INFO - Running post-run listener: copy_logs_to_upload_dir 14:59:49 INFO - Copying logs to upload dir... 14:59:49 INFO - mkdir: /builds/slave/test/build/upload/logs 14:59:49 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1229.795498 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-05-30 14:59:48.357034) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-30 14:59:48.361215) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a12cd81e0ef515edd9e0d800000001bb-1464644336.425281-1609355336 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/386dce9b7dfc66ec80611ab297749d5d7e86f24267f9e7d2ed8c651250771968bcfa4033f56ea161ac46932ff84c8ae2ca666e1b0487b39bdb30c0e06116a2d5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f46f46da2716eeb45b121e9d2bb4f70e8cabedb93467238c22f853db29d55dc60433f512e9a02724452d12cc05ff17e30a58e0c42c65d1e98d3c5a9bcbe0e8ae"} build_url:https://queue.taskcluster.net/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011182 build_url: 'https://queue.taskcluster.net/v1/task/PFkRtY74QaCv8vwtlU479g/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/386dce9b7dfc66ec80611ab297749d5d7e86f24267f9e7d2ed8c651250771968bcfa4033f56ea161ac46932ff84c8ae2ca666e1b0487b39bdb30c0e06116a2d5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f46f46da2716eeb45b121e9d2bb4f70e8cabedb93467238c22f853db29d55dc60433f512e9a02724452d12cc05ff17e30a58e0c42c65d1e98d3c5a9bcbe0e8ae"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-30 14:59:48.387916) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 14:59:48.388270) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a12cd81e0ef515edd9e0d800000001bb-1464644336.425281-1609355336 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004510 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 14:59:48.472696) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-30 14:59:48.473090) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-30 14:59:48.473460) ========= ========= Total master_lag: 0.15 =========