builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-020 starttime: 1465221639.75 results: success (0) buildid: 20160606010529 builduid: 78750d9664274d05bee96204469a3a74 revision: d8adb38dd576398dacbfb96d2c247f8e0158bdf1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-06 07:00:39.753023) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-06 07:00:39.753644) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-06 07:00:39.753988) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-06 07:00:39.771766) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 07:00:39.772071) ========= 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=af724c981e2a0f424dbabf99000001e7-1465221639.512401-1901585856 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-06 07:00:40-- 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% 95.8M=0s 2016-06-06 07:00:40 (95.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.117045 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 07:00:39.901532) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 07:00:39.901931) ========= 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=af724c981e2a0f424dbabf99000001e7-1465221639.512401-1901585856 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017759 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 07:00:39.957972) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 07:00:39.958372) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev d8adb38dd576398dacbfb96d2c247f8e0158bdf1 --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 d8adb38dd576398dacbfb96d2c247f8e0158bdf1 --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=af724c981e2a0f424dbabf99000001e7-1465221639.512401-1901585856 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-06 07:00:40,922 truncating revision to first 12 chars 2016-06-06 07:00:40,923 Setting DEBUG logging. 2016-06-06 07:00:40,923 attempt 1/10 2016-06-06 07:00:40,923 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/d8adb38dd576?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-06 07:00:41,423 unpacking tar archive at: mozilla-aurora-d8adb38dd576/testing/mozharness/ program finished with exit code 0 elapsedTime=0.832283 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 07:00:40.807609) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-06 07:00:40.808054) ========= script_repo_revision: d8adb38dd576398dacbfb96d2c247f8e0158bdf1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-06 07:00:40.808537) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-06 07:00:40.808863) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-06 07:00:40.820528) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 25 secs) (at 2016-06-06 07:00:40.820981) ========= /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=af724c981e2a0f424dbabf99000001e7-1465221639.512401-1901585856 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:00:41 INFO - MultiFileLogger online at 20160606 07:00:41 in /builds/slave/test 07:00:41 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 07:00:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:00:41 INFO - {'append_to_log': False, 07:00:41 INFO - 'base_work_dir': '/builds/slave/test', 07:00:41 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 07:00:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:00:41 INFO - 'branch': 'Mozilla-Aurora', 07:00:41 INFO - 'buildbot_json_path': 'buildprops.json', 07:00:41 INFO - 'config_files': ('talos/linux_config.py',), 07:00:41 INFO - 'default_actions': ('clobber', 07:00:41 INFO - 'read-buildbot-config', 07:00:41 INFO - 'download-and-extract', 07:00:41 INFO - 'populate-webroot', 07:00:41 INFO - 'create-virtualenv', 07:00:41 INFO - 'install', 07:00:41 INFO - 'run-tests'), 07:00:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:00:41 INFO - 'download_minidump_stackwalk': True, 07:00:41 INFO - 'download_symbols': 'ondemand', 07:00:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:00:41 INFO - 'tooltool.py': '/tools/tooltool.py', 07:00:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:00:41 INFO - '/tools/misc-python/virtualenv.py')}, 07:00:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:00:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:00:41 INFO - 'installer_path': 'installer.exe', 07:00:41 INFO - 'log_level': 'info', 07:00:41 INFO - 'log_name': 'talos', 07:00:41 INFO - 'log_to_console': True, 07:00:41 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:00:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:00:41 INFO - 'opt_config_files': (), 07:00:41 INFO - 'pip_index': False, 07:00:41 INFO - 'sps_profile': False, 07:00:41 INFO - 'sps_profile_interval': 0, 07:00:41 INFO - 'suite': 'dromaeojs-e10s', 07:00:41 INFO - 'system_bits': '32', 07:00:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:00:41 INFO - 'title': 'talos-linux64-ix-020', 07:00:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:00:41 INFO - 'use_talos_json': True, 07:00:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:00:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:00:41 INFO - 'work_dir': 'build'} 07:00:41 INFO - ##### 07:00:41 INFO - ##### Running clobber step. 07:00:41 INFO - ##### 07:00:41 INFO - Running pre-action listener: _resource_record_pre_action 07:00:41 INFO - Running main action method: clobber 07:00:41 INFO - rmtree: /builds/slave/test/build 07:00:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:00:42 INFO - Running post-action listener: _resource_record_post_action 07:00:42 INFO - ##### 07:00:42 INFO - ##### Running read-buildbot-config step. 07:00:42 INFO - ##### 07:00:42 INFO - Running pre-action listener: _resource_record_pre_action 07:00:42 INFO - Running main action method: read_buildbot_config 07:00:42 INFO - Using buildbot properties: 07:00:42 INFO - { 07:00:42 INFO - "project": "", 07:00:42 INFO - "product": "firefox", 07:00:42 INFO - "script_repo_revision": "production", 07:00:42 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 07:00:42 INFO - "repository": "", 07:00:42 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 07:00:42 INFO - "buildid": "20160606010529", 07:00:42 INFO - "pgo_build": "True", 07:00:42 INFO - "basedir": "/builds/slave/test", 07:00:42 INFO - "buildnumber": 389, 07:00:42 INFO - "slavename": "talos-linux64-ix-020", 07:00:42 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 07:00:42 INFO - "platform": "ubuntu64_hw", 07:00:42 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 07:00:42 INFO - "branch": "mozilla-aurora", 07:00:42 INFO - "repo_path": "releases/mozilla-aurora", 07:00:42 INFO - "revision": "d8adb38dd576398dacbfb96d2c247f8e0158bdf1", 07:00:42 INFO - "stage_platform": "linux64-pgo", 07:00:42 INFO - "builduid": "78750d9664274d05bee96204469a3a74", 07:00:42 INFO - "slavebuilddir": "test" 07:00:42 INFO - } 07:00:42 INFO - Found installer url https://queue.taskcluster.net/v1/task/TPuJqxlBRzGNOtqJN1sFbw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 07:00:42 INFO - Running post-action listener: _resource_record_post_action 07:00:42 INFO - ##### 07:00:42 INFO - ##### Running download-and-extract step. 07:00:42 INFO - ##### 07:00:42 INFO - Running pre-action listener: _resource_record_pre_action 07:00:42 INFO - Running main action method: download_and_extract 07:00:42 INFO - mkdir: /builds/slave/test/build/tests 07:00:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:00:42 INFO - https://queue.taskcluster.net/v1/task/TPuJqxlBRzGNOtqJN1sFbw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:00:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TPuJqxlBRzGNOtqJN1sFbw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 07:00:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TPuJqxlBRzGNOtqJN1sFbw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 07:00:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TPuJqxlBRzGNOtqJN1sFbw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 07:00:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TPuJqxlBRzGNOtqJN1sFbw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 07:00:43 INFO - Downloaded 1361 bytes. 07:00:43 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 07:00:43 INFO - Using the following test package requirements: 07:00:43 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 07:00:43 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 07:00:43 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 07:00:43 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 07:00:43 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 07:00:43 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 07:00:43 INFO - u'jsshell-linux-x86_64.zip'], 07:00:43 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 07:00:43 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 07:00:43 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 07:00:43 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 07:00:43 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 07:00:43 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 07:00:43 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 07:00:43 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 07:00:43 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 07:00:43 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 07:00:43 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 07:00:43 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:00:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:00:43 INFO - https://queue.taskcluster.net/v1/task/TPuJqxlBRzGNOtqJN1sFbw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:00:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TPuJqxlBRzGNOtqJN1sFbw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 07:00:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TPuJqxlBRzGNOtqJN1sFbw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 07:00:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TPuJqxlBRzGNOtqJN1sFbw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 07:00:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TPuJqxlBRzGNOtqJN1sFbw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:00:44 INFO - Downloaded 24177411 bytes. 07:00:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:00:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:00:45 INFO - Return code: 0 07:00:45 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 07:00:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:00:45 INFO - https://queue.taskcluster.net/v1/task/TPuJqxlBRzGNOtqJN1sFbw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:00:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TPuJqxlBRzGNOtqJN1sFbw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 07:00:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TPuJqxlBRzGNOtqJN1sFbw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 07:00:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TPuJqxlBRzGNOtqJN1sFbw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 07:00:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TPuJqxlBRzGNOtqJN1sFbw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:00:46 INFO - Downloaded 24177411 bytes. 07:00:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:00:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:00:48 INFO - Return code: 0 07:00: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')]} 07:00:48 INFO - https://queue.taskcluster.net/v1/task/TPuJqxlBRzGNOtqJN1sFbw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:00:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TPuJqxlBRzGNOtqJN1sFbw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 07:00:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TPuJqxlBRzGNOtqJN1sFbw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 07:00:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TPuJqxlBRzGNOtqJN1sFbw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 07:00:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TPuJqxlBRzGNOtqJN1sFbw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:00:49 INFO - Downloaded 10840145 bytes. 07:00:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:00:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 07:00:49 INFO - Return code: 0 07:00:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:00:49 INFO - https://queue.taskcluster.net/v1/task/TPuJqxlBRzGNOtqJN1sFbw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:00:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TPuJqxlBRzGNOtqJN1sFbw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 07:00:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TPuJqxlBRzGNOtqJN1sFbw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 07:00:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TPuJqxlBRzGNOtqJN1sFbw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 07:00:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TPuJqxlBRzGNOtqJN1sFbw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 07:00:50 INFO - Downloaded 62805945 bytes. 07:00:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TPuJqxlBRzGNOtqJN1sFbw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 07:00:50 INFO - mkdir: /builds/slave/test/properties 07:00:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:00:50 INFO - Writing to file /builds/slave/test/properties/build_url 07:00:50 INFO - Contents: 07:00:50 INFO - build_url:https://queue.taskcluster.net/v1/task/TPuJqxlBRzGNOtqJN1sFbw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 07:00:51 INFO - Running post-action listener: _resource_record_post_action 07:00:51 INFO - Running post-action listener: set_extra_try_arguments 07:00:51 INFO - ##### 07:00:51 INFO - ##### Running populate-webroot step. 07:00:51 INFO - ##### 07:00:51 INFO - Running pre-action listener: _resource_record_pre_action 07:00:51 INFO - Running main action method: populate_webroot 07:00:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:00:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:00:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:00:51 INFO - '--tppagecycles', 07:00:51 INFO - '7'], 07:00:51 INFO - 'tests': ['tsvgm']}}, 07:00:51 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:00:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:00:51 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:00:51 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:00:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:00:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:00:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:00:51 INFO - 'talos_options': ['--disable-e10s'], 07:00:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:00:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:00:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:00:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:00:51 INFO - 'talos_options': ['--disable-e10s'], 07:00:51 INFO - 'tests': ['damp', 'tps']}, 07:00:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:00:51 INFO - 'tests': ['damp', 'tps']}, 07:00:51 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:00:51 INFO - 'tests': ['dromaeo_dom']}, 07:00:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:00:51 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:00:51 INFO - 'tests': ['a11yr', 07:00:51 INFO - 'ts_paint', 07:00:51 INFO - 'tpaint', 07:00:51 INFO - 'sessionrestore', 07:00:51 INFO - 'sessionrestore_no_auto_restore', 07:00:51 INFO - 'tabpaint']}, 07:00:51 INFO - 'other-e10s': {'tests': ['a11yr', 07:00:51 INFO - 'ts_paint', 07:00:51 INFO - 'tpaint', 07:00:51 INFO - 'sessionrestore', 07:00:51 INFO - 'sessionrestore_no_auto_restore', 07:00:51 INFO - 'tabpaint']}, 07:00:51 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:00:51 INFO - 'ts_paint', 07:00:51 INFO - 'tpaint', 07:00:51 INFO - 'sessionrestore', 07:00:51 INFO - 'sessionrestore_no_auto_restore', 07:00:51 INFO - 'tabpaint']}, 07:00:51 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:00:51 INFO - 'ts_paint', 07:00:51 INFO - 'tpaint', 07:00:51 INFO - 'sessionrestore', 07:00:51 INFO - 'sessionrestore_no_auto_restore', 07:00:51 INFO - 'tabpaint']}, 07:00:51 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:00:51 INFO - 'tests': ['a11yr', 07:00:51 INFO - 'ts_paint', 07:00:51 INFO - 'tpaint', 07:00:51 INFO - 'sessionrestore', 07:00:51 INFO - 'sessionrestore_no_auto_restore', 07:00:51 INFO - 'tabpaint']}, 07:00:51 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:00:51 INFO - 'tests': ['a11yr', 07:00:51 INFO - 'ts_paint', 07:00:51 INFO - 'tpaint', 07:00:51 INFO - 'sessionrestore', 07:00:51 INFO - 'sessionrestore_no_auto_restore', 07:00:51 INFO - 'tabpaint']}, 07:00:51 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:00:51 INFO - 'tests': ['tsvgx', 07:00:51 INFO - 'tsvgr_opacity', 07:00:51 INFO - 'tart', 07:00:51 INFO - 'tscrollx', 07:00:51 INFO - 'cart']}, 07:00:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:00:51 INFO - 'tsvgr_opacity', 07:00:51 INFO - 'tart', 07:00:51 INFO - 'tscrollx', 07:00:51 INFO - 'cart']}, 07:00:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:00:51 INFO - 'talos_options': ['--disable-e10s'], 07:00:51 INFO - 'tests': ['tp5o']}, 07:00:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:00:51 INFO - 'tests': ['tp5o']}, 07:00:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:00:51 INFO - 'talos_options': ['--disable-e10s', 07:00:51 INFO - '--xperf_path', 07:00:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:00:51 INFO - 'tests': ['tp5n']}, 07:00:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:00:51 INFO - 'talos_options': ['--xperf_path', 07:00:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:00:51 INFO - 'tests': ['tp5n']}}, 07:00:51 INFO - 'talos.zip': {'path': '', 07:00:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:00:51 INFO - Running post-action listener: _resource_record_post_action 07:00:51 INFO - ##### 07:00:51 INFO - ##### Running create-virtualenv step. 07:00:51 INFO - ##### 07:00:51 INFO - Running pre-action listener: _resource_record_pre_action 07:00:51 INFO - Running main action method: create_virtualenv 07:00:51 INFO - Creating virtualenv /builds/slave/test/build/venv 07:00:51 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 07:00:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:00:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:00:51 INFO - Using real prefix '/usr' 07:00:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:00:52 INFO - Installing distribute.............................................................................................................................................................................................done. 07:00:54 INFO - Installing pip.................done. 07:00:54 INFO - Return code: 0 07:00:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:00: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')]} 07:00:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:00:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00: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')]} 07:00:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:00:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f18bc93af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f0d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fd85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2067410>, '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 0x2068310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20687a0>, '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': 'af724c981e2a0f424dbabf99000001e7-1465221639.512401-1901585856', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:00: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', 'pip>=1.5'] in /builds/slave/test/build 07:00: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 pip>=1.5 07:00:54 INFO - Using env: {'DISPLAY': ':0', 07:00:54 INFO - 'HOME': '/home/cltbld', 07:00:54 INFO - 'LANG': 'en_US.UTF-8', 07:00:54 INFO - 'LANGUAGE': 'en_US:en', 07:00:54 INFO - 'LOGNAME': 'cltbld', 07:00:54 INFO - 'MAIL': '/var/mail/cltbld', 07:00:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:54 INFO - 'MOZ_NO_REMOTE': '1', 07:00:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:00:54 INFO - 'NO_EM_RESTART': '1', 07:00:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:00:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:00:54 INFO - 'PWD': '/builds/slave/test', 07:00:54 INFO - 'SHELL': '/bin/bash', 07:00:54 INFO - 'SHLVL': '1', 07:00:54 INFO - 'TERM': 'linux', 07:00:54 INFO - 'TMOUT': '86400', 07:00:54 INFO - 'USER': 'cltbld', 07:00:54 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1465221639.512401-1901585856', 07:00:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:54 INFO - '_': '/tools/buildbot/bin/python'} 07:00:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:00:54 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 07:00:54 INFO - Cleaning up... 07:00:54 INFO - Return code: 0 07:00:54 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 07:00: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')]} 07:00:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:00:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00: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')]} 07:00:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:00:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00: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', '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 0x7f18bc93af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f0d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fd85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2067410>, '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 0x2068310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20687a0>, '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': 'af724c981e2a0f424dbabf99000001e7-1465221639.512401-1901585856', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:00: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', 'psutil>=0.7.1'] in /builds/slave/test/build 07:00: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 psutil>=0.7.1 07:00:54 INFO - Using env: {'DISPLAY': ':0', 07:00:54 INFO - 'HOME': '/home/cltbld', 07:00:54 INFO - 'LANG': 'en_US.UTF-8', 07:00:54 INFO - 'LANGUAGE': 'en_US:en', 07:00:54 INFO - 'LOGNAME': 'cltbld', 07:00:54 INFO - 'MAIL': '/var/mail/cltbld', 07:00:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:54 INFO - 'MOZ_NO_REMOTE': '1', 07:00:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:00:54 INFO - 'NO_EM_RESTART': '1', 07:00:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:00:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:00:54 INFO - 'PWD': '/builds/slave/test', 07:00:54 INFO - 'SHELL': '/bin/bash', 07:00:54 INFO - 'SHLVL': '1', 07:00:54 INFO - 'TERM': 'linux', 07:00:54 INFO - 'TMOUT': '86400', 07:00:54 INFO - 'USER': 'cltbld', 07:00:54 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1465221639.512401-1901585856', 07:00:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:54 INFO - '_': '/tools/buildbot/bin/python'} 07:00:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:00:54 INFO - Downloading/unpacking psutil>=0.7.1 07:00: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 07:00: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 07:00: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 07:00: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 07:00: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 07:00: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 07:00:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:00:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:00:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:00:56 INFO - Installing collected packages: psutil 07:00:56 INFO - Running setup.py install for psutil 07:00:56 INFO - building 'psutil._psutil_linux' extension 07:00:56 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 07:00:56 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 07:00:56 INFO - building 'psutil._psutil_posix' extension 07:00:56 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 07:00:57 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 07:00:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:00:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:00:57 INFO - Successfully installed psutil 07:00:57 INFO - Cleaning up... 07:00:57 INFO - Return code: 0 07:00:57 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 07:00:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:00:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:00:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:00:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:00:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f18bc93af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f0d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fd85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2067410>, '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 0x2068310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20687a0>, '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': 'af724c981e2a0f424dbabf99000001e7-1465221639.512401-1901585856', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:00:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 07:00:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 07:00:57 INFO - Using env: {'DISPLAY': ':0', 07:00:57 INFO - 'HOME': '/home/cltbld', 07:00:57 INFO - 'LANG': 'en_US.UTF-8', 07:00:57 INFO - 'LANGUAGE': 'en_US:en', 07:00:57 INFO - 'LOGNAME': 'cltbld', 07:00:57 INFO - 'MAIL': '/var/mail/cltbld', 07:00:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:57 INFO - 'MOZ_NO_REMOTE': '1', 07:00:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:00:57 INFO - 'NO_EM_RESTART': '1', 07:00:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:00:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:00:57 INFO - 'PWD': '/builds/slave/test', 07:00:57 INFO - 'SHELL': '/bin/bash', 07:00:57 INFO - 'SHLVL': '1', 07:00:57 INFO - 'TERM': 'linux', 07:00:57 INFO - 'TMOUT': '86400', 07:00:57 INFO - 'USER': 'cltbld', 07:00:57 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1465221639.512401-1901585856', 07:00:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:57 INFO - '_': '/tools/buildbot/bin/python'} 07:00:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:00:57 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:00: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 07:00: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 07:00: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 07:00: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 07:00: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 07:00: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 07:00:59 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:00:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:00:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:00:59 INFO - Installing collected packages: mozsystemmonitor 07:00:59 INFO - Running setup.py install for mozsystemmonitor 07:00:59 INFO - Successfully installed mozsystemmonitor 07:00:59 INFO - Cleaning up... 07:00:59 INFO - Return code: 0 07:00:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:00:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:00:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:00:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:00:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:00:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:59 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 0x7f18bc93af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f0d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fd85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2067410>, '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 0x2068310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20687a0>, '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': 'af724c981e2a0f424dbabf99000001e7-1465221639.512401-1901585856', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:00:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:00:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:00:59 INFO - Using env: {'DISPLAY': ':0', 07:00:59 INFO - 'HOME': '/home/cltbld', 07:00:59 INFO - 'LANG': 'en_US.UTF-8', 07:00:59 INFO - 'LANGUAGE': 'en_US:en', 07:00:59 INFO - 'LOGNAME': 'cltbld', 07:00:59 INFO - 'MAIL': '/var/mail/cltbld', 07:00:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:59 INFO - 'MOZ_NO_REMOTE': '1', 07:00:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:00:59 INFO - 'NO_EM_RESTART': '1', 07:00:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:00:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:00:59 INFO - 'PWD': '/builds/slave/test', 07:00:59 INFO - 'SHELL': '/bin/bash', 07:00:59 INFO - 'SHLVL': '1', 07:00:59 INFO - 'TERM': 'linux', 07:00:59 INFO - 'TMOUT': '86400', 07:00:59 INFO - 'USER': 'cltbld', 07:00:59 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1465221639.512401-1901585856', 07:00:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:59 INFO - '_': '/tools/buildbot/bin/python'} 07:00:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:00:59 INFO - Downloading/unpacking blobuploader==1.2.4 07:00:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:00:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:00:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:00:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:00:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:00:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:01:01 INFO - Downloading blobuploader-1.2.4.tar.gz 07:01:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:01:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:01:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:01:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:01:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:01:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:01:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:01:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:01:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:01:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:01:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:01:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:01:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:01:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:01:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:01:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:01:02 INFO - Downloading docopt-0.6.1.tar.gz 07:01:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:01:02 INFO - Installing collected packages: blobuploader, requests, docopt 07:01:02 INFO - Running setup.py install for blobuploader 07:01:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:01:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:01:02 INFO - Running setup.py install for requests 07:01:02 INFO - Running setup.py install for docopt 07:01:02 INFO - Successfully installed blobuploader requests docopt 07:01:02 INFO - Cleaning up... 07:01:02 INFO - Return code: 0 07:01:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:01:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:01:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:01:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:01:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:01:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:01:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:01:02 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 0x7f18bc93af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f0d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fd85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2067410>, '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 0x2068310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20687a0>, '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': 'af724c981e2a0f424dbabf99000001e7-1465221639.512401-1901585856', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:01:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:01:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:01:02 INFO - Using env: {'DISPLAY': ':0', 07:01:02 INFO - 'HOME': '/home/cltbld', 07:01:02 INFO - 'LANG': 'en_US.UTF-8', 07:01:02 INFO - 'LANGUAGE': 'en_US:en', 07:01:02 INFO - 'LOGNAME': 'cltbld', 07:01:02 INFO - 'MAIL': '/var/mail/cltbld', 07:01:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:01:02 INFO - 'MOZ_NO_REMOTE': '1', 07:01:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:01:02 INFO - 'NO_EM_RESTART': '1', 07:01:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:01:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:01:02 INFO - 'PWD': '/builds/slave/test', 07:01:02 INFO - 'SHELL': '/bin/bash', 07:01:02 INFO - 'SHLVL': '1', 07:01:02 INFO - 'TERM': 'linux', 07:01:02 INFO - 'TMOUT': '86400', 07:01:02 INFO - 'USER': 'cltbld', 07:01:02 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1465221639.512401-1901585856', 07:01:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:01:02 INFO - '_': '/tools/buildbot/bin/python'} 07:01:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:01:03 INFO - Running setup.py (path:/tmp/pip-Z4BVFU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:01:03 INFO - Running setup.py (path:/tmp/pip-oR8lr9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:01:03 INFO - Running setup.py (path:/tmp/pip-iMwvSF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:01:03 INFO - Running setup.py (path:/tmp/pip-cv6g7_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:01:03 INFO - Running setup.py (path:/tmp/pip-NkJ8Ag-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:01:03 INFO - Running setup.py (path:/tmp/pip-qQUaCm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:01:03 INFO - Running setup.py (path:/tmp/pip-ImYMnv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:01:03 INFO - Running setup.py (path:/tmp/pip-HaauAP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:01:03 INFO - Running setup.py (path:/tmp/pip-ZzxFMR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:01:03 INFO - Running setup.py (path:/tmp/pip-B2aHhO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:01:03 INFO - Running setup.py (path:/tmp/pip-OV1AO6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:01:03 INFO - Running setup.py (path:/tmp/pip-snsncV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:01:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:01:04 INFO - Running setup.py (path:/tmp/pip-sC1mAs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:01:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:01:04 INFO - Running setup.py (path:/tmp/pip-fL0nnV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:01:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:01:04 INFO - Running setup.py (path:/tmp/pip-wMhmeG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:01:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:01:04 INFO - Running setup.py (path:/tmp/pip-NixiQF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:01:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:01:04 INFO - Running setup.py (path:/tmp/pip-ky_7Oe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:01:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:01:04 INFO - Running setup.py install for manifestparser 07:01:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:01:04 INFO - Running setup.py install for mozcrash 07:01:04 INFO - Running setup.py install for mozdebug 07:01:04 INFO - Running setup.py install for mozdevice 07:01:04 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:01:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:01:04 INFO - Running setup.py install for mozfile 07:01:04 INFO - Running setup.py install for mozhttpd 07:01:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:01:05 INFO - Running setup.py install for mozinfo 07:01:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:01:05 INFO - Running setup.py install for mozInstall 07:01:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:01:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:01:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:01:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:01:05 INFO - Running setup.py install for mozleak 07:01:05 INFO - Running setup.py install for mozlog 07:01:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:01:05 INFO - Running setup.py install for moznetwork 07:01:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:01:05 INFO - Running setup.py install for mozprocess 07:01:05 INFO - Running setup.py install for mozprofile 07:01:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:01:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:01:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:01:05 INFO - Running setup.py install for mozrunner 07:01:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:01:05 INFO - Running setup.py install for mozscreenshot 07:01:05 INFO - Running setup.py install for moztest 07:01:06 INFO - Running setup.py install for mozversion 07:01:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:01:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:01:06 INFO - Cleaning up... 07:01:06 INFO - Return code: 0 07:01:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:01:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:01:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:01:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:01:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:01:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:01:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:01:06 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 0x7f18bc93af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f0d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fd85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2067410>, '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 0x2068310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20687a0>, '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': 'af724c981e2a0f424dbabf99000001e7-1465221639.512401-1901585856', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:01:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:01:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:01:06 INFO - Using env: {'DISPLAY': ':0', 07:01:06 INFO - 'HOME': '/home/cltbld', 07:01:06 INFO - 'LANG': 'en_US.UTF-8', 07:01:06 INFO - 'LANGUAGE': 'en_US:en', 07:01:06 INFO - 'LOGNAME': 'cltbld', 07:01:06 INFO - 'MAIL': '/var/mail/cltbld', 07:01:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:01:06 INFO - 'MOZ_NO_REMOTE': '1', 07:01:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:01:06 INFO - 'NO_EM_RESTART': '1', 07:01:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:01:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:01:06 INFO - 'PWD': '/builds/slave/test', 07:01:06 INFO - 'SHELL': '/bin/bash', 07:01:06 INFO - 'SHLVL': '1', 07:01:06 INFO - 'TERM': 'linux', 07:01:06 INFO - 'TMOUT': '86400', 07:01:06 INFO - 'USER': 'cltbld', 07:01:06 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1465221639.512401-1901585856', 07:01:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:01:06 INFO - '_': '/tools/buildbot/bin/python'} 07:01:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:01:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:01:06 INFO - Running setup.py (path:/tmp/pip-AN4YRo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:01:06 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 07:01:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:01:06 INFO - Running setup.py (path:/tmp/pip-BODWsV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:01:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:01:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:01:06 INFO - Running setup.py (path:/tmp/pip-YMiu2D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:01:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:01:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:01:06 INFO - Running setup.py (path:/tmp/pip-9mp6_x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:01:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:01:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:01:06 INFO - Running setup.py (path:/tmp/pip-PlnLjp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:01:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 07:01:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:01:06 INFO - Running setup.py (path:/tmp/pip-rrbNa2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:01:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 07:01:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:01:06 INFO - Running setup.py (path:/tmp/pip-83Ml9m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:01:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 07:01:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:01:06 INFO - Running setup.py (path:/tmp/pip-7YInmX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:01:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 07:01:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:01:07 INFO - Running setup.py (path:/tmp/pip-Mq7bMz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:01:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 07:01:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:01:07 INFO - Running setup.py (path:/tmp/pip-hRz1wx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:01:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:01:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:01:07 INFO - Running setup.py (path:/tmp/pip-3Uj0iQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:01:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 07:01:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:01:07 INFO - Running setup.py (path:/tmp/pip-bo7w6A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:01:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:01:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:01:07 INFO - Running setup.py (path:/tmp/pip-34DfMp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:01:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 07:01:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:01:07 INFO - Running setup.py (path:/tmp/pip-FMqzdW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:01:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:01:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:01:07 INFO - Running setup.py (path:/tmp/pip-IGfsnk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:01:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 07:01:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:01:07 INFO - Running setup.py (path:/tmp/pip-i3_iuN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:01:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 07:01:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:01:07 INFO - Running setup.py (path:/tmp/pip-IwEsov-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:01:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 07:01:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:01:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:01:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:01:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:01:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:01:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:01:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:01:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:01:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:01:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:01:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:01:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:01:09 INFO - Downloading blessings-1.6.tar.gz 07:01:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:01:09 INFO - Installing collected packages: blessings 07:01:09 INFO - Running setup.py install for blessings 07:01:09 INFO - Successfully installed blessings 07:01:09 INFO - Cleaning up... 07:01:09 INFO - Return code: 0 07:01:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:01:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:01:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:01:09 INFO - Reading from file tmpfile_stdout 07:01:09 INFO - Current package versions: 07:01:09 INFO - argparse == 1.2.1 07:01:09 INFO - blessings == 1.6 07:01:09 INFO - blobuploader == 1.2.4 07:01:09 INFO - docopt == 0.6.1 07:01:09 INFO - manifestparser == 1.1 07:01:09 INFO - mozInstall == 1.12 07:01:09 INFO - mozcrash == 0.17 07:01:09 INFO - mozdebug == 0.1 07:01:09 INFO - mozdevice == 0.48 07:01:09 INFO - mozfile == 1.2 07:01:09 INFO - mozhttpd == 0.7 07:01:09 INFO - mozinfo == 0.9 07:01:09 INFO - mozleak == 0.1 07:01:09 INFO - mozlog == 3.1 07:01:09 INFO - moznetwork == 0.27 07:01:09 INFO - mozprocess == 0.22 07:01:09 INFO - mozprofile == 0.28 07:01:09 INFO - mozrunner == 6.11 07:01:09 INFO - mozscreenshot == 0.1 07:01:09 INFO - mozsystemmonitor == 0.0 07:01:09 INFO - moztest == 0.7 07:01:09 INFO - mozversion == 1.4 07:01:09 INFO - psutil == 3.1.1 07:01:09 INFO - requests == 1.2.3 07:01:09 INFO - wsgiref == 0.1.2 07:01:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:01:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:01:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:01:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:01:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:01:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:01:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:01:10 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 0x7f18bc93af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f0d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fd85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2067410>, '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 0x2068310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20687a0>, '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': 'af724c981e2a0f424dbabf99000001e7-1465221639.512401-1901585856', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:01:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 07:01:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:01:10 INFO - Using env: {'DISPLAY': ':0', 07:01:10 INFO - 'HOME': '/home/cltbld', 07:01:10 INFO - 'LANG': 'en_US.UTF-8', 07:01:10 INFO - 'LANGUAGE': 'en_US:en', 07:01:10 INFO - 'LOGNAME': 'cltbld', 07:01:10 INFO - 'MAIL': '/var/mail/cltbld', 07:01:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:01:10 INFO - 'MOZ_NO_REMOTE': '1', 07:01:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:01:10 INFO - 'NO_EM_RESTART': '1', 07:01:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:01:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:01:10 INFO - 'PWD': '/builds/slave/test', 07:01:10 INFO - 'SHELL': '/bin/bash', 07:01:10 INFO - 'SHLVL': '1', 07:01:10 INFO - 'TERM': 'linux', 07:01:10 INFO - 'TMOUT': '86400', 07:01:10 INFO - 'USER': 'cltbld', 07:01:10 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1465221639.512401-1901585856', 07:01:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:01:10 INFO - '_': '/tools/buildbot/bin/python'} 07:01:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:01:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:01:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 07:01:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 07:01:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:01:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 07:01:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 07:01:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 07:01:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 07:01:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 07:01:10 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:01:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:01:10 INFO - Cleaning up... 07:01:10 INFO - Return code: 0 07:01:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:01:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:01:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:01:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:01:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:01:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:01:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:01:10 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 0x7f18bc93af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f0d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fd85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2067410>, '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 0x2068310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20687a0>, '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': 'af724c981e2a0f424dbabf99000001e7-1465221639.512401-1901585856', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:01:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:01:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:01:10 INFO - Using env: {'DISPLAY': ':0', 07:01:10 INFO - 'HOME': '/home/cltbld', 07:01:10 INFO - 'LANG': 'en_US.UTF-8', 07:01:10 INFO - 'LANGUAGE': 'en_US:en', 07:01:10 INFO - 'LOGNAME': 'cltbld', 07:01:10 INFO - 'MAIL': '/var/mail/cltbld', 07:01:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:01:10 INFO - 'MOZ_NO_REMOTE': '1', 07:01:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:01:10 INFO - 'NO_EM_RESTART': '1', 07:01:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:01:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:01:10 INFO - 'PWD': '/builds/slave/test', 07:01:10 INFO - 'SHELL': '/bin/bash', 07:01:10 INFO - 'SHLVL': '1', 07:01:10 INFO - 'TERM': 'linux', 07:01:10 INFO - 'TMOUT': '86400', 07:01:10 INFO - 'USER': 'cltbld', 07:01:10 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1465221639.512401-1901585856', 07:01:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:01:10 INFO - '_': '/tools/buildbot/bin/python'} 07:01:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:01:10 INFO - Downloading/unpacking jsonschema 07:01:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:01:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:01:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:01:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:01:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:01:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:01:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:01:12 INFO - Downloading/unpacking functools32 (from jsonschema) 07:01:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:01:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:01:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:01:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:01:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:01:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:01:12 INFO - Downloading functools32-3.2.3-2.tar.gz 07:01:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:01:12 INFO - warning: no files found matching '*.txt' 07:01:12 INFO - no previously-included directories found matching 'build' 07:01:12 INFO - no previously-included directories found matching 'dist' 07:01:12 INFO - no previously-included directories found matching '.git*' 07:01:12 INFO - Installing collected packages: jsonschema, functools32 07:01:12 INFO - Running setup.py install for functools32 07:01:12 INFO - warning: no files found matching '*.txt' 07:01:12 INFO - no previously-included directories found matching 'build' 07:01:12 INFO - no previously-included directories found matching 'dist' 07:01:12 INFO - no previously-included directories found matching '.git*' 07:01:12 INFO - Successfully installed jsonschema functools32 07:01:12 INFO - Cleaning up... 07:01:12 INFO - Return code: 0 07:01:12 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:01:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:01:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:01:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:01:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:01:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:01:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:01:12 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 0x7f18bc93af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f0d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fd85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2067410>, '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 0x2068310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20687a0>, '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': 'af724c981e2a0f424dbabf99000001e7-1465221639.512401-1901585856', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:01:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 07:01:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 07:01:12 INFO - Using env: {'DISPLAY': ':0', 07:01:12 INFO - 'HOME': '/home/cltbld', 07:01:12 INFO - 'LANG': 'en_US.UTF-8', 07:01:12 INFO - 'LANGUAGE': 'en_US:en', 07:01:12 INFO - 'LOGNAME': 'cltbld', 07:01:12 INFO - 'MAIL': '/var/mail/cltbld', 07:01:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:01:12 INFO - 'MOZ_NO_REMOTE': '1', 07:01:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:01:12 INFO - 'NO_EM_RESTART': '1', 07:01:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:01:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:01:12 INFO - 'PWD': '/builds/slave/test', 07:01:12 INFO - 'SHELL': '/bin/bash', 07:01:12 INFO - 'SHLVL': '1', 07:01:12 INFO - 'TERM': 'linux', 07:01:12 INFO - 'TMOUT': '86400', 07:01:12 INFO - 'USER': 'cltbld', 07:01:12 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1465221639.512401-1901585856', 07:01:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:01:12 INFO - '_': '/tools/buildbot/bin/python'} 07:01:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:01:13 INFO - Downloading/unpacking flake8 07:01:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:01:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:01:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:01:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:01:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:01:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:01:14 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:01:14 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:01:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:01:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:01:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:01:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:01:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:01:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:01:15 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:01:15 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:01:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:01:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:01:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:01:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:01:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:01:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:01:15 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:01:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:01:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:01:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:01:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:01:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:01:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:01:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:01:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:01:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:01:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:01:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:01:15 INFO - no previously-included directories found matching 'docs/_build' 07:01:15 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:01:15 INFO - Running setup.py install for pep8 07:01:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:01:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:01:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:01:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:01:15 INFO - no previously-included directories found matching 'docs/_build' 07:01:15 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:01:15 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:01:15 INFO - Cleaning up... 07:01:15 INFO - Return code: 0 07:01:15 INFO - Running post-action listener: _resource_record_post_action 07:01:15 INFO - Running post-action listener: _start_resource_monitoring 07:01:15 INFO - Starting resource monitoring. 07:01:15 INFO - ##### 07:01:15 INFO - ##### Running install step. 07:01:15 INFO - ##### 07:01:15 INFO - Running pre-action listener: _resource_record_pre_action 07:01:15 INFO - Running main action method: install 07:01:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:01:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:01:16 INFO - Reading from file tmpfile_stdout 07:01:16 INFO - Detecting whether we're running mozinstall >=1.0... 07:01:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:01:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:01:16 INFO - Reading from file tmpfile_stdout 07:01:16 INFO - Output received: 07:01:16 INFO - Usage: mozinstall [options] installer 07:01:16 INFO - Options: 07:01:16 INFO - -h, --help show this help message and exit 07:01:16 INFO - -d DEST, --destination=DEST 07:01:16 INFO - Directory to install application into. [default: 07:01:16 INFO - "/builds/slave/test"] 07:01:16 INFO - --app=APP Application being installed. [default: firefox] 07:01:16 INFO - mkdir: /builds/slave/test/build/application 07:01:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 07:01:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 07:01:31 INFO - Reading from file tmpfile_stdout 07:01:31 INFO - Output received: 07:01:31 INFO - /builds/slave/test/build/application/firefox/firefox 07:01:31 INFO - Running post-action listener: _resource_record_post_action 07:01:31 INFO - ##### 07:01:31 INFO - ##### Running run-tests step. 07:01:31 INFO - ##### 07:01:31 INFO - Running pre-action listener: _resource_record_pre_action 07:01:31 INFO - Running main action method: run_tests 07:01:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:01:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:01:31 INFO - Python 2.7.3 07:01:31 INFO - Return code: 0 07:01:31 INFO - grabbing minidump binary from tooltool 07:01: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')]} 07:01:31 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 0x2067410>, '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 0x2068310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20687a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:01:31 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 07:01:31 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 07:01:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:01:31 INFO - Return code: 0 07:01:31 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:01:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:01:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:01:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:01:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:01:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:01:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:01:32 INFO - Return code: 0 07:01:32 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/TPuJqxlBRzGNOtqJN1sFbw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--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 07:01:32 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/TPuJqxlBRzGNOtqJN1sFbw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-020 --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 07:01:32 INFO - Using env: {'DISPLAY': ':0', 07:01:32 INFO - 'HOME': '/home/cltbld', 07:01:32 INFO - 'LANG': 'en_US.UTF-8', 07:01:32 INFO - 'LANGUAGE': 'en_US:en', 07:01:32 INFO - 'LOGNAME': 'cltbld', 07:01:32 INFO - 'MAIL': '/var/mail/cltbld', 07:01:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:01:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:01:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:01:32 INFO - 'MOZ_NO_REMOTE': '1', 07:01:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:01:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:01:32 INFO - 'NO_EM_RESTART': '1', 07:01:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:01:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:01:32 INFO - 'PWD': '/builds/slave/test', 07:01:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:01:32 INFO - 'SHELL': '/bin/bash', 07:01:32 INFO - 'SHLVL': '1', 07:01:32 INFO - 'TERM': 'linux', 07:01:32 INFO - 'TMOUT': '86400', 07:01:32 INFO - 'USER': 'cltbld', 07:01:32 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1465221639.512401-1901585856', 07:01:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:01:32 INFO - '_': '/tools/buildbot/bin/python'} 07:01:32 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/TPuJqxlBRzGNOtqJN1sFbw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--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 07:01:33 INFO - mozversion application_buildid: 20160606010529 07:01:33 INFO - mozversion application_changeset: d8adb38dd576398dacbfb96d2c247f8e0158bdf1 07:01:33 INFO - mozversion application_display_name: FirefoxDeveloperEdition 07:01:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:01:33 INFO - mozversion application_name: Firefox 07:01:33 INFO - mozversion application_remotingname: firefox-dev 07:01:33 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:01:33 INFO - mozversion application_vendor: Mozilla 07:01:33 INFO - mozversion application_version: 48.0a2 07:01:33 INFO - mozversion platform_buildid: 20160606010529 07:01:33 INFO - mozversion platform_changeset: d8adb38dd576398dacbfb96d2c247f8e0158bdf1 07:01:33 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:01:33 INFO - mozversion platform_version: 48.0a2 07:01:33 INFO - using testdate: 1465221693 07:01:33 INFO - actual date: 1465221693 07:01:33 INFO - starting webserver on 'localhost:45646' 07:01:33 INFO - SUITE-START | Running 2 tests 07:01:33 INFO - TEST-START | dromaeo_css 07:01:33 INFO - operating with platform_type : linux_ 07:01:33 INFO - Initialising browser for dromaeo_css test... 07:01:33 INFO - TEST-INFO | started process 5781 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpksOtmZ/profile http://localhost:45646/getInfo.html) 07:01:36 INFO - PROCESS | 5781 | 07:01:36 INFO - PROCESS | 5781 | (process:5849): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:01:37 INFO - PROCESS | 5781 | __metrics Screen width/height:1600/1200 07:01:37 INFO - PROCESS | 5781 | colorDepth:24 07:01:37 INFO - PROCESS | 5781 | Browser inner width/height: 1024/697 07:01:37 INFO - PROCESS | 5781 | __metrics 07:01:38 ERROR - PROCESS | 5781 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2940: TypeError: this.tabs is undefined 07:01:38 INFO - TEST-INFO | 5781: exit 0 07:01:38 INFO - Browser initialized. 07:01:38 INFO - Running cycle 1/1 for dromaeo_css test... 07:01:39 INFO - TEST-INFO | started process 5906 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpksOtmZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:01:40 INFO - PROCESS | 5906 | 07:01:40 INFO - PROCESS | 5906 | (process:5975): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:01:50 INFO - PROCESS | 5906 | RSS: Main: 151986176 07:01:50 INFO - PROCESS | 5906 | 07:02:40 INFO - PROCESS | 5906 | 1465221760320 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 07:04:48 INFO - PROCESS | 5906 | Cycle 1(1): loaded http://localhost:45646/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45646/tests/dromaeo/cssquery-ext.html) 07:04:49 INFO - PROCESS | 5906 | RSS: Main: 154640384 07:04:49 INFO - PROCESS | 5906 | 07:07:51 INFO - PROCESS | 5906 | Cycle 1(1): loaded http://localhost:45646/tests/dromaeo/cssquery-ext.html (next: http://localhost:45646/tests/dromaeo/cssquery-jquery.html) 07:07:51 INFO - PROCESS | 5906 | RSS: Main: 153350144 07:07:51 INFO - PROCESS | 5906 | 07:10:53 INFO - PROCESS | 5906 | Cycle 1(1): loaded http://localhost:45646/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45646/tests/dromaeo/cssquery-mootools.html) 07:10:53 INFO - PROCESS | 5906 | RSS: Main: 153313280 07:10:53 INFO - PROCESS | 5906 | 07:13:55 INFO - PROCESS | 5906 | Cycle 1(1): loaded http://localhost:45646/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45646/tests/dromaeo/cssquery-prototype.html) 07:13:56 INFO - PROCESS | 5906 | RSS: Main: 152899584 07:13:56 INFO - PROCESS | 5906 | 07:16:58 INFO - PROCESS | 5906 | Cycle 1(1): loaded http://localhost:45646/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45646/tests/dromaeo/cssquery-yui.html) 07:16:59 INFO - PROCESS | 5906 | RSS: Main: 154279936 07:16:59 INFO - PROCESS | 5906 | 07:20:01 INFO - PROCESS | 5906 | Cycle 1(1): loaded http://localhost:45646/tests/dromaeo/cssquery-yui.html (next: http://localhost:45646/tests/dromaeo/cssquery-dojo.html) 07:20:01 INFO - PROCESS | 5906 | RSS: Main: 156016640 07:20:01 INFO - PROCESS | 5906 | 07:20:01 INFO - PROCESS | 5906 | __start_tp_report 07:20:01 INFO - PROCESS | 5906 | _x_x_mozilla_page_load 07:20:01 INFO - PROCESS | 5906 | _x_x_mozilla_page_load_details 07:20:01 INFO - PROCESS | 5906 | |i|pagename|runs| 07:20:01 INFO - PROCESS | 5906 | |0;dojo.html;3405.6424075472073;3443.4490481522944;3446.86212551498;3465.3589086019074;3465.5494785677856;5746.683932383718;5758.1362795580635;5778.6243894146855;5787.508061814746;5789.942100578993;5721.885562288751;5737.25415695959;5738.8278351649415;5744.138379243115;5781.62419442736;5202.583793296527;5239.240310155025;5244.659097158673;5279.366476022883;5280.287161233242;5202.973985130069;5271.341082364705;5345.679259244458;5369.865753356158;5404.972975135119;5288.6562373445795;5302.496262855023;5306.699858534665;5309.787608495655;5324.1215199492035;5233.398159211663;5281.996420680078;5282.260483532289;5306.177542480883;5336.9733151334385;5088.872778180538;5111.488851114896;5160.974195129038;5202.531772140488;5222.791088356461;5615.438456154393;5673.319201695823;5681.062624666925;5686.857828554278;5697.088465845445;6176.382361763833;6178.474829639486;6179.783707570258;6179.907301390483;6193.87612247757;6071.514278857725;6141.578063794106;6163.137160797492;6203.2556093269095;6231.189945307081;5767.048437007888;5866.677332746697;5871.588988770788;5872;5873.500752436048;6246.250449946036;6376.808695739135;6391.456726178327;6392.776252831129;6397.648129352837;6041.818745437644;6086.087086936995;6103.115048317969;6136.601120927215;6142.078688196717;6189.35011823761;6213.347598502182;6221.129041934133;6229.688515574203;6234.657093859791;6049;6141.823559979257;6179.0422484514975;6185.752569897244;6235.220597425322;6179.69101544921;6196.752129914753;6202.379762023762;6211.472024877846;6212.223472065992;4689.015306785614;4696.272077827942;4700.952990470051;4707.270373092176;4748.857534273978;4101.302778527657;4184.267753143188;4190.224808410454;4229.111886503807;4252.766097864585;5942.61373010753;5944.554158438048;5950.375210602911;5979.073243647154;6017.939820601738;6203.627782333075;6218.471429928416;6227.19046523949;6237.438630523275;6243.8126856194385;5947.464728174485;5971.19388882504;5984.521238300926;6006.069059295816;6038.245219347582;5284.154535274338;5308.389535203424;5319.760610772524;5330;5335.946640533545;6404.423601875854;6460.224773027267;6466.741330346827;6471;6472.288048314682;6099.542534309856;6141.547378150805;6311.936880631319;6346.809595712136;6355.110284560073;6409.935900640934;6425.06836508713;6451.0645956337;6454.1609590752905;6486.05952136947;5883.882322353444;6128.66292353907;6134.325224225242;6134.846628834315;6148.047052706837;6198.969005154945;6265.279492858197;6288.968555157195;6294.5593808434805;6307.558470907176;6049.758009679564;6060.545459090497;6070.423309785563;6076.878462430638;6097.024476083982;5861.208736820645;6064.120702498201;6077.787277445268;6092.208012958287;6123.479504242189;5968.791092311748;6012.549058820693;6023.066424704178;6034.155218269533;6037.78867739627;6096.055111457731;6137.478314343331;6141.907871382022;6144.109104179958;6169.938300616936;5861.7655293787775;5990.520758339409;6007.399260074132;6031.819045428644;6086.60437071589 07:20:01 INFO - PROCESS | 5906 | |1;ext.html;649.2274193709485;669.1034014420677;675.0178490296619;679.3546131175382;693.9687714052867;40390.192196156095;41374.37938430926;41427.58572414275;41477.377839332396;41574.58425415745;41504.792476037655;42361;42391.15217695644;42480.3627945581;42507.57492425075;8717.651293948235;8789.208971192591;8845.513496757676;8853.070427605106;8882.378233523656;8678.435901666404;8931.73204803857;8974.461532308082;8982.505962172077;8991;9031.277497800193;9034.728958131234;9041.95479022604;9045.909540904606;9046.954765226164;8901.06538813425;8948.8657670135;8958.238549723248;8961.103889610988;8999.595018224163;8868.778280542974;8950.910490895138;8957.238634715992;8977.955110224473;9021.413608115452;35694;42040.78979605113;42560.148797024194;42700.359494607605;42745.786271068755;3713.275911197318;3805.9238815223816;3911.471951286568;3957.2679054374744;4146.067134894654;29639.259018524495;29776.553351699742;30237.244068898235;30319.848400758077;30433;4633.397658304432;4665.440147182326;4682.4381074271305;4730.929036064462;4825.589824864891;288988;292291.53854230803;292551;293427;293456;63934.36065639377;65328.346716533175;65363;65402;65446.672766635864;70867.64566177239;71258;71702.64148679223;71777;72085.6395718018;19211.903940480486;19307.51731206703;19396.515087122934;19416.611667766847;19423.223071077282;14868.182249976355;14879.404823806926;14900.552983410515;14910.70178596422;14949.402023918921;20380.184792608427;20756.377308680763;20768.273110441063;20769.480762981046;21657.45856353572;7823.569703666353;7824.843503129906;7979.281864632211;8060.717874874468;8126.349892008625;1042.4943902207424;1089.6894385100209;1110.4614262082882;1186.1400484648561;1210.7033776724759;33890.830545847115;34248.14379640479;34322.65677343245;34637.82681086579;34802;1158.3455347728507;1164.2839653612966;1201.2312120243053;1224.1492162946668;1254.3978890132787;16078.115703636413;16136.273867675984;16394.344226231056;16952.57618559546;16982.40561580339;496798;552923;554060;566307;566822;58696.706516467995;59404;59659.105113423335;59710.40289597048;59885.70057149686;1501.3319073012406;1551.83705710901;1558.5791836204162;1558.6804705035668;1560.7346751052348;34992.82503587466;35208;35501.11247218737;35871.64128358683;35936.28127437384;57089.42910570841;57169.428305716414;57853.13220301615;58004.4199557999;58111.4188858106;437972;441674;442152;443075;444029;31205.843970780003;31225.063248102593;31668.208294792814;32252.19369515781;32346.191345216557;52887;53016.2047569279;53688.73155634197;53974.19038714344;54308.45691543192;43440;44656.77671611621;44940;45139.322910155715;45996.310055349866;43526.782366087966;43622;44059.55940440555;44134.11731765411;45650.315245270685;44181;45221.77389113033;45924.770376147906;46281.53718462772;46571.06857862892;33071.66928330782;33703.66296337005;33935.660643394236;35880.3654611246;36839.81580092083;28921.132366029055;29181;29399;29712.257193570334;29780.851095744383 07:20:01 INFO - PROCESS | 5906 | |2;jquery.html;433.84381622615865;436.2866712924368;442.30999640560725;442.3519543868234;454.9181147393468;18625.441236762887;18814.90592547037;19100.80899191008;19249.518762030937;19469.805301946977;18306.267749290048;18513.35203267886;20352.491187720316;20480.28319008835;20503.384898453034;5783.566232532567;5823.5341172706085;5931.199288096095;5969.940300596982;5994.920914235436;5681.062624666925;5877.67672777997;5923.28920529537;5958.851028724273;5968.612040217394;5886.234789477362;5923.614965027259;5944.048952167654;5965.433283838029;5996.190514280582;5895.35151133375;5906.911396329058;6581.111549940744;6605.108310378109;6621.702023408958;5899.233099697055;5941.613795103304;5949.405059494059;5976.73104710289;5983.042713165873;15011.099334039993;15140.167290799001;15145.469908553257;15159.62100947474;17237;2533.1007492340136;2629.7764690001372;2839.843808590527;3024.894128705507;3156.2898347871774;10965.287256328313;11516.654500364919;12518.436670349856;14739.336729847182;15179.62050948724;2017.7175195472646;2076.356329537848;2093.9476513087143;2112.968305475419;2167.1548096242477;81781.18218817795;82448.17551824465;85085.57457212674;85172.57413712892;85827.14172858317;11600.30398176112;11775.116866235066;11891.702707432383;12015.399230038463;12534.498620055096;16961.15194240283;17027.65944681124;17065.06142162168;17065.720070994725;17066.31734730597;8851.247643950337;9051.868516435445;9094.909050909539;9115.954420227856;9227.907720922705;8727.738167854974;8779.912200878038;8839.248663863515;9003.099690031075;9036.051214622501;5080.237964305384;5169.560587350042;5171.77724338187;5194.4026436959475;5198.766055527511;2049.231538173185;2058.5059585699323;2100.1494394770143;2102.253699936531;2177.5862586108587;1058.2169194795795;1089.7576762490767;1120.4173829608558;1132.7847708935276;1135.3131355529786;18913.7162942556;19043.42869713911;19208.13563389651;19423;19612.411627651192;1099.4228030284164;1144.9370284634258;1145.7422080032093;1173.4074292482412;1210.9697257568632;10584.735381615521;11026.283291586022;11061;11160.441977901073;11160.720981975515;488669;488932;489129;492440;497971;60804;65210;90911;103262;106942.46528767307;1113.6325012745774;1150.7295785490403;1156.7744289863565;1168.707823044239;1174.5243176513354;17909.28362865523;18027.09864506743;18175.18211680504;18304.908475457538;18405.631887362444;40876.38685419781;40988.59011409848;42342.78828605837;42893.57106428896;43038;56420.717896411894;62150.68924655348;62729;62965;63113.684431579386;9178.265738741018;9216.815663686823;9326.766830829283;9505.619775208914;9528.428294302365;7839.412044096602;10942.835857461985;12805.359732013176;13607.931960340135;13782.241976691379;12042.759144816879;12213.816792748294;12222.083343749433;12279.631611051684;12445.62663120108;11743.41282935867;12150.02799775998;12252.448639811051;12254.4485498151;12274.202176858476;6911.896321555281;11233.606823761129;11940.52237910474;12109.515619375126;12396.504139834306;9129.497877616795;9151.450912945245;9217.459928973749;9400.905990940004;9597.28020398459;11685.649430517098;11776.941115294369;11810.232334898204;11966.880331196577;12055 07:20:01 INFO - PROCESS | 5906 | |3;mootools.html;1542.992285038575;1576.0464918724176;1741.7213245880653;1817.4365946556568;1895.9052047397627;7919.643616037278;8516;8641.222289993899;8939.150780675833;8947.284217262619;8541.316694664427;8606.827863442728;8739.082396348387;8747.12528747125;8759.43063700859;2429.040528991043;2454.9754502454925;2463.0394146282874;2475.5296493666237;2488.079410618074;2431.294924471901;2527.0397249045427;2527.494501099778;2528.4058246312193;2529.064246228889;2463.6550882876413;2475.306914064065;2508.5233805576972;2511.5855883779154;2526.8357556758842;2466.334089795754;2486.6643003194517;2491.8006559475198;2497.4880149569294;2502.3493891588228;2447.730749617541;2456.078970386105;2465.60550311951;2491;2535.3027917322884;9027.864582031274;9063.093690630883;9063.68277110298;9071.501067441288;9088.318376121817;5498.835034948958;5598.664080155204;5607.52336051432;5620.5503559715125;5622.550195984311;3503.3343664703625;3532.116970757311;3555.4311310190506;3575.4458059000895;3581.7850928944085;1162.6744511536783;1193.7672153929987;1204.1931905623253;1214.4474264209764;1220.4324988880126;12688.555900543437;12770.169938953939;12820.230786152768;12830.486780528767;12851.614451566375;4737.45519265282;4765.9761701191965;4777.044591081728;4823.469418363977;4984.725840078758;10848.294860834021;10900.454977251105;10911.399873007062;10912;10950.34297942126;5536.75084621193;5576.302962129734;5592.832215033555;5593.468620481048;5602.523785478198;4558.5897269245925;4997.525235102659;5049.166887463601;5079.619028572798;5109.182530795129;4401.273789824707;4454.420925279693;4558.8632341029825;4570.040291538748;4575.3365761965;1378.8690074442911;1439.6400899775056;1449.3188201545256;1456.1263242054895;1456.4975083596141;1092.8415379770047;1099.7008973080758;1100.9028594686129;1109.9559384127958;1141.1270378160714;6417.422431981144;6455.322191169954;6466.515011374072;6534.901976470357;6581.243157037002;490.8453837041321;499.86753510319795;499.97250151241303;505.3884799392776;508.6134537751262;4488;4566.086782643484;4584.7936842842155;4592.448906131285;4610.815567377267;10638.627648032281;11008.669739907815;11029.83455248172;11046.116310695124;11110.166737494721;10129.189664826796;10827.566897324177;10860;10935.945320273348;10947.069499092508;8399.958000210083;8427.536485493234;8460.661573537112;8497.36269779769;8578.227959483676;5970.791022314372;6111.602745821508;6145.784897528565;6192.876142477216;6249.281332646804;9695.757606059622;9899.901000990187;9999.800004000024;10023.398596084258;10036.247281453774;9884.209263258777;9999.150072243941;10409.739756506147;10460.110890574386;10567.735806604896;7711.344535714527;8063.637136328996;8081.111077781322;8084.9595752023215;8096.190380962093;8626.223639872442;8644.308455323684;8646.265067469336;8655.134486551295;8661.307095432225;7679.846403072019;7746.070471543226;7977.242161994601;8147.348212142896;8163.591820409075;7753.457257992112;7834.608269586612;7841.921580784119;7847.411444141598;8004.039515258206;7010.474214433836;7037.1555413350725;7076.540024898365;7125.786226413215;7131.179914309921;5423.078076727044;5432.5110740032005;5446.945530544803;5462.726863656721;5510.421405752499;5520.199571062093;5564.582656300713;5620.971895140498;5701.914471282851;5744.310682718101 07:20:01 INFO - PROCESS | 5906 | |4;prototype.html;370.6460330384483;372.42460398684045;372.5436340482908;376.41091691502794;376.8907016965082;6425.196850393695;6444.677766111699;6533.281339052706;6537.869242615151;6640.103586015886;6618.907880199761;6674.899876501844;6676.0319753635695;6679.899801502969;6680.997850322442;5047.015831912779;5075.111855425304;5088.92366614501;5090.287359769635;5091.592672586185;5068.594512438996;5084.694918304914;5091.6690415123085;5101.285819985186;5101.872453188663;5039.596832253411;5045.571126454256;5047.369078865142;5048.141815891289;5055.721935293557;4944.554990050912;4957.429895562021;4992.425871024842;5031.496850314976;5040.798368065273;4301.741895486281;4324.740515569045;4326.870193894189;4355.760433176174;4372.956270437287;6343.714532846033;6348.365163483615;6349.714262858182;6363.522735794788;6396.392342727433;5549.056660367747;5683.261176047129;5713.628614140068;5718.48533631971;5832.6500409975115;6886.724531018754;6907.240203577602;6932.341427564374;6935.098437203132;6938.965305173442;4776.47458779534;4777.641676874214;4779.091972525209;4780.665353425262;4789.592884604813;7213.350798428167;7265.89101163483;7272.763630182882;7275.672594733197;7283.308085731847;4794.513700752777;4799.136155491975;4803.927941080887;4807.158747219222;4826.855194344105;4772.0694464579765;4879.219324907997;4899.608031357483;4944.505549445027;4953.331300274489;5715.114157305624;5716.028275193227;5730;5731.168980497804;5756.136579513107;6946.687399067054;6953.687084081127;6992.335728105923;7003.439724822104;7012.807822670158;1719;1739.7129473636708;1741.477556732975;1743.2678275124479;1744.7557341972133;1080.4543705428866;1109.073923274059;1130.22014809781;1146.4611632532697;1156.7397335599424;6775.898361524581;6930.168379794457;6930.168379794457;6969.303069693092;6989.231184569693;7310.268973102648;7311.926880731231;7334.119905611361;7338.77983660491;7339.155997060299;6851.520393572502;6871.828204294832;6910.827229319207;6915.930840691629;6921.342472465108;3823.9808800956375;3902.746321489094;3948.4274780156716;3950.486436763202;3955.0903292242947;7630.96184519085;7638.961805190938;7648.1204661463535;7650.770476885702;7658.693652253959;7308.6345682715655;7331.963340183265;7342.118945726547;7371.520851144658;7407.8148046299275;7570.356519695777;7596.468247222641;7628.199039100926;7638;7646.273604007611;7152.85694286101;7223.097112860893;7260.673269702982;7292.744753933587;7320.194778574459;7112.537685050455;7140.964295178491;7141.82145446368;7160.391366733886;7184.640767961477;7586.279303466162;7612.7716168515035;7615.048118985127;7618.085829700472;7625.084989801259;4895.094407534618;4899.681520701143;4906.803727850846;4907.950920490749;4911;7125.251848555827;7233.348998590152;7250.854982900418;7259.818504537428;7269.491135620668;7015.508914375945;7039.260877607778;7044.295570442915;7050.682719277543;7052.259512751088;6985.091938048021;7017.403520700594;7033.156021277479;7033.261507541839;7045.647717613996;6853.760118395832;6880.449564034965;6884.345987131214;6893;6897.137857767779;6896.793096207121;7020.227774944854;7056.364927156581;7083.327083927019;7087.433005359662;6697.899531507129;6842.965785171242;6925;6925.099737034153;6955.547889387173 07:20:01 INFO - PROCESS | 5906 | |5;yui.html;768.7770546541503;778.4434129597337;822.0217940650629;904.1365495951366;906.891173059233;13469.461221551139;13526.864731352684;13580.049396542247;13719.794203086962;14109;13370.264635445046;13371.064025518193;13437.798433023512;13455;13461.057725959163;750.9812254693621;857.8241460500583;864.494270851551;885.3581153663607;887.3211992825494;895.6014573514789;897.3001059173855;903.3902116071625;904.4121321141245;906.4289497616526;928.633189889993;933;936.199549385276;940.7977284883749;941.2140862379887;926.3237836379413;927.7912469694264;930.7068273493861;931.5481991234246;932.0446542294135;683.6957553888521;686.2279935073043;686.7767975408012;687.9484038697068;690.6270613868555;14329;14421;14422.206778627171;14429.422823087063;14439.783403248959;14598.197099159543;14634.121952682766;14786.112833229932;14797.852021479755;14825.851741482555;11481.88518114825;11598;11768.764624707543;11836.881631183664;11927.403629818475;4000.979995100006;4028.5971402859773;4066.6340029397497;4072.2669919414493;4076.9388459173138;55331.72334138344;55357.446425536036;55912;55960.72019639876;55977;11642.6507204784;11774.705632359259;11816.46825892837;12071.939640301742;12109.333986630643;21605.351839444527;21669.458263543536;21698.240561580267;21722.34832955014;21736.673949890763;8564.443311184754;8609.268212202032;8724.91275087241;8745.56272186401;8880.73357799267;4870.732109733999;4952.603791696655;4969.525554714599;5024.598032157419;5038.2190760432195;3347.447671134284;3394.304167645627;3395.4567269236804;3396.388650043016;3403.829808509565;600.2766666167258;601.8044135655929;606.4117805728437;607.7720854679495;608.656109298245;671.5467059734659;740.2005833699592;756.8486302739474;771.3327971304781;847.1147650705028;9787.853182202272;10074.345167564084;10157.542910569042;10311.381317120997;10325.432101234353;768.2970082374565;783.3654739660893;792.4967645545005;794.6503538443067;803.7146812881343;4736.100140973204;4837.250226214942;4855.247436647325;4896.853094407174;4901.191303434894;68247.3175268241;68552;68819.31180688129;69220.65389673019;69475;60358.39641603528;60449.39550604438;60674.69662651658;60755;60972.39027609756;53948.46051539513;54198.729006355505;55074.44925550773;56005.7199714007;56251.437485625436;9538.23694104484;9573.473458959825;9685.70942871715;9695.757606059906;9759.56081976327;41397.37903931383;41469.37795933003;42537.36193957031;42698.78650606727;42975.57024429841;53759.73120134374;53814.73092634668;54312.45687543074;54755.17867232074;55140.44859551514;11977.940110299392;12156.878431215575;12912.16070955385;13057.608271751862;13215.405306761026;13163.276019818619;13793.862061379257;14254.073485223427;14358.425662973365;14918.254087295809;13076.934615326862;13154;13274.643693675842;13837.792433113713;14025.789613155606;13537.526186583422;13800.240986745825;14043;14312.499062532761;14553.417863285349;12768.808467873176;13371.06402551812;13467.663308417368;13768.449262029808;13911.930440347733;10591.205659575717;10614.1508679307;10674.199435042248;10791;10800.837987430352;10764.192685548773;10945.507452164513;11089.168312376765;11358.375289359165;11408.144389170679 07:20:01 INFO - PROCESS | 5906 | __end_tp_report 07:20:01 INFO - PROCESS | 5906 | __start_cc_report 07:20:01 INFO - PROCESS | 5906 | _x_x_mozilla_cycle_collect,335 07:20:01 INFO - PROCESS | 5906 | __end_cc_report 07:20:01 INFO - PROCESS | 5906 | __startTimestamp1465222801486__endTimestamp 07:20:01 INFO - PROCESS | 5906 | 07:20:01 INFO - PROCESS | 5906 | ------- Summary: start ------- 07:20:01 INFO - PROCESS | 5906 | Number of tests: 6 07:20:01 INFO - PROCESS | 5906 | 07:20:01 INFO - PROCESS | 5906 | [#0] dojo.html Cycles:165 Average:5768.37 Median:6031.82 stddev:656.76 (10.9%) stddev-sans-first:632.08 07:20:01 INFO - PROCESS | 5906 | Values: 3405.6 3443.4 3446.9 3465.4 3465.5 5746.7 5758.1 5778.6 5787.5 5789.9 5721.9 5737.3 5738.8 5744.1 5781.6 5202.6 5239.2 5244.7 5279.4 5280.3 5203.0 5271.3 5345.7 5369.9 5405.0 5288.7 5302.5 5306.7 5309.8 5324.1 5233.4 5282.0 5282.3 5306.2 5337.0 5088.9 5111.5 5161.0 5202.5 5222.8 5615.4 5673.3 5681.1 5686.9 5697.1 6176.4 6178.5 6179.8 6179.9 6193.9 6071.5 6141.6 6163.1 6203.3 6231.2 5767.0 5866.7 5871.6 5872.0 5873.5 6246.3 6376.8 6391.5 6392.8 6397.6 6041.8 6086.1 6103.1 6136.6 6142.1 6189.4 6213.3 6221.1 6229.7 6234.7 6049.0 6141.8 6179.0 6185.8 6235.2 6179.7 6196.8 6202.4 6211.5 6212.2 4689.0 4696.3 4701.0 4707.3 4748.9 4101.3 4184.3 4190.2 4229.1 4252.8 5942.6 5944.6 5950.4 5979.1 6017.9 6203.6 6218.5 6227.2 6237.4 6243.8 5947.5 5971.2 5984.5 6006.1 6038.2 5284.2 5308.4 5319.8 5330.0 5335.9 6404.4 6460.2 6466.7 6471.0 6472.3 6099.5 6141.5 6311.9 6346.8 6355.1 6409.9 6425.1 6451.1 6454.2 6486.1 5883.9 6128.7 6134.3 6134.8 6148.0 6199.0 6265.3 6289.0 6294.6 6307.6 6049.8 6060.5 6070.4 6076.9 6097.0 5861.2 6064.1 6077.8 6092.2 6123.5 5968.8 6012.5 6023.1 6034.2 6037.8 6096.1 6137.5 6141.9 6144.1 6169.9 5861.8 5990.5 6007.4 6031.8 6086.6 07:20:01 INFO - PROCESS | 5906 | 07:20:01 INFO - PROCESS | 5906 | [#1] ext.html Cycles:180 Average:60587.90 Median:43483.39 stddev:116661.01 (268.3%) stddev-sans-first:116901.48 07:20:01 INFO - PROCESS | 5906 | Values: 649.2 669.1 675.0 679.4 694.0 40390.2 41374.4 41427.6 41477.4 41574.6 41504.8 42361.0 42391.2 42480.4 42507.6 8717.7 8789.2 8845.5 8853.1 8882.4 8678.4 8931.7 8974.5 8982.5 8991.0 9031.3 9034.7 9042.0 9045.9 9047.0 8901.1 8948.9 8958.2 8961.1 8999.6 8868.8 8950.9 8957.2 8978.0 9021.4 35694.0 42040.8 42560.1 42700.4 42745.8 3713.3 3805.9 3911.5 3957.3 4146.1 29639.3 29776.6 30237.2 30319.8 30433.0 4633.4 4665.4 4682.4 4730.9 4825.6 288988.0 292291.5 292551.0 293427.0 293456.0 63934.4 65328.3 65363.0 65402.0 65446.7 70867.6 71258.0 71702.6 71777.0 72085.6 19211.9 19307.5 19396.5 19416.6 19423.2 14868.2 14879.4 14900.6 14910.7 14949.4 20380.2 20756.4 20768.3 20769.5 21657.5 7823.6 7824.8 7979.3 8060.7 8126.3 1042.5 1089.7 1110.5 1186.1 1210.7 33890.8 34248.1 34322.7 34637.8 34802.0 1158.3 1164.3 1201.2 1224.1 1254.4 16078.1 16136.3 16394.3 16952.6 16982.4 496798.0 552923.0 554060.0 566307.0 566822.0 58696.7 59404.0 59659.1 59710.4 59885.7 1501.3 1551.8 1558.6 1558.7 1560.7 34992.8 35208.0 35501.1 35871.6 35936.3 57089.4 57169.4 57853.1 58004.4 58111.4 437972.0 441674.0 442152.0 443075.0 444029.0 31205.8 31225.1 31668.2 32252.2 32346.2 52887.0 53016.2 53688.7 53974.2 54308.5 43440.0 44656.8 44940.0 45139.3 45996.3 43526.8 43622.0 44059.6 44134.1 45650.3 44181.0 45221.8 45924.8 46281.5 46571.1 33071.7 33703.7 33935.7 35880.4 36839.8 28921.1 29181.0 29399.0 29712.3 29780.9 07:20:01 INFO - PROCESS | 5906 | 07:20:01 INFO - PROCESS | 5906 | [#2] jquery.html Cycles:180 Average:29183.90 Median:2101.20 stddev:80989.69 (3854.4%) stddev-sans-first:81188.12 07:20:01 INFO - PROCESS | 5906 | Values: 433.8 436.3 442.3 442.4 454.9 18625.4 18814.9 19100.8 19249.5 19469.8 18306.3 18513.4 20352.5 20480.3 20503.4 5783.6 5823.5 5931.2 5969.9 5994.9 5681.1 5877.7 5923.3 5958.9 5968.6 5886.2 5923.6 5944.0 5965.4 5996.2 5895.4 5906.9 6581.1 6605.1 6621.7 5899.2 5941.6 5949.4 5976.7 5983.0 15011.1 15140.2 15145.5 15159.6 17237.0 2533.1 2629.8 2839.8 3024.9 3156.3 10965.3 11516.7 12518.4 14739.3 15179.6 2017.7 2076.4 2093.9 2113.0 2167.2 81781.2 82448.2 85085.6 85172.6 85827.1 11600.3 11775.1 11891.7 12015.4 12534.5 16961.2 17027.7 17065.1 17065.7 17066.3 8851.2 9051.9 9094.9 9116.0 9227.9 8727.7 8779.9 8839.2 9003.1 9036.1 5080.2 5169.6 5171.8 5194.4 5198.8 2049.2 2058.5 2100.1 2102.3 2177.6 1058.2 1089.8 1120.4 1132.8 1135.3 18913.7 19043.4 19208.1 19423.0 19612.4 1099.4 1144.9 1145.7 1173.4 1211.0 10584.7 11026.3 11061.0 11160.4 11160.7 488669.0 488932.0 489129.0 492440.0 497971.0 60804.0 65210.0 90911.0 103262.0 106942.5 1113.6 1150.7 1156.8 1168.7 1174.5 17909.3 18027.1 18175.2 18304.9 18405.6 40876.4 40988.6 42342.8 42893.6 43038.0 56420.7 62150.7 62729.0 62965.0 63113.7 9178.3 9216.8 9326.8 9505.6 9528.4 7839.4 10942.8 12805.4 13607.9 13782.2 12042.8 12213.8 12222.1 12279.6 12445.6 11743.4 12150.0 12252.4 12254.4 12274.2 6911.9 11233.6 11940.5 12109.5 12396.5 9129.5 9151.5 9217.5 9400.9 9597.3 11685.6 11776.9 11810.2 11966.9 12055.0 07:20:01 INFO - PROCESS | 5906 | 07:20:01 INFO - PROCESS | 5906 | [#3] mootools.html Cycles:180 Average:5989.39 Median:2737.79 stddev:3309.87 (120.9%) stddev-sans-first:3302.28 07:20:01 INFO - PROCESS | 5906 | Values: 1543.0 1576.0 1741.7 1817.4 1895.9 7919.6 8516.0 8641.2 8939.2 8947.3 8541.3 8606.8 8739.1 8747.1 8759.4 2429.0 2455.0 2463.0 2475.5 2488.1 2431.3 2527.0 2527.5 2528.4 2529.1 2463.7 2475.3 2508.5 2511.6 2526.8 2466.3 2486.7 2491.8 2497.5 2502.3 2447.7 2456.1 2465.6 2491.0 2535.3 9027.9 9063.1 9063.7 9071.5 9088.3 5498.8 5598.7 5607.5 5620.6 5622.6 3503.3 3532.1 3555.4 3575.4 3581.8 1162.7 1193.8 1204.2 1214.4 1220.4 12688.6 12770.2 12820.2 12830.5 12851.6 4737.5 4766.0 4777.0 4823.5 4984.7 10848.3 10900.5 10911.4 10912.0 10950.3 5536.8 5576.3 5592.8 5593.5 5602.5 4558.6 4997.5 5049.2 5079.6 5109.2 4401.3 4454.4 4558.9 4570.0 4575.3 1378.9 1439.6 1449.3 1456.1 1456.5 1092.8 1099.7 1100.9 1110.0 1141.1 6417.4 6455.3 6466.5 6534.9 6581.2 490.8 499.9 500.0 505.4 508.6 4488.0 4566.1 4584.8 4592.4 4610.8 10638.6 11008.7 11029.8 11046.1 11110.2 10129.2 10827.6 10860.0 10935.9 10947.1 8400.0 8427.5 8460.7 8497.4 8578.2 5970.8 6111.6 6145.8 6192.9 6249.3 9695.8 9899.9 9999.8 10023.4 10036.2 9884.2 9999.2 10409.7 10460.1 10567.7 7711.3 8063.6 8081.1 8085.0 8096.2 8626.2 8644.3 8646.3 8655.1 8661.3 7679.8 7746.1 7977.2 8147.3 8163.6 7753.5 7834.6 7841.9 7847.4 8004.0 7010.5 7037.2 7076.5 7125.8 7131.2 5423.1 5432.5 5446.9 5462.7 5510.4 5520.2 5564.6 5621.0 5701.9 5744.3 07:20:01 INFO - PROCESS | 5906 | 07:20:01 INFO - PROCESS | 5906 | [#4] prototype.html Cycles:180 Average:5862.46 Median:6736.90 stddev:1797.63 (26.7%) stddev-sans-first:1754.78 07:20:01 INFO - PROCESS | 5906 | Values: 370.6 372.4 372.5 376.4 376.9 6425.2 6444.7 6533.3 6537.9 6640.1 6618.9 6674.9 6676.0 6679.9 6681.0 5047.0 5075.1 5088.9 5090.3 5091.6 5068.6 5084.7 5091.7 5101.3 5101.9 5039.6 5045.6 5047.4 5048.1 5055.7 4944.6 4957.4 4992.4 5031.5 5040.8 4301.7 4324.7 4326.9 4355.8 4373.0 6343.7 6348.4 6349.7 6363.5 6396.4 5549.1 5683.3 5713.6 5718.5 5832.7 6886.7 6907.2 6932.3 6935.1 6939.0 4776.5 4777.6 4779.1 4780.7 4789.6 7213.4 7265.9 7272.8 7275.7 7283.3 4794.5 4799.1 4803.9 4807.2 4826.9 4772.1 4879.2 4899.6 4944.5 4953.3 5715.1 5716.0 5730.0 5731.2 5756.1 6946.7 6953.7 6992.3 7003.4 7012.8 1719.0 1739.7 1741.5 1743.3 1744.8 1080.5 1109.1 1130.2 1146.5 1156.7 6775.9 6930.2 6930.2 6969.3 6989.2 7310.3 7311.9 7334.1 7338.8 7339.2 6851.5 6871.8 6910.8 6915.9 6921.3 3824.0 3902.7 3948.4 3950.5 3955.1 7631.0 7639.0 7648.1 7650.8 7658.7 7308.6 7332.0 7342.1 7371.5 7407.8 7570.4 7596.5 7628.2 7638.0 7646.3 7152.9 7223.1 7260.7 7292.7 7320.2 7112.5 7141.0 7141.8 7160.4 7184.6 7586.3 7612.8 7615.0 7618.1 7625.1 4895.1 4899.7 4906.8 4908.0 4911.0 7125.3 7233.3 7250.9 7259.8 7269.5 7015.5 7039.3 7044.3 7050.7 7052.3 6985.1 7017.4 7033.2 7033.3 7045.6 6853.8 6880.4 6884.3 6893.0 6897.1 6896.8 7020.2 7056.4 7083.3 7087.4 6697.9 6843.0 6925.0 6925.1 6955.5 07:20:01 INFO - PROCESS | 5906 | 07:20:01 INFO - PROCESS | 5906 | [#5] yui.html Cycles:180 Average:16138.59 Median:4846.25 stddev:19036.44 (392.8%) stddev-sans-first:19054.85 07:20:01 INFO - PROCESS | 5906 | Values: 768.8 778.4 822.0 904.1 906.9 13469.5 13526.9 13580.0 13719.8 14109.0 13370.3 13371.1 13437.8 13455.0 13461.1 751.0 857.8 864.5 885.4 887.3 895.6 897.3 903.4 904.4 906.4 928.6 933.0 936.2 940.8 941.2 926.3 927.8 930.7 931.5 932.0 683.7 686.2 686.8 687.9 690.6 14329.0 14421.0 14422.2 14429.4 14439.8 14598.2 14634.1 14786.1 14797.9 14825.9 11481.9 11598.0 11768.8 11836.9 11927.4 4001.0 4028.6 4066.6 4072.3 4076.9 55331.7 55357.4 55912.0 55960.7 55977.0 11642.7 11774.7 11816.5 12071.9 12109.3 21605.4 21669.5 21698.2 21722.3 21736.7 8564.4 8609.3 8724.9 8745.6 8880.7 4870.7 4952.6 4969.5 5024.6 5038.2 3347.4 3394.3 3395.5 3396.4 3403.8 600.3 601.8 606.4 607.8 608.7 671.5 740.2 756.8 771.3 847.1 9787.9 10074.3 10157.5 10311.4 10325.4 768.3 783.4 792.5 794.7 803.7 4736.1 4837.3 4855.2 4896.9 4901.2 68247.3 68552.0 68819.3 69220.7 69475.0 60358.4 60449.4 60674.7 60755.0 60972.4 53948.5 54198.7 55074.4 56005.7 56251.4 9538.2 9573.5 9685.7 9695.8 9759.6 41397.4 41469.4 42537.4 42698.8 42975.6 53759.7 53814.7 54312.5 54755.2 55140.4 11977.9 12156.9 12912.2 13057.6 13215.4 13163.3 13793.9 14254.1 14358.4 14918.3 13076.9 13154.0 13274.6 13837.8 14025.8 13537.5 13800.2 14043.0 14312.5 14553.4 12768.8 13371.1 13467.7 13768.4 13911.9 10591.2 10614.2 10674.2 10791.0 10800.8 10764.2 10945.5 11089.2 11358.4 11408.1 07:20:01 INFO - PROCESS | 5906 | -------- Summary: end -------- 07:20:01 INFO - PROCESS | 5906 | 07:20:02 INFO - TEST-INFO | 5906: exit 0 07:20:02 INFO - TEST-OK | dromaeo_css | took 1109152ms 07:20:02 INFO - TEST-START | kraken 07:20:02 INFO - operating with platform_type : linux_ 07:20:02 INFO - Initialising browser for kraken test... 07:20:02 INFO - TEST-INFO | started process 6150 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppvmavl/profile http://localhost:45646/getInfo.html) 07:20:05 INFO - PROCESS | 6150 | 07:20:05 INFO - PROCESS | 6150 | (process:6230): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:20:06 INFO - PROCESS | 6150 | __metrics Screen width/height:1600/1200 07:20:06 INFO - PROCESS | 6150 | colorDepth:24 07:20:06 INFO - PROCESS | 6150 | Browser inner width/height: 1024/697 07:20:06 INFO - PROCESS | 6150 | __metrics 07:20:07 ERROR - PROCESS | 6150 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2940: TypeError: this.tabs is undefined 07:20:08 INFO - TEST-INFO | 6150: exit 0 07:20:08 INFO - Browser initialized. 07:20:08 INFO - Running cycle 1/1 for kraken test... 07:20:08 INFO - TEST-INFO | started process 6281 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppvmavl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:20:10 INFO - PROCESS | 6281 | 07:20:10 INFO - PROCESS | 6281 | (process:6353): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:20:20 INFO - PROCESS | 6281 | RSS: Main: 152567808 07:20:20 INFO - PROCESS | 6281 | 07:20:22 INFO - PROCESS | 6281 | Cycle 1(1): loaded http://localhost:45646/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45646/tests/kraken/driver.html?testName=audio-beat-detection) 07:20:23 INFO - PROCESS | 6281 | RSS: Main: 157294592 07:20:23 INFO - PROCESS | 6281 | 07:20:26 INFO - PROCESS | 6281 | Cycle 1(1): loaded http://localhost:45646/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45646/tests/kraken/driver.html?testName=audio-dft) 07:20:26 INFO - PROCESS | 6281 | RSS: Main: 157409280 07:20:26 INFO - PROCESS | 6281 | 07:20:29 INFO - PROCESS | 6281 | Cycle 1(1): loaded http://localhost:45646/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45646/tests/kraken/driver.html?testName=audio-fft) 07:20:30 INFO - PROCESS | 6281 | RSS: Main: 157593600 07:20:30 INFO - PROCESS | 6281 | 07:20:32 INFO - PROCESS | 6281 | Cycle 1(1): loaded http://localhost:45646/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45646/tests/kraken/driver.html?testName=audio-oscillator) 07:20:32 INFO - PROCESS | 6281 | RSS: Main: 157065216 07:20:32 INFO - PROCESS | 6281 | 07:20:35 INFO - PROCESS | 6281 | Cycle 1(1): loaded http://localhost:45646/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45646/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:20:35 INFO - PROCESS | 6281 | RSS: Main: 157097984 07:20:35 INFO - PROCESS | 6281 | 07:20:38 INFO - PROCESS | 6281 | Cycle 1(1): loaded http://localhost:45646/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45646/tests/kraken/driver.html?testName=imaging-darkroom) 07:20:39 INFO - PROCESS | 6281 | RSS: Main: 157802496 07:20:39 INFO - PROCESS | 6281 | 07:20:42 INFO - PROCESS | 6281 | Cycle 1(1): loaded http://localhost:45646/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45646/tests/kraken/driver.html?testName=imaging-desaturate) 07:20:43 INFO - PROCESS | 6281 | RSS: Main: 157921280 07:20:43 INFO - PROCESS | 6281 | 07:20:46 INFO - PROCESS | 6281 | Cycle 1(1): loaded http://localhost:45646/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45646/tests/kraken/driver.html?testName=json-parse-financial) 07:20:46 INFO - PROCESS | 6281 | RSS: Main: 157814784 07:20:46 INFO - PROCESS | 6281 | 07:20:48 INFO - PROCESS | 6281 | Cycle 1(1): loaded http://localhost:45646/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45646/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:20:48 INFO - PROCESS | 6281 | RSS: Main: 157274112 07:20:48 INFO - PROCESS | 6281 | 07:20:50 INFO - PROCESS | 6281 | Cycle 1(1): loaded http://localhost:45646/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45646/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:20:51 INFO - PROCESS | 6281 | RSS: Main: 157368320 07:20:51 INFO - PROCESS | 6281 | 07:20:53 INFO - PROCESS | 6281 | Cycle 1(1): loaded http://localhost:45646/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45646/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:20:53 INFO - PROCESS | 6281 | RSS: Main: 157638656 07:20:53 INFO - PROCESS | 6281 | 07:20:56 INFO - PROCESS | 6281 | Cycle 1(1): loaded http://localhost:45646/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45646/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:20:56 INFO - PROCESS | 6281 | RSS: Main: 158474240 07:20:56 INFO - PROCESS | 6281 | 07:20:59 INFO - PROCESS | 6281 | Cycle 1(1): loaded http://localhost:45646/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45646/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:21:00 INFO - PROCESS | 6281 | RSS: Main: 158552064 07:21:00 INFO - PROCESS | 6281 | 07:21:01 INFO - PROCESS | 6281 | Cycle 1(1): loaded http://localhost:45646/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45646/tests/kraken/driver.html?testName=ai-astar) 07:21:02 INFO - PROCESS | 6281 | RSS: Main: 159518720 07:21:02 INFO - PROCESS | 6281 | 07:21:02 INFO - PROCESS | 6281 | __start_tp_report 07:21:02 INFO - PROCESS | 6281 | _x_x_mozilla_page_load 07:21:02 INFO - PROCESS | 6281 | _x_x_mozilla_page_load_details 07:21:02 INFO - PROCESS | 6281 | |i|pagename|runs| 07:21:02 INFO - PROCESS | 6281 | |0;ai-astar;111;111;105;110;112;111;101;112;111;110 07:21:02 INFO - PROCESS | 6281 | |1;audio-beat-detection;156;127;158;182;129;154;148;129;188;128 07:21:02 INFO - PROCESS | 6281 | |2;audio-dft;163;162;163;165;162;173;164;165;164;164 07:21:02 INFO - PROCESS | 6281 | |3;audio-fft;73;77;77;187;75;74;76;77;176;74 07:21:02 INFO - PROCESS | 6281 | |4;audio-oscillator;92;93;161;92;92;93;139;91;93;149 07:21:02 INFO - PROCESS | 6281 | |5;imaging-gaussian-blur;117;118;118;117;117;117;118;119;118;118 07:21:02 INFO - PROCESS | 6281 | |6;imaging-darkroom;147;147;147;146;147;149;147;147;147;148 07:21:02 INFO - PROCESS | 6281 | |7;imaging-desaturate;95;96;96;95;95;95;96;96;95;95 07:21:02 INFO - PROCESS | 6281 | |8;json-parse-financial;56;59;58;56;58;61;58;74;55;54 07:21:02 INFO - PROCESS | 6281 | |9;json-stringify-tinderbox;57;59;58;58;60;59;58;58;58;58 07:21:02 INFO - PROCESS | 6281 | |10;stanford-crypto-aes;74;74;72;74;73;82;83;73;75;74 07:21:02 INFO - PROCESS | 6281 | |11;stanford-crypto-ccm;121;113;120;113;116;114;119;120;130;137 07:21:02 INFO - PROCESS | 6281 | |12;stanford-crypto-pbkdf2;161;162;164;166;161;156;157;161;161;162 07:21:02 INFO - PROCESS | 6281 | |13;stanford-crypto-sha256-iterative;69;69;71;68;69;68;66;66;66;67 07:21:02 INFO - PROCESS | 6281 | __end_tp_report 07:21:02 INFO - PROCESS | 6281 | __start_cc_report 07:21:02 INFO - PROCESS | 6281 | _x_x_mozilla_cycle_collect,847 07:21:02 INFO - PROCESS | 6281 | __end_cc_report 07:21:02 INFO - PROCESS | 6281 | __startTimestamp1465222862128__endTimestamp 07:21:02 INFO - PROCESS | 6281 | 07:21:02 INFO - PROCESS | 6281 | ------- Summary: start ------- 07:21:02 INFO - PROCESS | 6281 | Number of tests: 14 07:21:02 INFO - PROCESS | 6281 | 07:21:02 INFO - PROCESS | 6281 | [#0] ai-astar Cycles:10 Average:109.40 Median:111.00 stddev:3.57 (3.2%) stddev-sans-first:3.73 07:21:02 INFO - PROCESS | 6281 | Values: 111.0 111.0 105.0 110.0 112.0 111.0 101.0 112.0 111.0 110.0 07:21:02 INFO - PROCESS | 6281 | 07:21:02 INFO - PROCESS | 6281 | [#1] audio-beat-detection Cycles:10 Average:149.90 Median:155.00 stddev:22.32 (14.4%) stddev-sans-first:23.56 07:21:02 INFO - PROCESS | 6281 | Values: 156.0 127.0 158.0 182.0 129.0 154.0 148.0 129.0 188.0 128.0 07:21:02 INFO - PROCESS | 6281 | 07:21:02 INFO - PROCESS | 6281 | [#2] audio-dft Cycles:10 Average:164.50 Median:164.00 stddev:3.17 (1.9%) stddev-sans-first:3.32 07:21:02 INFO - PROCESS | 6281 | Values: 163.0 162.0 163.0 165.0 162.0 173.0 164.0 165.0 164.0 164.0 07:21:02 INFO - PROCESS | 6281 | 07:21:02 INFO - PROCESS | 6281 | [#3] audio-fft Cycles:10 Average:96.60 Median:75.50 stddev:44.84 (59.4%) stddev-sans-first:46.74 07:21:02 INFO - PROCESS | 6281 | Values: 73.0 77.0 77.0 187.0 75.0 74.0 76.0 77.0 176.0 74.0 07:21:02 INFO - PROCESS | 6281 | 07:21:02 INFO - PROCESS | 6281 | [#4] audio-oscillator Cycles:10 Average:109.50 Median:92.00 stddev:28.21 (30.7%) stddev-sans-first:29.20 07:21:02 INFO - PROCESS | 6281 | Values: 92.0 93.0 161.0 92.0 92.0 93.0 139.0 91.0 93.0 149.0 07:21:02 INFO - PROCESS | 6281 | 07:21:02 INFO - PROCESS | 6281 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.67 (0.6%) stddev-sans-first:0.67 07:21:02 INFO - PROCESS | 6281 | Values: 117.0 118.0 118.0 117.0 117.0 117.0 118.0 119.0 118.0 118.0 07:21:02 INFO - PROCESS | 6281 | 07:21:02 INFO - PROCESS | 6281 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.00 stddev:0.79 (0.5%) stddev-sans-first:0.83 07:21:02 INFO - PROCESS | 6281 | Values: 147.0 147.0 147.0 146.0 147.0 149.0 147.0 147.0 147.0 148.0 07:21:02 INFO - PROCESS | 6281 | 07:21:02 INFO - PROCESS | 6281 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 07:21:02 INFO - PROCESS | 6281 | Values: 95.0 96.0 96.0 95.0 95.0 95.0 96.0 96.0 95.0 95.0 07:21:02 INFO - PROCESS | 6281 | 07:21:02 INFO - PROCESS | 6281 | [#8] json-parse-financial Cycles:10 Average:58.90 Median:58.00 stddev:5.69 (9.8%) stddev-sans-first:5.93 07:21:02 INFO - PROCESS | 6281 | Values: 56.0 59.0 58.0 56.0 58.0 61.0 58.0 74.0 55.0 54.0 07:21:02 INFO - PROCESS | 6281 | 07:21:02 INFO - PROCESS | 6281 | [#9] json-stringify-tinderbox Cycles:10 Average:58.30 Median:58.00 stddev:0.82 (1.4%) stddev-sans-first:0.73 07:21:02 INFO - PROCESS | 6281 | Values: 57.0 59.0 58.0 58.0 60.0 59.0 58.0 58.0 58.0 58.0 07:21:02 INFO - PROCESS | 6281 | 07:21:02 INFO - PROCESS | 6281 | [#10] stanford-crypto-aes Cycles:10 Average:75.40 Median:74.00 stddev:3.84 (5.2%) stddev-sans-first:4.03 07:21:02 INFO - PROCESS | 6281 | Values: 74.0 74.0 72.0 74.0 73.0 82.0 83.0 73.0 75.0 74.0 07:21:02 INFO - PROCESS | 6281 | 07:21:02 INFO - PROCESS | 6281 | [#11] stanford-crypto-ccm Cycles:10 Average:120.30 Median:120.00 stddev:7.75 (6.5%) stddev-sans-first:8.21 07:21:02 INFO - PROCESS | 6281 | Values: 121.0 113.0 120.0 113.0 116.0 114.0 119.0 120.0 130.0 137.0 07:21:02 INFO - PROCESS | 6281 | 07:21:02 INFO - PROCESS | 6281 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.10 Median:161.50 stddev:2.92 (1.8%) stddev-sans-first:3.10 07:21:02 INFO - PROCESS | 6281 | Values: 161.0 162.0 164.0 166.0 161.0 156.0 157.0 161.0 161.0 162.0 07:21:02 INFO - PROCESS | 6281 | 07:21:02 INFO - PROCESS | 6281 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.90 Median:68.50 stddev:1.66 (2.4%) stddev-sans-first:1.72 07:21:02 INFO - PROCESS | 6281 | Values: 69.0 69.0 71.0 68.0 69.0 68.0 66.0 66.0 66.0 67.0 07:21:02 INFO - PROCESS | 6281 | -------- Summary: end -------- 07:21:02 INFO - PROCESS | 6281 | 07:21:03 INFO - TEST-INFO | 6281: exit 0 07:21:03 INFO - TEST-OK | kraken | took 60919ms 07:21:03 INFO - SUITE-END | took 1170s 07:21:03 INFO - Completed test suite (00:19:30) 07:21:03 INFO - javascript benchmark 07:21:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3405.6424075472073, 3443.4490481522944, 3446.86212551498, 3465.3589086019074, 3465.5494785677856, 5746.683932383718, 5758.1362795580635, 5778.6243894146855, 5787.508061814746, 5789.942100578993, 5721.885562288751, 5737.25415695959, 5738.8278351649415, 5744.138379243115, 5781.62419442736, 5202.583793296527, 5239.240310155025, 5244.659097158673, 5279.366476022883, 5280.287161233242, 5202.973985130069, 5271.341082364705, 5345.679259244458, 5369.865753356158, 5404.972975135119, 5288.6562373445795, 5302.496262855023, 5306.699858534665, 5309.787608495655, 5324.1215199492035, 5233.398159211663, 5281.996420680078, 5282.260483532289, 5306.177542480883, 5336.9733151334385, 5088.872778180538, 5111.488851114896, 5160.974195129038, 5202.531772140488, 5222.791088356461, 5615.438456154393, 5673.319201695823, 5681.062624666925, 5686.857828554278, 5697.088465845445, 6176.382361763833, 6178.474829639486, 6179.783707570258, 6179.907301390483, 6193.87612247757, 6071.514278857725, 6141.578063794106, 6163.137160797492, 6203.2556093269095, 6231.189945307081, 5767.048437007888, 5866.677332746697, 5871.588988770788, 5872.0, 5873.500752436048, 6246.250449946036, 6376.808695739135, 6391.456726178327, 6392.776252831129, 6397.648129352837, 6041.818745437644, 6086.087086936995, 6103.115048317969, 6136.601120927215, 6142.078688196717, 6189.35011823761, 6213.347598502182, 6221.129041934133, 6229.688515574203, 6234.657093859791, 6049.0, 6141.823559979257, 6179.0422484514975, 6185.752569897244, 6235.220597425322, 6179.69101544921, 6196.752129914753, 6202.379762023762, 6211.472024877846, 6212.223472065992, 4689.015306785614, 4696.272077827942, 4700.952990470051, 4707.270373092176, 4748.857534273978, 4101.302778527657, 4184.267753143188, 4190.224808410454, 4229.111886503807, 4252.766097864585, 5942.61373010753, 5944.554158438048, 5950.375210602911, 5979.073243647154, 6017.939820601738, 6203.627782333075, 6218.471429928416, 6227.19046523949, 6237.438630523275, 6243.8126856194385, 5947.464728174485, 5971.19388882504, 5984.521238300926, 6006.069059295816, 6038.245219347582, 5284.154535274338, 5308.389535203424, 5319.760610772524, 5330.0, 5335.946640533545, 6404.423601875854, 6460.224773027267, 6466.741330346827, 6471.0, 6472.288048314682, 6099.542534309856, 6141.547378150805, 6311.936880631319, 6346.809595712136, 6355.110284560073, 6409.935900640934, 6425.06836508713, 6451.0645956337, 6454.1609590752905, 6486.05952136947, 5883.882322353444, 6128.66292353907, 6134.325224225242, 6134.846628834315, 6148.047052706837, 6198.969005154945, 6265.279492858197, 6288.968555157195, 6294.5593808434805, 6307.558470907176, 6049.758009679564, 6060.545459090497, 6070.423309785563, 6076.878462430638, 6097.024476083982, 5861.208736820645, 6064.120702498201, 6077.787277445268, 6092.208012958287, 6123.479504242189, 5968.791092311748, 6012.549058820693, 6023.066424704178, 6034.155218269533, 6037.78867739627, 6096.055111457731, 6137.478314343331, 6141.907871382022, 6144.109104179958, 6169.938300616936, 5861.7655293787775, 5990.520758339409, 6007.399260074132, 6031.819045428644, 6086.60437071589], "value": 5724.384447684017, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [649.2274193709485, 669.1034014420677, 675.0178490296619, 679.3546131175382, 693.9687714052867, 40390.192196156095, 41374.37938430926, 41427.58572414275, 41477.377839332396, 41574.58425415745, 41504.792476037655, 42361.0, 42391.15217695644, 42480.3627945581, 42507.57492425075, 8717.651293948235, 8789.208971192591, 8845.513496757676, 8853.070427605106, 8882.378233523656, 8678.435901666404, 8931.73204803857, 8974.461532308082, 8982.505962172077, 8991.0, 9031.277497800193, 9034.728958131234, 9041.95479022604, 9045.909540904606, 9046.954765226164, 8901.06538813425, 8948.8657670135, 8958.238549723248, 8961.103889610988, 8999.595018224163, 8868.778280542974, 8950.910490895138, 8957.238634715992, 8977.955110224473, 9021.413608115452, 35694.0, 42040.78979605113, 42560.148797024194, 42700.359494607605, 42745.786271068755, 3713.275911197318, 3805.9238815223816, 3911.471951286568, 3957.2679054374744, 4146.067134894654, 29639.259018524495, 29776.553351699742, 30237.244068898235, 30319.848400758077, 30433.0, 4633.397658304432, 4665.440147182326, 4682.4381074271305, 4730.929036064462, 4825.589824864891, 288988.0, 292291.53854230803, 292551.0, 293427.0, 293456.0, 63934.36065639377, 65328.346716533175, 65363.0, 65402.0, 65446.672766635864, 70867.64566177239, 71258.0, 71702.64148679223, 71777.0, 72085.6395718018, 19211.903940480486, 19307.51731206703, 19396.515087122934, 19416.611667766847, 19423.223071077282, 14868.182249976355, 14879.404823806926, 14900.552983410515, 14910.70178596422, 14949.402023918921, 20380.184792608427, 20756.377308680763, 20768.273110441063, 20769.480762981046, 21657.45856353572, 7823.569703666353, 7824.843503129906, 7979.281864632211, 8060.717874874468, 8126.349892008625, 1042.4943902207424, 1089.6894385100209, 1110.4614262082882, 1186.1400484648561, 1210.7033776724759, 33890.830545847115, 34248.14379640479, 34322.65677343245, 34637.82681086579, 34802.0, 1158.3455347728507, 1164.2839653612966, 1201.2312120243053, 1224.1492162946668, 1254.3978890132787, 16078.115703636413, 16136.273867675984, 16394.344226231056, 16952.57618559546, 16982.40561580339, 496798.0, 552923.0, 554060.0, 566307.0, 566822.0, 58696.706516467995, 59404.0, 59659.105113423335, 59710.40289597048, 59885.70057149686, 1501.3319073012406, 1551.83705710901, 1558.5791836204162, 1558.6804705035668, 1560.7346751052348, 34992.82503587466, 35208.0, 35501.11247218737, 35871.64128358683, 35936.28127437384, 57089.42910570841, 57169.428305716414, 57853.13220301615, 58004.4199557999, 58111.4188858106, 437972.0, 441674.0, 442152.0, 443075.0, 444029.0, 31205.843970780003, 31225.063248102593, 31668.208294792814, 32252.19369515781, 32346.191345216557, 52887.0, 53016.2047569279, 53688.73155634197, 53974.19038714344, 54308.45691543192, 43440.0, 44656.77671611621, 44940.0, 45139.322910155715, 45996.310055349866, 43526.782366087966, 43622.0, 44059.55940440555, 44134.11731765411, 45650.315245270685, 44181.0, 45221.77389113033, 45924.770376147906, 46281.53718462772, 46571.06857862892, 33071.66928330782, 33703.66296337005, 33935.660643394236, 35880.3654611246, 36839.81580092083, 28921.132366029055, 29181.0, 29399.0, 29712.257193570334, 29780.851095744383], "value": 21185.325821852104, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [433.84381622615865, 436.2866712924368, 442.30999640560725, 442.3519543868234, 454.9181147393468, 18625.441236762887, 18814.90592547037, 19100.80899191008, 19249.518762030937, 19469.805301946977, 18306.267749290048, 18513.35203267886, 20352.491187720316, 20480.28319008835, 20503.384898453034, 5783.566232532567, 5823.5341172706085, 5931.199288096095, 5969.940300596982, 5994.920914235436, 5681.062624666925, 5877.67672777997, 5923.28920529537, 5958.851028724273, 5968.612040217394, 5886.234789477362, 5923.614965027259, 5944.048952167654, 5965.433283838029, 5996.190514280582, 5895.35151133375, 5906.911396329058, 6581.111549940744, 6605.108310378109, 6621.702023408958, 5899.233099697055, 5941.613795103304, 5949.405059494059, 5976.73104710289, 5983.042713165873, 15011.099334039993, 15140.167290799001, 15145.469908553257, 15159.62100947474, 17237.0, 2533.1007492340136, 2629.7764690001372, 2839.843808590527, 3024.894128705507, 3156.2898347871774, 10965.287256328313, 11516.654500364919, 12518.436670349856, 14739.336729847182, 15179.62050948724, 2017.7175195472646, 2076.356329537848, 2093.9476513087143, 2112.968305475419, 2167.1548096242477, 81781.18218817795, 82448.17551824465, 85085.57457212674, 85172.57413712892, 85827.14172858317, 11600.30398176112, 11775.116866235066, 11891.702707432383, 12015.399230038463, 12534.498620055096, 16961.15194240283, 17027.65944681124, 17065.06142162168, 17065.720070994725, 17066.31734730597, 8851.247643950337, 9051.868516435445, 9094.909050909539, 9115.954420227856, 9227.907720922705, 8727.738167854974, 8779.912200878038, 8839.248663863515, 9003.099690031075, 9036.051214622501, 5080.237964305384, 5169.560587350042, 5171.77724338187, 5194.4026436959475, 5198.766055527511, 2049.231538173185, 2058.5059585699323, 2100.1494394770143, 2102.253699936531, 2177.5862586108587, 1058.2169194795795, 1089.7576762490767, 1120.4173829608558, 1132.7847708935276, 1135.3131355529786, 18913.7162942556, 19043.42869713911, 19208.13563389651, 19423.0, 19612.411627651192, 1099.4228030284164, 1144.9370284634258, 1145.7422080032093, 1173.4074292482412, 1210.9697257568632, 10584.735381615521, 11026.283291586022, 11061.0, 11160.441977901073, 11160.720981975515, 488669.0, 488932.0, 489129.0, 492440.0, 497971.0, 60804.0, 65210.0, 90911.0, 103262.0, 106942.46528767307, 1113.6325012745774, 1150.7295785490403, 1156.7744289863565, 1168.707823044239, 1174.5243176513354, 17909.28362865523, 18027.09864506743, 18175.18211680504, 18304.908475457538, 18405.631887362444, 40876.38685419781, 40988.59011409848, 42342.78828605837, 42893.57106428896, 43038.0, 56420.717896411894, 62150.68924655348, 62729.0, 62965.0, 63113.684431579386, 9178.265738741018, 9216.815663686823, 9326.766830829283, 9505.619775208914, 9528.428294302365, 7839.412044096602, 10942.835857461985, 12805.359732013176, 13607.931960340135, 13782.241976691379, 12042.759144816879, 12213.816792748294, 12222.083343749433, 12279.631611051684, 12445.62663120108, 11743.41282935867, 12150.02799775998, 12252.448639811051, 12254.4485498151, 12274.202176858476, 6911.896321555281, 11233.606823761129, 11940.52237910474, 12109.515619375126, 12396.504139834306, 9129.497877616795, 9151.450912945245, 9217.459928973749, 9400.905990940004, 9597.28020398459, 11685.649430517098, 11776.941115294369, 11810.232334898204, 11966.880331196577, 12055.0], "value": 9652.347760831499, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1542.992285038575, 1576.0464918724176, 1741.7213245880653, 1817.4365946556568, 1895.9052047397627, 7919.643616037278, 8516.0, 8641.222289993899, 8939.150780675833, 8947.284217262619, 8541.316694664427, 8606.827863442728, 8739.082396348387, 8747.12528747125, 8759.43063700859, 2429.040528991043, 2454.9754502454925, 2463.0394146282874, 2475.5296493666237, 2488.079410618074, 2431.294924471901, 2527.0397249045427, 2527.494501099778, 2528.4058246312193, 2529.064246228889, 2463.6550882876413, 2475.306914064065, 2508.5233805576972, 2511.5855883779154, 2526.8357556758842, 2466.334089795754, 2486.6643003194517, 2491.8006559475198, 2497.4880149569294, 2502.3493891588228, 2447.730749617541, 2456.078970386105, 2465.60550311951, 2491.0, 2535.3027917322884, 9027.864582031274, 9063.093690630883, 9063.68277110298, 9071.501067441288, 9088.318376121817, 5498.835034948958, 5598.664080155204, 5607.52336051432, 5620.5503559715125, 5622.550195984311, 3503.3343664703625, 3532.116970757311, 3555.4311310190506, 3575.4458059000895, 3581.7850928944085, 1162.6744511536783, 1193.7672153929987, 1204.1931905623253, 1214.4474264209764, 1220.4324988880126, 12688.555900543437, 12770.169938953939, 12820.230786152768, 12830.486780528767, 12851.614451566375, 4737.45519265282, 4765.9761701191965, 4777.044591081728, 4823.469418363977, 4984.725840078758, 10848.294860834021, 10900.454977251105, 10911.399873007062, 10912.0, 10950.34297942126, 5536.75084621193, 5576.302962129734, 5592.832215033555, 5593.468620481048, 5602.523785478198, 4558.5897269245925, 4997.525235102659, 5049.166887463601, 5079.619028572798, 5109.182530795129, 4401.273789824707, 4454.420925279693, 4558.8632341029825, 4570.040291538748, 4575.3365761965, 1378.8690074442911, 1439.6400899775056, 1449.3188201545256, 1456.1263242054895, 1456.4975083596141, 1092.8415379770047, 1099.7008973080758, 1100.9028594686129, 1109.9559384127958, 1141.1270378160714, 6417.422431981144, 6455.322191169954, 6466.515011374072, 6534.901976470357, 6581.243157037002, 490.8453837041321, 499.86753510319795, 499.97250151241303, 505.3884799392776, 508.6134537751262, 4488.0, 4566.086782643484, 4584.7936842842155, 4592.448906131285, 4610.815567377267, 10638.627648032281, 11008.669739907815, 11029.83455248172, 11046.116310695124, 11110.166737494721, 10129.189664826796, 10827.566897324177, 10860.0, 10935.945320273348, 10947.069499092508, 8399.958000210083, 8427.536485493234, 8460.661573537112, 8497.36269779769, 8578.227959483676, 5970.791022314372, 6111.602745821508, 6145.784897528565, 6192.876142477216, 6249.281332646804, 9695.757606059622, 9899.901000990187, 9999.800004000024, 10023.398596084258, 10036.247281453774, 9884.209263258777, 9999.150072243941, 10409.739756506147, 10460.110890574386, 10567.735806604896, 7711.344535714527, 8063.637136328996, 8081.111077781322, 8084.9595752023215, 8096.190380962093, 8626.223639872442, 8644.308455323684, 8646.265067469336, 8655.134486551295, 8661.307095432225, 7679.846403072019, 7746.070471543226, 7977.242161994601, 8147.348212142896, 8163.591820409075, 7753.457257992112, 7834.608269586612, 7841.921580784119, 7847.411444141598, 8004.039515258206, 7010.474214433836, 7037.1555413350725, 7076.540024898365, 7125.786226413215, 7131.179914309921, 5423.078076727044, 5432.5110740032005, 5446.945530544803, 5462.726863656721, 5510.421405752499, 5520.199571062093, 5564.582656300713, 5620.971895140498, 5701.914471282851, 5744.310682718101], "value": 4788.152063508315, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [370.6460330384483, 372.42460398684045, 372.5436340482908, 376.41091691502794, 376.8907016965082, 6425.196850393695, 6444.677766111699, 6533.281339052706, 6537.869242615151, 6640.103586015886, 6618.907880199761, 6674.899876501844, 6676.0319753635695, 6679.899801502969, 6680.997850322442, 5047.015831912779, 5075.111855425304, 5088.92366614501, 5090.287359769635, 5091.592672586185, 5068.594512438996, 5084.694918304914, 5091.6690415123085, 5101.285819985186, 5101.872453188663, 5039.596832253411, 5045.571126454256, 5047.369078865142, 5048.141815891289, 5055.721935293557, 4944.554990050912, 4957.429895562021, 4992.425871024842, 5031.496850314976, 5040.798368065273, 4301.741895486281, 4324.740515569045, 4326.870193894189, 4355.760433176174, 4372.956270437287, 6343.714532846033, 6348.365163483615, 6349.714262858182, 6363.522735794788, 6396.392342727433, 5549.056660367747, 5683.261176047129, 5713.628614140068, 5718.48533631971, 5832.6500409975115, 6886.724531018754, 6907.240203577602, 6932.341427564374, 6935.098437203132, 6938.965305173442, 4776.47458779534, 4777.641676874214, 4779.091972525209, 4780.665353425262, 4789.592884604813, 7213.350798428167, 7265.89101163483, 7272.763630182882, 7275.672594733197, 7283.308085731847, 4794.513700752777, 4799.136155491975, 4803.927941080887, 4807.158747219222, 4826.855194344105, 4772.0694464579765, 4879.219324907997, 4899.608031357483, 4944.505549445027, 4953.331300274489, 5715.114157305624, 5716.028275193227, 5730.0, 5731.168980497804, 5756.136579513107, 6946.687399067054, 6953.687084081127, 6992.335728105923, 7003.439724822104, 7012.807822670158, 1719.0, 1739.7129473636708, 1741.477556732975, 1743.2678275124479, 1744.7557341972133, 1080.4543705428866, 1109.073923274059, 1130.22014809781, 1146.4611632532697, 1156.7397335599424, 6775.898361524581, 6930.168379794457, 6930.168379794457, 6969.303069693092, 6989.231184569693, 7310.268973102648, 7311.926880731231, 7334.119905611361, 7338.77983660491, 7339.155997060299, 6851.520393572502, 6871.828204294832, 6910.827229319207, 6915.930840691629, 6921.342472465108, 3823.9808800956375, 3902.746321489094, 3948.4274780156716, 3950.486436763202, 3955.0903292242947, 7630.96184519085, 7638.961805190938, 7648.1204661463535, 7650.770476885702, 7658.693652253959, 7308.6345682715655, 7331.963340183265, 7342.118945726547, 7371.520851144658, 7407.8148046299275, 7570.356519695777, 7596.468247222641, 7628.199039100926, 7638.0, 7646.273604007611, 7152.85694286101, 7223.097112860893, 7260.673269702982, 7292.744753933587, 7320.194778574459, 7112.537685050455, 7140.964295178491, 7141.82145446368, 7160.391366733886, 7184.640767961477, 7586.279303466162, 7612.7716168515035, 7615.048118985127, 7618.085829700472, 7625.084989801259, 4895.094407534618, 4899.681520701143, 4906.803727850846, 4907.950920490749, 4911.0, 7125.251848555827, 7233.348998590152, 7250.854982900418, 7259.818504537428, 7269.491135620668, 7015.508914375945, 7039.260877607778, 7044.295570442915, 7050.682719277543, 7052.259512751088, 6985.091938048021, 7017.403520700594, 7033.156021277479, 7033.261507541839, 7045.647717613996, 6853.760118395832, 6880.449564034965, 6884.345987131214, 6893.0, 6897.137857767779, 6896.793096207121, 7020.227774944854, 7056.364927156581, 7083.327083927019, 7087.433005359662, 6697.899531507129, 6842.965785171242, 6925.0, 6925.099737034153, 6955.547889387173], "value": 5273.594306765449, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [768.7770546541503, 778.4434129597337, 822.0217940650629, 904.1365495951366, 906.891173059233, 13469.461221551139, 13526.864731352684, 13580.049396542247, 13719.794203086962, 14109.0, 13370.264635445046, 13371.064025518193, 13437.798433023512, 13455.0, 13461.057725959163, 750.9812254693621, 857.8241460500583, 864.494270851551, 885.3581153663607, 887.3211992825494, 895.6014573514789, 897.3001059173855, 903.3902116071625, 904.4121321141245, 906.4289497616526, 928.633189889993, 933.0, 936.199549385276, 940.7977284883749, 941.2140862379887, 926.3237836379413, 927.7912469694264, 930.7068273493861, 931.5481991234246, 932.0446542294135, 683.6957553888521, 686.2279935073043, 686.7767975408012, 687.9484038697068, 690.6270613868555, 14329.0, 14421.0, 14422.206778627171, 14429.422823087063, 14439.783403248959, 14598.197099159543, 14634.121952682766, 14786.112833229932, 14797.852021479755, 14825.851741482555, 11481.88518114825, 11598.0, 11768.764624707543, 11836.881631183664, 11927.403629818475, 4000.979995100006, 4028.5971402859773, 4066.6340029397497, 4072.2669919414493, 4076.9388459173138, 55331.72334138344, 55357.446425536036, 55912.0, 55960.72019639876, 55977.0, 11642.6507204784, 11774.705632359259, 11816.46825892837, 12071.939640301742, 12109.333986630643, 21605.351839444527, 21669.458263543536, 21698.240561580267, 21722.34832955014, 21736.673949890763, 8564.443311184754, 8609.268212202032, 8724.91275087241, 8745.56272186401, 8880.73357799267, 4870.732109733999, 4952.603791696655, 4969.525554714599, 5024.598032157419, 5038.2190760432195, 3347.447671134284, 3394.304167645627, 3395.4567269236804, 3396.388650043016, 3403.829808509565, 600.2766666167258, 601.8044135655929, 606.4117805728437, 607.7720854679495, 608.656109298245, 671.5467059734659, 740.2005833699592, 756.8486302739474, 771.3327971304781, 847.1147650705028, 9787.853182202272, 10074.345167564084, 10157.542910569042, 10311.381317120997, 10325.432101234353, 768.2970082374565, 783.3654739660893, 792.4967645545005, 794.6503538443067, 803.7146812881343, 4736.100140973204, 4837.250226214942, 4855.247436647325, 4896.853094407174, 4901.191303434894, 68247.3175268241, 68552.0, 68819.31180688129, 69220.65389673019, 69475.0, 60358.39641603528, 60449.39550604438, 60674.69662651658, 60755.0, 60972.39027609756, 53948.46051539513, 54198.729006355505, 55074.44925550773, 56005.7199714007, 56251.437485625436, 9538.23694104484, 9573.473458959825, 9685.70942871715, 9695.757606059906, 9759.56081976327, 41397.37903931383, 41469.37795933003, 42537.36193957031, 42698.78650606727, 42975.57024429841, 53759.73120134374, 53814.73092634668, 54312.45687543074, 54755.17867232074, 55140.44859551514, 11977.940110299392, 12156.878431215575, 12912.16070955385, 13057.608271751862, 13215.405306761026, 13163.276019818619, 13793.862061379257, 14254.073485223427, 14358.425662973365, 14918.254087295809, 13076.934615326862, 13154.0, 13274.643693675842, 13837.792433113713, 14025.789613155606, 13537.526186583422, 13800.240986745825, 14043.0, 14312.499062532761, 14553.417863285349, 12768.808467873176, 13371.06402551812, 13467.663308417368, 13768.449262029808, 13911.930440347733, 10591.205659575717, 10614.1508679307, 10674.199435042248, 10791.0, 10800.837987430352, 10764.192685548773, 10945.507452164513, 11089.168312376765, 11358.375289359165, 11408.144389170679], "value": 7200.712313627402, "unit": "score"}], "name": "dromaeo_css", "value": 7727.056436597674, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 111.0, 105.0, 110.0, 112.0, 111.0, 101.0, 112.0, 111.0, 110.0], "value": 109.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 127.0, 158.0, 182.0, 129.0, 154.0, 148.0, 129.0, 188.0, 128.0], "value": 149.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 163.0, 165.0, 162.0, 173.0, 164.0, 165.0, 164.0, 164.0], "value": 164.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 77.0, 77.0, 187.0, 75.0, 74.0, 76.0, 77.0, 176.0, 74.0], "value": 96.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 93.0, 161.0, 92.0, 92.0, 93.0, 139.0, 91.0, 93.0, 149.0], "value": 109.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 117.0, 117.0, 117.0, 118.0, 119.0, 118.0, 118.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 146.0, 147.0, 149.0, 147.0, 147.0, 147.0, 148.0], "value": 147.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 59.0, 58.0, 56.0, 58.0, 61.0, 58.0, 74.0, 55.0, 54.0], "value": 58.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 59.0, 58.0, 58.0, 60.0, 59.0, 58.0, 58.0, 58.0, 58.0], "value": 58.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 72.0, 74.0, 73.0, 82.0, 83.0, 73.0, 75.0, 74.0], "value": 75.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 113.0, 120.0, 113.0, 116.0, 114.0, 119.0, 120.0, 130.0, 137.0], "value": 120.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 164.0, 166.0, 161.0, 156.0, 157.0, 161.0, 161.0, 162.0], "value": 161.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 71.0, 68.0, 69.0, 68.0, 66.0, 66.0, 66.0, 67.0], "value": 67.9, "unit": "score"}], "name": "kraken", "value": 1532.1, "alertThreshold": 2.0}]} 07:21:03 INFO - Return code: 0 07:21:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 07:21:03 ERROR - # TBPL SUCCESS # 07:21:03 INFO - Running post-action listener: _resource_record_post_action 07:21:03 INFO - Running post-run listener: _resource_record_post_run 07:21:04 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 4096; Write bytes: 499671040; Read time: 8; Write time: 611276 07:21:04 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 249614336; Read time: 0; Write time: 396288 07:21:04 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 4096; Write bytes: 250056704; Read time: 8; Write time: 214988 07:21:04 INFO - Running post-run listener: _upload_blobber_files 07:21:04 INFO - Blob upload gear active. 07:21:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:21:04 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 07:21:04 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'] 07:21:04 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 07:21:04 INFO - (blobuploader) - INFO - Open directory for files ... 07:21:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:21:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:21:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:21:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:21:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:21:06 INFO - (blobuploader) - INFO - Done attempting. 07:21:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:21:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:21:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:21:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:21:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:21:07 INFO - (blobuploader) - INFO - Done attempting. 07:21:07 INFO - (blobuploader) - INFO - Iteration through files over. 07:21:07 INFO - Return code: 0 07:21:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:21:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:21:07 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c6e477c13bd12197672c4d53c51981e2c46b5937a0c59807d6e50d238b8d79cbc068c754e7f1fd22f563d98e0a7aaedd119954397d5e86a37be07e05dee23bf7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cfa9e639c88c5bda51046c5ad45a1006fb751d3c50306ba1cab6b00027493c0dde8ca8cf5c331b08fe33f1d36a7009682abec44dedf918962fc8795a85f57a73"} 07:21:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:21:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:21:07 INFO - Contents: 07:21:07 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c6e477c13bd12197672c4d53c51981e2c46b5937a0c59807d6e50d238b8d79cbc068c754e7f1fd22f563d98e0a7aaedd119954397d5e86a37be07e05dee23bf7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cfa9e639c88c5bda51046c5ad45a1006fb751d3c50306ba1cab6b00027493c0dde8ca8cf5c331b08fe33f1d36a7009682abec44dedf918962fc8795a85f57a73"} 07:21:07 INFO - Running post-run listener: copy_logs_to_upload_dir 07:21:07 INFO - Copying logs to upload dir... 07:21:07 INFO - mkdir: /builds/slave/test/build/upload/logs 07:21:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1225.571114 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 25 secs) (at 2016-06-06 07:21:06.410211) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-06 07:21:06.414158) ========= 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=af724c981e2a0f424dbabf99000001e7-1465221639.512401-1901585856 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/c6e477c13bd12197672c4d53c51981e2c46b5937a0c59807d6e50d238b8d79cbc068c754e7f1fd22f563d98e0a7aaedd119954397d5e86a37be07e05dee23bf7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cfa9e639c88c5bda51046c5ad45a1006fb751d3c50306ba1cab6b00027493c0dde8ca8cf5c331b08fe33f1d36a7009682abec44dedf918962fc8795a85f57a73"} build_url:https://queue.taskcluster.net/v1/task/TPuJqxlBRzGNOtqJN1sFbw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011248 build_url: 'https://queue.taskcluster.net/v1/task/TPuJqxlBRzGNOtqJN1sFbw/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/c6e477c13bd12197672c4d53c51981e2c46b5937a0c59807d6e50d238b8d79cbc068c754e7f1fd22f563d98e0a7aaedd119954397d5e86a37be07e05dee23bf7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cfa9e639c88c5bda51046c5ad45a1006fb751d3c50306ba1cab6b00027493c0dde8ca8cf5c331b08fe33f1d36a7009682abec44dedf918962fc8795a85f57a73"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-06 07:21:06.439661) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 07:21:06.440034) ========= 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=af724c981e2a0f424dbabf99000001e7-1465221639.512401-1901585856 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004662 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 07:21:06.524950) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-06 07:21:06.525303) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-06 07:21:06.525625) ========= ========= Total master_lag: 0.18 =========