builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-050 starttime: 1464447079.22 results: success (0) buildid: 20160528051133 builduid: 7503437525154ad183cd41cd16907ba0 revision: bfea62662298a8400d559abd40ec7d4d12fbd97d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-28 07:51:19.221362) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-28 07:51:19.221868) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-28 07:51:19.222427) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-28 07:51:19.268306) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 07:51:19.268599) ========= 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=6dbc10da6d83fee962c624be000001a8-1464445622.817643-482957209 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-28 07:51:19-- 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% 66.1M=0s 2016-05-28 07:51:19 (66.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.110881 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 07:51:19.394085) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 07:51:19.394475) ========= 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=6dbc10da6d83fee962c624be000001a8-1464445622.817643-482957209 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019622 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 07:51:19.445574) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 07:51:19.445964) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev bfea62662298a8400d559abd40ec7d4d12fbd97d --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 bfea62662298a8400d559abd40ec7d4d12fbd97d --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=6dbc10da6d83fee962c624be000001a8-1464445622.817643-482957209 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-28 07:51:19,881 truncating revision to first 12 chars 2016-05-28 07:51:19,881 Setting DEBUG logging. 2016-05-28 07:51:19,881 attempt 1/10 2016-05-28 07:51:19,881 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/bfea62662298?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-28 07:51:20,247 unpacking tar archive at: mozilla-aurora-bfea62662298/testing/mozharness/ program finished with exit code 0 elapsedTime=0.699404 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 07:51:20.166365) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-28 07:51:20.166676) ========= script_repo_revision: bfea62662298a8400d559abd40ec7d4d12fbd97d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-28 07:51:20.167082) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-28 07:51:20.167361) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-28 07:51:20.184400) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-05-28 07:51:20.184686) ========= /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=6dbc10da6d83fee962c624be000001a8-1464445622.817643-482957209 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:51:20 INFO - MultiFileLogger online at 20160528 07:51:20 in /builds/slave/test 07:51:20 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:51:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:51:20 INFO - {'append_to_log': False, 07:51:20 INFO - 'base_work_dir': '/builds/slave/test', 07:51:20 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 07:51:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:51:20 INFO - 'branch': 'Mozilla-Aurora', 07:51:20 INFO - 'buildbot_json_path': 'buildprops.json', 07:51:20 INFO - 'config_files': ('talos/linux_config.py',), 07:51:20 INFO - 'default_actions': ('clobber', 07:51:20 INFO - 'read-buildbot-config', 07:51:20 INFO - 'download-and-extract', 07:51:20 INFO - 'populate-webroot', 07:51:20 INFO - 'create-virtualenv', 07:51:20 INFO - 'install', 07:51:20 INFO - 'run-tests'), 07:51:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:51:20 INFO - 'download_minidump_stackwalk': True, 07:51:20 INFO - 'download_symbols': 'ondemand', 07:51:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:51:20 INFO - 'tooltool.py': '/tools/tooltool.py', 07:51:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:51:20 INFO - '/tools/misc-python/virtualenv.py')}, 07:51:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:51:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:51:20 INFO - 'installer_path': 'installer.exe', 07:51:20 INFO - 'log_level': 'info', 07:51:20 INFO - 'log_name': 'talos', 07:51:20 INFO - 'log_to_console': True, 07:51:20 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:51:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:51:20 INFO - 'opt_config_files': (), 07:51:20 INFO - 'pip_index': False, 07:51:20 INFO - 'sps_profile': False, 07:51:20 INFO - 'sps_profile_interval': 0, 07:51:20 INFO - 'suite': 'dromaeojs-e10s', 07:51:20 INFO - 'system_bits': '32', 07:51:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:51:20 INFO - 'title': 'talos-linux64-ix-050', 07:51:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:51:20 INFO - 'use_talos_json': True, 07:51:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:51:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:51:20 INFO - 'work_dir': 'build'} 07:51:20 INFO - ##### 07:51:20 INFO - ##### Running clobber step. 07:51:20 INFO - ##### 07:51:20 INFO - Running pre-action listener: _resource_record_pre_action 07:51:20 INFO - Running main action method: clobber 07:51:20 INFO - rmtree: /builds/slave/test/build 07:51:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:51:21 INFO - Running post-action listener: _resource_record_post_action 07:51:21 INFO - ##### 07:51:21 INFO - ##### Running read-buildbot-config step. 07:51:21 INFO - ##### 07:51:21 INFO - Running pre-action listener: _resource_record_pre_action 07:51:21 INFO - Running main action method: read_buildbot_config 07:51:21 INFO - Using buildbot properties: 07:51:21 INFO - { 07:51:21 INFO - "project": "", 07:51:21 INFO - "product": "firefox", 07:51:21 INFO - "script_repo_revision": "production", 07:51:21 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 07:51:21 INFO - "repository": "", 07:51:21 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 07:51:21 INFO - "buildid": "20160528051133", 07:51:21 INFO - "pgo_build": "True", 07:51:21 INFO - "basedir": "/builds/slave/test", 07:51:21 INFO - "buildnumber": 300, 07:51:21 INFO - "slavename": "talos-linux64-ix-050", 07:51:21 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 07:51:21 INFO - "platform": "ubuntu64_hw", 07:51:21 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 07:51:21 INFO - "branch": "mozilla-aurora", 07:51:21 INFO - "repo_path": "releases/mozilla-aurora", 07:51:21 INFO - "revision": "bfea62662298a8400d559abd40ec7d4d12fbd97d", 07:51:21 INFO - "stage_platform": "linux64-pgo", 07:51:21 INFO - "builduid": "7503437525154ad183cd41cd16907ba0", 07:51:21 INFO - "slavebuilddir": "test" 07:51:21 INFO - } 07:51:21 INFO - Found installer url https://queue.taskcluster.net/v1/task/dgqWuW-xToS7oa47Vy7qQw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 07:51:21 INFO - Running post-action listener: _resource_record_post_action 07:51:21 INFO - ##### 07:51:21 INFO - ##### Running download-and-extract step. 07:51:21 INFO - ##### 07:51:21 INFO - Running pre-action listener: _resource_record_pre_action 07:51:21 INFO - Running main action method: download_and_extract 07:51:21 INFO - mkdir: /builds/slave/test/build/tests 07:51:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:51:21 INFO - https://queue.taskcluster.net/v1/task/dgqWuW-xToS7oa47Vy7qQw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:51:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dgqWuW-xToS7oa47Vy7qQw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 07:51:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dgqWuW-xToS7oa47Vy7qQw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 07:51:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dgqWuW-xToS7oa47Vy7qQw/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:51:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dgqWuW-xToS7oa47Vy7qQw/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:51:31 INFO - Downloaded 1361 bytes. 07:51:31 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 07:51:31 INFO - Using the following test package requirements: 07:51:31 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 07:51:31 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 07:51:31 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 07:51:31 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 07:51:31 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 07:51:31 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 07:51:31 INFO - u'jsshell-linux-x86_64.zip'], 07:51:31 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 07:51:31 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 07:51:31 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 07:51:31 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 07:51:31 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 07:51:31 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 07:51:31 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 07:51:31 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 07:51:31 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 07:51:31 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 07:51:31 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 07:51:31 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:51: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:51:31 INFO - https://queue.taskcluster.net/v1/task/dgqWuW-xToS7oa47Vy7qQw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:51:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dgqWuW-xToS7oa47Vy7qQw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 07:51:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dgqWuW-xToS7oa47Vy7qQw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 07:51:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dgqWuW-xToS7oa47Vy7qQw/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:51:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dgqWuW-xToS7oa47Vy7qQw/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:51:36 INFO - Downloaded 24136089 bytes. 07:51:36 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:51:36 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:51:37 INFO - Return code: 0 07:51:37 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:51:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:51:37 INFO - https://queue.taskcluster.net/v1/task/dgqWuW-xToS7oa47Vy7qQw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:51:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dgqWuW-xToS7oa47Vy7qQw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 07:51:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dgqWuW-xToS7oa47Vy7qQw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 07:51:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dgqWuW-xToS7oa47Vy7qQw/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:51:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dgqWuW-xToS7oa47Vy7qQw/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:51:40 INFO - Downloaded 24136089 bytes. 07:51:40 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:51:40 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:51:41 INFO - Return code: 0 07:51:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:51:41 INFO - https://queue.taskcluster.net/v1/task/dgqWuW-xToS7oa47Vy7qQw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:51:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dgqWuW-xToS7oa47Vy7qQw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 07:51:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dgqWuW-xToS7oa47Vy7qQw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 07:51:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dgqWuW-xToS7oa47Vy7qQw/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:51:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dgqWuW-xToS7oa47Vy7qQw/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:51:43 INFO - Downloaded 10840145 bytes. 07:51:43 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:51:43 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:51:43 INFO - Return code: 0 07:51: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:51:43 INFO - https://queue.taskcluster.net/v1/task/dgqWuW-xToS7oa47Vy7qQw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:51:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dgqWuW-xToS7oa47Vy7qQw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 07:51:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dgqWuW-xToS7oa47Vy7qQw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 07:51:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dgqWuW-xToS7oa47Vy7qQw/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:51:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dgqWuW-xToS7oa47Vy7qQw/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:51:45 INFO - Downloaded 62745427 bytes. 07:51:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dgqWuW-xToS7oa47Vy7qQw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 07:51:45 INFO - mkdir: /builds/slave/test/properties 07:51:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:51:45 INFO - Writing to file /builds/slave/test/properties/build_url 07:51:45 INFO - Contents: 07:51:45 INFO - build_url:https://queue.taskcluster.net/v1/task/dgqWuW-xToS7oa47Vy7qQw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 07:51:45 INFO - Running post-action listener: _resource_record_post_action 07:51:45 INFO - Running post-action listener: set_extra_try_arguments 07:51:45 INFO - ##### 07:51:45 INFO - ##### Running populate-webroot step. 07:51:45 INFO - ##### 07:51:45 INFO - Running pre-action listener: _resource_record_pre_action 07:51:45 INFO - Running main action method: populate_webroot 07:51:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:51:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:51:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:51:46 INFO - '--tppagecycles', 07:51:46 INFO - '7'], 07:51:46 INFO - 'tests': ['tsvgm']}}, 07:51:46 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:51:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:51:46 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:51:46 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:51:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:51:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:51:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:51:46 INFO - 'talos_options': ['--disable-e10s'], 07:51:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:51:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:51:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:51:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:51:46 INFO - 'talos_options': ['--disable-e10s'], 07:51:46 INFO - 'tests': ['damp', 'tps']}, 07:51:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:51:46 INFO - 'tests': ['damp', 'tps']}, 07:51:46 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:51:46 INFO - 'tests': ['dromaeo_dom']}, 07:51:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:51:46 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:51:46 INFO - 'tests': ['a11yr', 07:51:46 INFO - 'ts_paint', 07:51:46 INFO - 'tpaint', 07:51:46 INFO - 'sessionrestore', 07:51:46 INFO - 'sessionrestore_no_auto_restore', 07:51:46 INFO - 'tabpaint']}, 07:51:46 INFO - 'other-e10s': {'tests': ['a11yr', 07:51:46 INFO - 'ts_paint', 07:51:46 INFO - 'tpaint', 07:51:46 INFO - 'sessionrestore', 07:51:46 INFO - 'sessionrestore_no_auto_restore', 07:51:46 INFO - 'tabpaint']}, 07:51:46 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:51:46 INFO - 'ts_paint', 07:51:46 INFO - 'tpaint', 07:51:46 INFO - 'sessionrestore', 07:51:46 INFO - 'sessionrestore_no_auto_restore', 07:51:46 INFO - 'tabpaint']}, 07:51:46 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:51:46 INFO - 'ts_paint', 07:51:46 INFO - 'tpaint', 07:51:46 INFO - 'sessionrestore', 07:51:46 INFO - 'sessionrestore_no_auto_restore', 07:51:46 INFO - 'tabpaint']}, 07:51:46 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:51:46 INFO - 'tests': ['a11yr', 07:51:46 INFO - 'ts_paint', 07:51:46 INFO - 'tpaint', 07:51:46 INFO - 'sessionrestore', 07:51:46 INFO - 'sessionrestore_no_auto_restore', 07:51:46 INFO - 'tabpaint']}, 07:51:46 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:51:46 INFO - 'tests': ['a11yr', 07:51:46 INFO - 'ts_paint', 07:51:46 INFO - 'tpaint', 07:51:46 INFO - 'sessionrestore', 07:51:46 INFO - 'sessionrestore_no_auto_restore', 07:51:46 INFO - 'tabpaint']}, 07:51:46 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:51:46 INFO - 'tests': ['tsvgx', 07:51:46 INFO - 'tsvgr_opacity', 07:51:46 INFO - 'tart', 07:51:46 INFO - 'tscrollx', 07:51:46 INFO - 'cart']}, 07:51:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:51:46 INFO - 'tsvgr_opacity', 07:51:46 INFO - 'tart', 07:51:46 INFO - 'tscrollx', 07:51:46 INFO - 'cart']}, 07:51:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:51:46 INFO - 'talos_options': ['--disable-e10s'], 07:51:46 INFO - 'tests': ['tp5o']}, 07:51:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:51:46 INFO - 'tests': ['tp5o']}, 07:51:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:51:46 INFO - 'talos_options': ['--disable-e10s', 07:51:46 INFO - '--xperf_path', 07:51:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:51:46 INFO - 'tests': ['tp5n']}, 07:51:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:51:46 INFO - 'talos_options': ['--xperf_path', 07:51:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:51:46 INFO - 'tests': ['tp5n']}}, 07:51:46 INFO - 'talos.zip': {'path': '', 07:51:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:51:46 INFO - Running post-action listener: _resource_record_post_action 07:51:46 INFO - ##### 07:51:46 INFO - ##### Running create-virtualenv step. 07:51:46 INFO - ##### 07:51:46 INFO - Running pre-action listener: _resource_record_pre_action 07:51:46 INFO - Running main action method: create_virtualenv 07:51:46 INFO - Creating virtualenv /builds/slave/test/build/venv 07:51:46 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:51:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:51:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:51:46 INFO - Using real prefix '/usr' 07:51:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:51:46 INFO - Installing distribute.............................................................................................................................................................................................done. 07:51:48 INFO - Installing pip.................done. 07:51:48 INFO - Return code: 0 07:51:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:51: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:51:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:51:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:51: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:51:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:51:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:51:48 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 0x7f7ed7308f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d535a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1de2410>, '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 0x1de3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1de37a0>, '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': '6dbc10da6d83fee962c624be000001a8-1464445622.817643-482957209', '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:51:48 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:51:48 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:51:48 INFO - Using env: {'DISPLAY': ':0', 07:51:48 INFO - 'HOME': '/home/cltbld', 07:51:48 INFO - 'LANG': 'en_US.UTF-8', 07:51:48 INFO - 'LANGUAGE': 'en_US:en', 07:51:48 INFO - 'LOGNAME': 'cltbld', 07:51:48 INFO - 'MAIL': '/var/mail/cltbld', 07:51:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:51:48 INFO - 'MOZ_NO_REMOTE': '1', 07:51:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:51:48 INFO - 'NO_EM_RESTART': '1', 07:51:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:51:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:51:48 INFO - 'PWD': '/builds/slave/test', 07:51:48 INFO - 'SHELL': '/bin/bash', 07:51:48 INFO - 'SHLVL': '1', 07:51:48 INFO - 'TERM': 'linux', 07:51:48 INFO - 'TMOUT': '86400', 07:51:48 INFO - 'USER': 'cltbld', 07:51:48 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1464445622.817643-482957209', 07:51:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:51:48 INFO - '_': '/tools/buildbot/bin/python'} 07:51:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:51:48 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:51:48 INFO - Cleaning up... 07:51:48 INFO - Return code: 0 07:51:48 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 07:51: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:51:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:51:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:51: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:51:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:51:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:51:48 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 0x7f7ed7308f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d535a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1de2410>, '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 0x1de3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1de37a0>, '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': '6dbc10da6d83fee962c624be000001a8-1464445622.817643-482957209', '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:51:48 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:51:48 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:51:48 INFO - Using env: {'DISPLAY': ':0', 07:51:48 INFO - 'HOME': '/home/cltbld', 07:51:48 INFO - 'LANG': 'en_US.UTF-8', 07:51:48 INFO - 'LANGUAGE': 'en_US:en', 07:51:48 INFO - 'LOGNAME': 'cltbld', 07:51:48 INFO - 'MAIL': '/var/mail/cltbld', 07:51:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:51:48 INFO - 'MOZ_NO_REMOTE': '1', 07:51:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:51:48 INFO - 'NO_EM_RESTART': '1', 07:51:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:51:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:51:48 INFO - 'PWD': '/builds/slave/test', 07:51:48 INFO - 'SHELL': '/bin/bash', 07:51:48 INFO - 'SHLVL': '1', 07:51:48 INFO - 'TERM': 'linux', 07:51:48 INFO - 'TMOUT': '86400', 07:51:48 INFO - 'USER': 'cltbld', 07:51:48 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1464445622.817643-482957209', 07:51:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:51:48 INFO - '_': '/tools/buildbot/bin/python'} 07:51:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:51:49 INFO - Downloading/unpacking psutil>=0.7.1 07:51:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:51:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:51:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:51:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:51:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:51:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:51:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:51:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:51:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:51:51 INFO - Installing collected packages: psutil 07:51:51 INFO - Running setup.py install for psutil 07:51:51 INFO - building 'psutil._psutil_linux' extension 07:51:51 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:51:51 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:51:51 INFO - building 'psutil._psutil_posix' extension 07:51:51 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:51:51 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:51:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:51:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:51:51 INFO - Successfully installed psutil 07:51:51 INFO - Cleaning up... 07:51:51 INFO - Return code: 0 07:51:51 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 07:51:51 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:51:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:51:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:51:51 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:51:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:51:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:51:51 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 0x7f7ed7308f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d535a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1de2410>, '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 0x1de3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1de37a0>, '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': '6dbc10da6d83fee962c624be000001a8-1464445622.817643-482957209', '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:51:51 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:51:51 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:51:51 INFO - Using env: {'DISPLAY': ':0', 07:51:51 INFO - 'HOME': '/home/cltbld', 07:51:51 INFO - 'LANG': 'en_US.UTF-8', 07:51:51 INFO - 'LANGUAGE': 'en_US:en', 07:51:51 INFO - 'LOGNAME': 'cltbld', 07:51:51 INFO - 'MAIL': '/var/mail/cltbld', 07:51:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:51:51 INFO - 'MOZ_NO_REMOTE': '1', 07:51:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:51:51 INFO - 'NO_EM_RESTART': '1', 07:51:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:51:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:51:51 INFO - 'PWD': '/builds/slave/test', 07:51:51 INFO - 'SHELL': '/bin/bash', 07:51:51 INFO - 'SHLVL': '1', 07:51:51 INFO - 'TERM': 'linux', 07:51:51 INFO - 'TMOUT': '86400', 07:51:51 INFO - 'USER': 'cltbld', 07:51:51 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1464445622.817643-482957209', 07:51:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:51:51 INFO - '_': '/tools/buildbot/bin/python'} 07:51:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:51:51 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:51:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:51:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:51:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:51:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:51:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:51:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:51:53 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:51:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:51:53 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:51:53 INFO - Installing collected packages: mozsystemmonitor 07:51:53 INFO - Running setup.py install for mozsystemmonitor 07:51:53 INFO - Successfully installed mozsystemmonitor 07:51:53 INFO - Cleaning up... 07:51:53 INFO - Return code: 0 07:51:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:51:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:51:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:51:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:51:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:51:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:51:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:51:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f7ed7308f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d535a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1de2410>, '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 0x1de3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1de37a0>, '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': '6dbc10da6d83fee962c624be000001a8-1464445622.817643-482957209', '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:51:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:51:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:51:53 INFO - Using env: {'DISPLAY': ':0', 07:51:53 INFO - 'HOME': '/home/cltbld', 07:51:53 INFO - 'LANG': 'en_US.UTF-8', 07:51:53 INFO - 'LANGUAGE': 'en_US:en', 07:51:53 INFO - 'LOGNAME': 'cltbld', 07:51:53 INFO - 'MAIL': '/var/mail/cltbld', 07:51:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:51:53 INFO - 'MOZ_NO_REMOTE': '1', 07:51:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:51:53 INFO - 'NO_EM_RESTART': '1', 07:51:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:51:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:51:53 INFO - 'PWD': '/builds/slave/test', 07:51:53 INFO - 'SHELL': '/bin/bash', 07:51:53 INFO - 'SHLVL': '1', 07:51:53 INFO - 'TERM': 'linux', 07:51:53 INFO - 'TMOUT': '86400', 07:51:53 INFO - 'USER': 'cltbld', 07:51:53 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1464445622.817643-482957209', 07:51:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:51:53 INFO - '_': '/tools/buildbot/bin/python'} 07:51:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:51:54 INFO - Downloading/unpacking blobuploader==1.2.4 07:51: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:51: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:51: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:51: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:51: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:51: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:51:55 INFO - Downloading blobuploader-1.2.4.tar.gz 07:51:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:51:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:51:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:51:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:51:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:51:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:51:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:51:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:51:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:51:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:51:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:51:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:51:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:51:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:51:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:51:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:51:56 INFO - Downloading docopt-0.6.1.tar.gz 07:51:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:51:56 INFO - Installing collected packages: blobuploader, requests, docopt 07:51:56 INFO - Running setup.py install for blobuploader 07:51:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:51:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:51:56 INFO - Running setup.py install for requests 07:51:57 INFO - Running setup.py install for docopt 07:51:57 INFO - Successfully installed blobuploader requests docopt 07:51:57 INFO - Cleaning up... 07:51:57 INFO - Return code: 0 07:51:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:51: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:51:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:51:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:51: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:51:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:51:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:51:57 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 0x7f7ed7308f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d535a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1de2410>, '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 0x1de3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1de37a0>, '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': '6dbc10da6d83fee962c624be000001a8-1464445622.817643-482957209', '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:51:57 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:51:57 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:51:57 INFO - Using env: {'DISPLAY': ':0', 07:51:57 INFO - 'HOME': '/home/cltbld', 07:51:57 INFO - 'LANG': 'en_US.UTF-8', 07:51:57 INFO - 'LANGUAGE': 'en_US:en', 07:51:57 INFO - 'LOGNAME': 'cltbld', 07:51:57 INFO - 'MAIL': '/var/mail/cltbld', 07:51:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:51:57 INFO - 'MOZ_NO_REMOTE': '1', 07:51:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:51:57 INFO - 'NO_EM_RESTART': '1', 07:51:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:51:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:51:57 INFO - 'PWD': '/builds/slave/test', 07:51:57 INFO - 'SHELL': '/bin/bash', 07:51:57 INFO - 'SHLVL': '1', 07:51:57 INFO - 'TERM': 'linux', 07:51:57 INFO - 'TMOUT': '86400', 07:51:57 INFO - 'USER': 'cltbld', 07:51:57 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1464445622.817643-482957209', 07:51:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:51:57 INFO - '_': '/tools/buildbot/bin/python'} 07:51:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:51:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:51:57 INFO - Running setup.py (path:/tmp/pip-sYqceA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:51:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:51:57 INFO - Running setup.py (path:/tmp/pip-AIFe5Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:51:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:51:57 INFO - Running setup.py (path:/tmp/pip-19jgy_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:51:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:51:57 INFO - Running setup.py (path:/tmp/pip-lFSbvi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:51:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:51:57 INFO - Running setup.py (path:/tmp/pip-V9gt2k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:51:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:51:57 INFO - Running setup.py (path:/tmp/pip-Jnhrou-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:51:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:51:57 INFO - Running setup.py (path:/tmp/pip-PLn9HJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:51:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:51:58 INFO - Running setup.py (path:/tmp/pip-sdSHV3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:51:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:51:58 INFO - Running setup.py (path:/tmp/pip-KskGT5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:51:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:51:58 INFO - Running setup.py (path:/tmp/pip-QmKos3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:51:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:51:58 INFO - Running setup.py (path:/tmp/pip-fIXlTF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:51:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:51:58 INFO - Running setup.py (path:/tmp/pip-kl4EWr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:51:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:51:58 INFO - Running setup.py (path:/tmp/pip-yGChr9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:51:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:51:58 INFO - Running setup.py (path:/tmp/pip-m2lcd_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:51:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:51:58 INFO - Running setup.py (path:/tmp/pip-kRfklO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:51:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:51:58 INFO - Running setup.py (path:/tmp/pip-Kn_kdx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:51:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:51:58 INFO - Running setup.py (path:/tmp/pip-AMn6V0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:51:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:51:58 INFO - Running setup.py install for manifestparser 07:51:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:51:58 INFO - Running setup.py install for mozcrash 07:51:58 INFO - Running setup.py install for mozdebug 07:51:59 INFO - Running setup.py install for mozdevice 07:51:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:51:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:51:59 INFO - Running setup.py install for mozfile 07:51:59 INFO - Running setup.py install for mozhttpd 07:51:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:51:59 INFO - Running setup.py install for mozinfo 07:51:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:51:59 INFO - Running setup.py install for mozInstall 07:51:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:51:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:51:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:51:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:51:59 INFO - Running setup.py install for mozleak 07:51:59 INFO - Running setup.py install for mozlog 07:51:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:51:59 INFO - Running setup.py install for moznetwork 07:51:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:51:59 INFO - Running setup.py install for mozprocess 07:51:59 INFO - Running setup.py install for mozprofile 07:52:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:52:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:52:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:52:00 INFO - Running setup.py install for mozrunner 07:52:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:52:00 INFO - Running setup.py install for mozscreenshot 07:52:00 INFO - Running setup.py install for moztest 07:52:00 INFO - Running setup.py install for mozversion 07:52:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:52:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:52:00 INFO - Cleaning up... 07:52:00 INFO - Return code: 0 07:52:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:52:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:52:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:52:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:52:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:52:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:00 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 0x7f7ed7308f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d535a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1de2410>, '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 0x1de3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1de37a0>, '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': '6dbc10da6d83fee962c624be000001a8-1464445622.817643-482957209', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:52:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:52:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:52:00 INFO - Using env: {'DISPLAY': ':0', 07:52:00 INFO - 'HOME': '/home/cltbld', 07:52:00 INFO - 'LANG': 'en_US.UTF-8', 07:52:00 INFO - 'LANGUAGE': 'en_US:en', 07:52:00 INFO - 'LOGNAME': 'cltbld', 07:52:00 INFO - 'MAIL': '/var/mail/cltbld', 07:52:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:52:00 INFO - 'MOZ_NO_REMOTE': '1', 07:52:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:52:00 INFO - 'NO_EM_RESTART': '1', 07:52:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:52:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:52:00 INFO - 'PWD': '/builds/slave/test', 07:52:00 INFO - 'SHELL': '/bin/bash', 07:52:00 INFO - 'SHLVL': '1', 07:52:00 INFO - 'TERM': 'linux', 07:52:00 INFO - 'TMOUT': '86400', 07:52:00 INFO - 'USER': 'cltbld', 07:52:00 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1464445622.817643-482957209', 07:52:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:52:00 INFO - '_': '/tools/buildbot/bin/python'} 07:52:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:52:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:52:00 INFO - Running setup.py (path:/tmp/pip-HgbZr2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:52:00 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 07:52:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:52:00 INFO - Running setup.py (path:/tmp/pip-9mD2fO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:52:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:52:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:52:00 INFO - Running setup.py (path:/tmp/pip-HlLjXV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:52:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:52:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:52:00 INFO - Running setup.py (path:/tmp/pip-vr8yEU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:52:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:52:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:52:01 INFO - Running setup.py (path:/tmp/pip-8I1XEl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:52:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 07:52:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:52:01 INFO - Running setup.py (path:/tmp/pip-4ZlXxf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:52:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 07:52:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:52:01 INFO - Running setup.py (path:/tmp/pip-VRMTVH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:52:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 07:52:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:52:01 INFO - Running setup.py (path:/tmp/pip-UycfT8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:52:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 07:52:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:52:01 INFO - Running setup.py (path:/tmp/pip-AHejds-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:52:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 07:52:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:52:01 INFO - Running setup.py (path:/tmp/pip-XOqYcu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:52:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:52:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:52:01 INFO - Running setup.py (path:/tmp/pip-LPJJnx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:52:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 07:52:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:52:01 INFO - Running setup.py (path:/tmp/pip-JBQ9dQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:52:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:52:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:52:01 INFO - Running setup.py (path:/tmp/pip-ew20qm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:52:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 07:52:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:52:01 INFO - Running setup.py (path:/tmp/pip-4mZBQD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:52:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:52:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:52:01 INFO - Running setup.py (path:/tmp/pip-YkDXu1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:52:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 07:52:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:52:01 INFO - Running setup.py (path:/tmp/pip-B1eNMP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:52:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 07:52:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:52:01 INFO - Running setup.py (path:/tmp/pip-W470gF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:52:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 07:52:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:52:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:52:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:52:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:52:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:52:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:52: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:52: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:52: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:52: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:52: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:52: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:52:03 INFO - Downloading blessings-1.6.tar.gz 07:52:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:52:03 INFO - Installing collected packages: blessings 07:52:03 INFO - Running setup.py install for blessings 07:52:04 INFO - Successfully installed blessings 07:52:04 INFO - Cleaning up... 07:52:04 INFO - Return code: 0 07:52:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:52:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:52:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:52:04 INFO - Reading from file tmpfile_stdout 07:52:04 INFO - Current package versions: 07:52:04 INFO - argparse == 1.2.1 07:52:04 INFO - blessings == 1.6 07:52:04 INFO - blobuploader == 1.2.4 07:52:04 INFO - docopt == 0.6.1 07:52:04 INFO - manifestparser == 1.1 07:52:04 INFO - mozInstall == 1.12 07:52:04 INFO - mozcrash == 0.17 07:52:04 INFO - mozdebug == 0.1 07:52:04 INFO - mozdevice == 0.48 07:52:04 INFO - mozfile == 1.2 07:52:04 INFO - mozhttpd == 0.7 07:52:04 INFO - mozinfo == 0.9 07:52:04 INFO - mozleak == 0.1 07:52:04 INFO - mozlog == 3.1 07:52:04 INFO - moznetwork == 0.27 07:52:04 INFO - mozprocess == 0.22 07:52:04 INFO - mozprofile == 0.28 07:52:04 INFO - mozrunner == 6.11 07:52:04 INFO - mozscreenshot == 0.1 07:52:04 INFO - mozsystemmonitor == 0.0 07:52:04 INFO - moztest == 0.7 07:52:04 INFO - mozversion == 1.4 07:52:04 INFO - psutil == 3.1.1 07:52:04 INFO - requests == 1.2.3 07:52:04 INFO - wsgiref == 0.1.2 07:52:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:52:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:52:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:52:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:52:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:52:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:04 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 0x7f7ed7308f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d535a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1de2410>, '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 0x1de3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1de37a0>, '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': '6dbc10da6d83fee962c624be000001a8-1464445622.817643-482957209', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:52:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 07:52:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:52:04 INFO - Using env: {'DISPLAY': ':0', 07:52:04 INFO - 'HOME': '/home/cltbld', 07:52:04 INFO - 'LANG': 'en_US.UTF-8', 07:52:04 INFO - 'LANGUAGE': 'en_US:en', 07:52:04 INFO - 'LOGNAME': 'cltbld', 07:52:04 INFO - 'MAIL': '/var/mail/cltbld', 07:52:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:52:04 INFO - 'MOZ_NO_REMOTE': '1', 07:52:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:52:04 INFO - 'NO_EM_RESTART': '1', 07:52:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:52:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:52:04 INFO - 'PWD': '/builds/slave/test', 07:52:04 INFO - 'SHELL': '/bin/bash', 07:52:04 INFO - 'SHLVL': '1', 07:52:04 INFO - 'TERM': 'linux', 07:52:04 INFO - 'TMOUT': '86400', 07:52:04 INFO - 'USER': 'cltbld', 07:52:04 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1464445622.817643-482957209', 07:52:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:52:04 INFO - '_': '/tools/buildbot/bin/python'} 07:52:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:52:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:52:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 07:52:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 07:52:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:52:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 07:52:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 07:52:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 07:52:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 07:52:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 07:52:04 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:52:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:52:04 INFO - Cleaning up... 07:52:04 INFO - Return code: 0 07:52:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:52:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:52:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:52:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:52:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:52:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7ed7308f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d535a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1de2410>, '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 0x1de3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1de37a0>, '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': '6dbc10da6d83fee962c624be000001a8-1464445622.817643-482957209', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:52:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:52:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:52:04 INFO - Using env: {'DISPLAY': ':0', 07:52:04 INFO - 'HOME': '/home/cltbld', 07:52:04 INFO - 'LANG': 'en_US.UTF-8', 07:52:04 INFO - 'LANGUAGE': 'en_US:en', 07:52:04 INFO - 'LOGNAME': 'cltbld', 07:52:04 INFO - 'MAIL': '/var/mail/cltbld', 07:52:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:52:04 INFO - 'MOZ_NO_REMOTE': '1', 07:52:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:52:04 INFO - 'NO_EM_RESTART': '1', 07:52:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:52:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:52:04 INFO - 'PWD': '/builds/slave/test', 07:52:04 INFO - 'SHELL': '/bin/bash', 07:52:04 INFO - 'SHLVL': '1', 07:52:04 INFO - 'TERM': 'linux', 07:52:04 INFO - 'TMOUT': '86400', 07:52:04 INFO - 'USER': 'cltbld', 07:52:04 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1464445622.817643-482957209', 07:52:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:52:04 INFO - '_': '/tools/buildbot/bin/python'} 07:52:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:52:04 INFO - Downloading/unpacking jsonschema 07:52:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:52:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:52:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:52:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:52:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:52:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:52:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:52:06 INFO - Downloading/unpacking functools32 (from jsonschema) 07:52:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:52:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:52:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:52:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:52:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:52:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:52:06 INFO - Downloading functools32-3.2.3-2.tar.gz 07:52:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:52:06 INFO - warning: no files found matching '*.txt' 07:52:06 INFO - no previously-included directories found matching 'build' 07:52:06 INFO - no previously-included directories found matching 'dist' 07:52:06 INFO - no previously-included directories found matching '.git*' 07:52:06 INFO - Installing collected packages: jsonschema, functools32 07:52:07 INFO - Running setup.py install for functools32 07:52:07 INFO - warning: no files found matching '*.txt' 07:52:07 INFO - no previously-included directories found matching 'build' 07:52:07 INFO - no previously-included directories found matching 'dist' 07:52:07 INFO - no previously-included directories found matching '.git*' 07:52:07 INFO - Successfully installed jsonschema functools32 07:52:07 INFO - Cleaning up... 07:52:07 INFO - Return code: 0 07:52:07 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:52:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:52:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:52:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:52:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:52:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:07 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 0x7f7ed7308f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d535a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1de2410>, '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 0x1de3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1de37a0>, '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': '6dbc10da6d83fee962c624be000001a8-1464445622.817643-482957209', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:52:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 07:52:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 07:52:07 INFO - Using env: {'DISPLAY': ':0', 07:52:07 INFO - 'HOME': '/home/cltbld', 07:52:07 INFO - 'LANG': 'en_US.UTF-8', 07:52:07 INFO - 'LANGUAGE': 'en_US:en', 07:52:07 INFO - 'LOGNAME': 'cltbld', 07:52:07 INFO - 'MAIL': '/var/mail/cltbld', 07:52:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:52:07 INFO - 'MOZ_NO_REMOTE': '1', 07:52:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:52:07 INFO - 'NO_EM_RESTART': '1', 07:52:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:52:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:52:07 INFO - 'PWD': '/builds/slave/test', 07:52:07 INFO - 'SHELL': '/bin/bash', 07:52:07 INFO - 'SHLVL': '1', 07:52:07 INFO - 'TERM': 'linux', 07:52:07 INFO - 'TMOUT': '86400', 07:52:07 INFO - 'USER': 'cltbld', 07:52:07 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1464445622.817643-482957209', 07:52:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:52:07 INFO - '_': '/tools/buildbot/bin/python'} 07:52:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:52:07 INFO - Downloading/unpacking flake8 07:52: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:52: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:52: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:52: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:52: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:52: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:52:09 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:52:09 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:52:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:52:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:52:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:52:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:52:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:52:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:52:09 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:52:09 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:52:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:52:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:52:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:52:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:52:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:52:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:52:09 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:52:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:52:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:52:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:52:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:52:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:52:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:52:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:52:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:52:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:52:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:52:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:52:09 INFO - no previously-included directories found matching 'docs/_build' 07:52:09 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:52:10 INFO - Running setup.py install for pep8 07:52:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:52:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:52:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:52:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:52:10 INFO - no previously-included directories found matching 'docs/_build' 07:52:10 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:52:10 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:52:10 INFO - Cleaning up... 07:52:10 INFO - Return code: 0 07:52:10 INFO - Running post-action listener: _resource_record_post_action 07:52:10 INFO - Running post-action listener: _start_resource_monitoring 07:52:10 INFO - Starting resource monitoring. 07:52:10 INFO - ##### 07:52:10 INFO - ##### Running install step. 07:52:10 INFO - ##### 07:52:10 INFO - Running pre-action listener: _resource_record_pre_action 07:52:10 INFO - Running main action method: install 07:52:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:52:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:52:10 INFO - Reading from file tmpfile_stdout 07:52:10 INFO - Detecting whether we're running mozinstall >=1.0... 07:52:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:52:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:52:10 INFO - Reading from file tmpfile_stdout 07:52:10 INFO - Output received: 07:52:10 INFO - Usage: mozinstall [options] installer 07:52:10 INFO - Options: 07:52:10 INFO - -h, --help show this help message and exit 07:52:10 INFO - -d DEST, --destination=DEST 07:52:10 INFO - Directory to install application into. [default: 07:52:10 INFO - "/builds/slave/test"] 07:52:10 INFO - --app=APP Application being installed. [default: firefox] 07:52:10 INFO - mkdir: /builds/slave/test/build/application 07:52:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 07:52:10 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:52:26 INFO - Reading from file tmpfile_stdout 07:52:26 INFO - Output received: 07:52:26 INFO - /builds/slave/test/build/application/firefox/firefox 07:52:26 INFO - Running post-action listener: _resource_record_post_action 07:52:26 INFO - ##### 07:52:26 INFO - ##### Running run-tests step. 07:52:26 INFO - ##### 07:52:26 INFO - Running pre-action listener: _resource_record_pre_action 07:52:26 INFO - Running main action method: run_tests 07:52:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:52:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:52:26 INFO - Python 2.7.3 07:52:26 INFO - Return code: 0 07:52:26 INFO - grabbing minidump binary from tooltool 07:52:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:52:26 INFO - 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 0x1de2410>, '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 0x1de3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1de37a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:52:26 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:52:26 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:52:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:52:26 INFO - Return code: 0 07:52:26 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:52:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:52:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:52:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:52:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:52:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:52:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:52:27 INFO - Return code: 0 07:52:27 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/dgqWuW-xToS7oa47Vy7qQw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--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:52:27 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/dgqWuW-xToS7oa47Vy7qQw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-050 --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:52:27 INFO - Using env: {'DISPLAY': ':0', 07:52:27 INFO - 'HOME': '/home/cltbld', 07:52:27 INFO - 'LANG': 'en_US.UTF-8', 07:52:27 INFO - 'LANGUAGE': 'en_US:en', 07:52:27 INFO - 'LOGNAME': 'cltbld', 07:52:27 INFO - 'MAIL': '/var/mail/cltbld', 07:52:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:52:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:52:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:52:27 INFO - 'MOZ_NO_REMOTE': '1', 07:52:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:52:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:52:27 INFO - 'NO_EM_RESTART': '1', 07:52:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:52:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:52:27 INFO - 'PWD': '/builds/slave/test', 07:52:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:52:27 INFO - 'SHELL': '/bin/bash', 07:52:27 INFO - 'SHLVL': '1', 07:52:27 INFO - 'TERM': 'linux', 07:52:27 INFO - 'TMOUT': '86400', 07:52:27 INFO - 'USER': 'cltbld', 07:52:27 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1464445622.817643-482957209', 07:52:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:52:27 INFO - '_': '/tools/buildbot/bin/python'} 07:52:27 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/dgqWuW-xToS7oa47Vy7qQw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--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:52:27 INFO - mozversion application_buildid: 20160528051133 07:52:27 INFO - mozversion application_changeset: bfea62662298a8400d559abd40ec7d4d12fbd97d 07:52:27 INFO - mozversion application_display_name: FirefoxDeveloperEdition 07:52:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:52:27 INFO - mozversion application_name: Firefox 07:52:27 INFO - mozversion application_remotingname: firefox-dev 07:52:27 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:52:27 INFO - mozversion application_vendor: Mozilla 07:52:27 INFO - mozversion application_version: 48.0a2 07:52:27 INFO - mozversion platform_buildid: 20160528051133 07:52:27 INFO - mozversion platform_changeset: bfea62662298a8400d559abd40ec7d4d12fbd97d 07:52:27 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:52:27 INFO - mozversion platform_version: 48.0a2 07:52:27 INFO - using testdate: 1464447147 07:52:27 INFO - actual date: 1464447147 07:52:27 INFO - starting webserver on 'localhost:57145' 07:52:27 INFO - SUITE-START | Running 2 tests 07:52:27 INFO - TEST-START | dromaeo_css 07:52:27 INFO - operating with platform_type : linux_ 07:52:27 INFO - Initialising browser for dromaeo_css test... 07:52:27 INFO - TEST-INFO | started process 2964 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpt2pU81/profile http://localhost:57145/getInfo.html) 07:52:30 INFO - PROCESS | 2964 | 07:52:30 INFO - PROCESS | 2964 | (process:3041): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:52:31 INFO - PROCESS | 2964 | __metrics Screen width/height:1600/1200 07:52:31 INFO - PROCESS | 2964 | colorDepth:24 07:52:31 INFO - PROCESS | 2964 | Browser inner width/height: 1024/697 07:52:31 INFO - PROCESS | 2964 | __metrics 07:52:32 ERROR - PROCESS | 2964 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 07:52:33 INFO - TEST-INFO | 2964: exit 0 07:52:33 INFO - Browser initialized. 07:52:33 INFO - Running cycle 1/1 for dromaeo_css test... 07:52:33 INFO - TEST-INFO | started process 3092 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpt2pU81/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:52:34 INFO - PROCESS | 3092 | 07:52:34 INFO - PROCESS | 3092 | (process:3161): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:52:44 INFO - PROCESS | 3092 | RSS: Main: 152080384 07:52:44 INFO - PROCESS | 3092 | 07:53:34 INFO - PROCESS | 3092 | 1464447214466 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:55:41 INFO - PROCESS | 3092 | Cycle 1(1): loaded http://localhost:57145/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57145/tests/dromaeo/cssquery-ext.html) 07:55:42 INFO - PROCESS | 3092 | RSS: Main: 154947584 07:55:42 INFO - PROCESS | 3092 | 07:58:44 INFO - PROCESS | 3092 | Cycle 1(1): loaded http://localhost:57145/tests/dromaeo/cssquery-ext.html (next: http://localhost:57145/tests/dromaeo/cssquery-jquery.html) 07:58:45 INFO - PROCESS | 3092 | RSS: Main: 153473024 07:58:45 INFO - PROCESS | 3092 | 08:01:46 INFO - PROCESS | 3092 | Cycle 1(1): loaded http://localhost:57145/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57145/tests/dromaeo/cssquery-mootools.html) 08:01:47 INFO - PROCESS | 3092 | RSS: Main: 152801280 08:01:47 INFO - PROCESS | 3092 | 08:04:49 INFO - PROCESS | 3092 | Cycle 1(1): loaded http://localhost:57145/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57145/tests/dromaeo/cssquery-prototype.html) 08:04:49 INFO - PROCESS | 3092 | RSS: Main: 152760320 08:04:49 INFO - PROCESS | 3092 | 08:07:52 INFO - PROCESS | 3092 | Cycle 1(1): loaded http://localhost:57145/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57145/tests/dromaeo/cssquery-yui.html) 08:07:52 INFO - PROCESS | 3092 | RSS: Main: 153927680 08:07:52 INFO - PROCESS | 3092 | 08:10:54 INFO - PROCESS | 3092 | Cycle 1(1): loaded http://localhost:57145/tests/dromaeo/cssquery-yui.html (next: http://localhost:57145/tests/dromaeo/cssquery-dojo.html) 08:10:55 INFO - PROCESS | 3092 | RSS: Main: 155750400 08:10:55 INFO - PROCESS | 3092 | 08:10:55 INFO - PROCESS | 3092 | __start_tp_report 08:10:55 INFO - PROCESS | 3092 | _x_x_mozilla_page_load 08:10:55 INFO - PROCESS | 3092 | _x_x_mozilla_page_load_details 08:10:55 INFO - PROCESS | 3092 | |i|pagename|runs| 08:10:55 INFO - PROCESS | 3092 | |0;dojo.html;3275.2794385235247;3351.229217280026;3361.630220675727;3415.4706020566805;3422.1615704152487;5469.945300546993;5495.505404513593;5504.954058728838;5518.586106042043;5555.250041244426;5508.862278443041;5517.310336207974;5524.530414914737;5559.444055594438;5559.861003474905;5083.415407228161;5086.923696144551;5140.794368225266;5151.74241287936;5173.560247378978;4952.059108769322;5097.617678674114;5142.820001299955;5205.713685747282;5241.135212689902;4992.151334273182;5002.1496345621335;5058.822941197059;5143.639945203838;5166.044281807877;5066.290719299301;5094.439611642716;5108.565771909392;5110;5145.33110695611;4848.490908454632;5008.549230569266;5013.974930125326;5058.418281897592;5082.720450375228;5302.840914772563;5339.866503337409;5377.946220537784;5379.435159308256;5408.8377348679605;5782.479576838063;5801.9129713054335;5826.912596311059;5835.153902684129;5835.795747148872;5759.769609215627;5848.941510584925;5875.35371109182;5884;5897.115432685132;5452.4274951129955;5527.2538207341895;5528.281323427928;5536.640118392292;5560.443955604448;5898.439648233411;5918.496927761103;5922.940770592325;5945.375735547792;5959.404059594006;5640.069388550925;5752.568557358215;5759.740811663485;5763;5813.88372232553;5848.619839710405;5876.970615146897;5878.11828225761;5888.087346461305;5930.377310382348;5798;5810.680412577264;5827.650340979555;5830.7084645767545;5873.706314684248;5664.5751568631695;5774.913376299359;5816.302043754692;5857.326407463111;5858.414158584107;4507.391502147234;4508.120916421332;4518.593326600621;4521.231390663595;4533.795979180944;4052;4063.227986682521;4073.837046518165;4085.632293093636;4105.856295029719;5517.613767036269;5575.749091290902;5588.329400471888;5665.603407761417;5699.74351154199;5764.913526297109;5851.912221316684;5869.266341707286;5875.941240587625;5924.881502369928;5620;5665.206871038058;5666.716664166857;5695.971520142372;5697.373288938214;4957.256411538226;5056.9494305057215;5104.464031276662;5133.12736834739;5158.535731784157;6065.4541091302;6089.117078023662;6105.877882442326;6133.662648554283;6137.693115344215;5650.152477128299;5898.616589921641;5905;5908.172855800278;5932.822015339547;6063;6129.358790882775;6136.3046386708;6137.131844484677;6147.139400484025;5732.656040637575;5741.282339707536;5745.080787074048;5750.338711048283;5779.219805326227;5748.310202775694;5789.623674461315;5826.067829147316;5848.824535263949;5860.765569377348;5639.351474580311;5639.6334238274385;5645.548356131418;5668.291463567054;5677.602567820378;5558.805441809517;5627.21219029328;5628.099504079328;5658.915116273177;5662;5495.917561236664;5553.028220061554;5569.944300556943;5583.413741557078;5583.74873130702;5673.262475878109;5683.460071293221;5722.141678748221;5722.599418040697;5728.627639203439;5574.470425309752;5574.581906356958;5581.274434323512;5584.329880414214;5585.609007369608 08:10:55 INFO - PROCESS | 3092 | |1;ext.html;678.4809620640211;682.3654001778347;683.9555428897124;729.8431985303291;744.192551082076;39624.40563391548;40780;40783.18433631326;40866.591334086654;40930.181396372056;42909.35635965455;43733.12533749323;43787.56212437875;43815;43882;8827.029026807062;9040.050794666564;9042.728718138467;9045.819083618324;9058.682946096887;8764.43031202973;8866.069062748415;8930.062343453941;9136.543172841364;9151.267898568098;9145.908540914605;9171.312151588625;9175.587098580547;9219.07809219076;9223.492707901063;9044.32167587427;9089.68186113486;9097.09029097085;9097.363184577081;9164.954175229115;8954;8995.325350598665;9021.413608115452;9043.864342034874;9085.81828363429;44372;44797;44923.77538112321;44977.55022449799;45005.77497112526;3793.677537409296;3864.8981648218323;3976.284268831609;4125.97937010316;4391.945932976095;33873.15317117092;33963.660363396295;33983.15042123942;34001.659983400095;34029.14927126842;4458.308962110878;4563.977180114111;4648.558386953234;4688.132695451352;4694.507076756926;305386;305926;306045;306245.9999999978;306973;39343;40143;40221.59778402237;40385;60929.39070609326;39324.606753932094;40365.19269614591;40393.39409908854;40533.59466405298;40563.18873622511;16230.350785968665;16336.591585210464;16373.263203155886;16408.507744767678;16428.096454694867;14617.561473155822;14623.19572423527;14673.972821902578;14687.853121468863;14813.925930370278;8997.730068097968;9044.59808729648;9092.590833412512;9132.771680708036;9144.222741066951;3489.94765078524;3507.5440192774777;3549.378858699769;3562.412201986695;3589.587197472272;1094.2668412163869;1147.6098126636984;1158.6639874436487;1165.294996527106;1178.2281758876516;32797.3440531188;33109;33834.32331353359;34036.31927361439;34275.82862085674;1185.7687750888667;1197.7664355450604;1204.9337286449154;1214.4595654933469;1290.3548225887057;15824.92253429915;15887.682246355009;16068.598285042734;16298.266578004019;16438.424655137253;521604;529901;990356;1005162;1006375;65062.67468662626;66005.66997164984;66203;66395;66407;1518.506485392252;1554.8678362339328;1558.454540910695;1561.851624095709;1566.1542766905743;33372.33255334928;33516.162095947795;33880;34367.656323436444;34566.82716586401;55059.44940550703;55691.443085570245;55981.72009140091;56190.719046404505;56358.154627679796;453641;454177;454358;457327;457792;30760.692393075784;31517.842410787798;31599.526007110373;31709.5243571342;31911;50429.49570504395;50707.74646126746;51019.23471147862;51276.23085653793;52237.7388113057;40971.79514102411;41803.7909810449;42237.36643950405;42977.57022429736;43100.78449607732;43289.3506597395;43441.78279108584;44137;44315.33526997033;44706;44788.77605611951;44937;45234.0953180928;45884;45940;36770.26459470742;36807.63192368149;37206.81396593;37395.81302093472;37670;28967.420651586428;29142.56286155752;29487;29723.85138074296;29761.404771904006 08:10:55 INFO - PROCESS | 3092 | |2;jquery.html;430.44472630306893;432.1657622101628;432.7900968030503;441.6533021578061;443.6362183009931;18975.52561185971;19247.903760481197;19751.111199995998;21402.89298553509;21505.784942150574;18476.538086547844;19304.3243486478;19513.024348782576;19697.90151049243;19738.802611973875;5258.447862974381;5406.864828379303;5441;5446.537044351215;5465.562754979612;5366.731663416814;5379.112446446332;5409.161579955114;5714.342850572175;5938.168656388109;5910.88178236435;5930.080837470199;5941.316748573904;5953.70231488426;6008.03871380577;5737.512311453511;5866.560007999417;5906.26171728534;5919.437653422918;5926.229590153295;5881.852953676193;5896.882062358772;5898.41015898411;5901.527877769769;5904.793332233394;23938.28185154448;24296.392590185387;24898.1285655003;24982.1256256032;25041.749582504122;2382.60686986647;2482.515909397668;2482.8137889658346;2573.9871300643376;2933.3546619743624;10672.146228301717;10722.463876806129;10807.243492955497;10997;12294.692632684166;1963.803619638039;2063.5769667218333;2115.502856828644;2116.291042500764;2152.13914434226;80459.5977020117;83049.58475207645;83866.58066709689;84458.57770711169;86047.56976215141;11558.711032224093;11631.185816992729;11666.533338666528;11903.166778325607;12042.698932526582;16362.263698133374;16456.259468323955;16524.586885327964;16623.584410389594;16652.16739163037;7560.508566943241;8736.606852691517;8755.649774008969;8793.824123517494;8900.955495222483;8763.342749293828;8868.955655221811;8954.417962832395;8975.865362019575;9107.362484626145;5113.284140220372;5127.87180320495;5136.101182293084;5154.871128221825;5173.379194496684;2117.74587049555;2129.808317251424;2140.989295053515;2202.48241663209;2222.411061068818;1090.8963648453384;1099.3184225780067;1114.7658991611852;1115.701654591544;1140.1334985411147;19149.808501915082;19369.4189174325;19748.802511974696;19788.94984560978;19910.203591856454;1055.8363453664695;1062.0919114157439;1085.8099832529276;1117.6647005898199;1121.3720316622716;10858.945705271422;11414.201005929504;11445.828312575319;11476.4835582399;11534.94232528832;518429;534627;541179;553783;586342;97739.51130244303;98996;101013;101167;102423.4878825601;1031.185363562777;1055.0715370473933;1058.1111866032722;1059.4861492176287;1075.736444571085;17161.227744751268;17740.29038838432;18176.818231817513;18193.727094093334;19213.903930480257;42485.93785155396;42908.78545607252;43293.78353108215;43547.34678979754;44567;56827.71586142043;60139;60283;60552.69723651354;61125.38874611197;9271.814563708553;9342.15920567125;9459.952700236454;9475.830515217878;9661.275404344562;13328.333583320602;14072.366743496363;14196.29018549089;14224.359903804147;14352.712945741236;12142.150049496451;12373.195742276723;12385.93807030959;12455.439505222106;12721.173123746927;11765.941170294094;11947.820782688093;12086.697832553904;12349.32078735678;12569.308688022247;12683.492660293485;12800.103992720793;12902.612921612366;12975;13103.73792524125;9186.08139186076;9196.218321442751;9291.814163716823;9303.162715355651;9307.488088155216;12004.639860804189;12406.193597416139;12453.1905426147;12806.743865122831;12819.42312595954 08:10:55 INFO - PROCESS | 3092 | |3;mootools.html;1532.570880153557;1537.6770878115592;1680.7899012623423;1800.981990180098;1822.8815127016735;7493.063367079115;7993.5203887766775;8229.506229626226;8419.410641255115;8453.112423195567;7817.140114587405;7925.24710152536;8000.0799908010595;8045.436819422643;8046.476978996376;2353.541059493395;2411;2414.034386245507;2415.2271273192587;2418.9395265118337;2320.756320586331;2383.189715496731;2444.2056331692183;2447.7062752469637;2448.4490989527394;2300.5858945389823;2407.7712617301418;2421.140495124232;2441.5727247731666;2461.7415171406924;2397.184957114581;2419.8790060496904;2428.5021570577987;2438.5244877248942;2451.705795304557;2402.6756387887763;2411.8552886826847;2435.8294919355653;2443.1326878957893;2463.4457247119435;8397.790055248668;8439.831203375898;8441.620127094295;8515.276201522878;8520.360972926994;5158.92261616076;5237.188235823453;5245.501677340647;5279.023380674587;5296.3909150447425;3372.578427696538;3406.6423025582203;3443.070370999816;3449.534312867756;3458.654134586546;1152.0840931459427;1156.3004382348643;1175.306569124221;1192.994035029828;1196.7068068323317;11733.061355091657;11946.044316454663;11962.641120766391;12010.399480026052;12012.759744805055;4781.856544303677;4793.35554781914;4805.303231031551;4846.176150054499;4975.601951843843;10122.949385253174;10182.134518565857;10204.081632652948;10210.897891020995;10211.234157438073;5346.705931173823;5366.248725178478;5373.9731301343245;5412.729363531807;5424.755885985141;4240.554741752133;4707.176244157327;4756.714597124114;4764.809407623726;4945.901081978413;4096.139810639799;4124.819588911585;4227.598378154071;4238.449001629769;4248.192843359813;1334.9399277032558;1358.7961805729021;1373.4231622718482;1387.0429403711407;1387.320213095596;962.5668449197889;1068.4604274841156;1083.5990683447017;1087.2606627493221;1100.9394483303495;5947.226860508106;5986.4013598639785;6053.801634417201;6074.574779765374;6079.604825686316;493.69884370533947;500.1098045479053;505.105962446475;507.2695318741001;508.84480233529126;4118.094019315746;4147.149834283965;4152.563980781974;4190.42673244584;4264;9822.901770982342;10013.39919604826;10209.846852297222;10299.176065914859;10321.638742644122;10014.298999069995;10070.446125463024;10143.036411540892;10180.236482263712;10186.847197292047;7608.429367797437;7847.686092556234;7853.568053757098;7854.60726963661;8061.234182752629;5693.259876216065;5706.942930570641;5731.770729170787;5773.278340207474;5956.344802071682;8644.178803013703;8732.34507411934;8790.296776258012;8887.289016878505;9015.684451044182;9221.216196623362;9282.35023548345;9338.533073346169;9345.439273643604;9354.579043942902;7329.413646908341;7919.406044546567;7992.320652744349;8077.353811695168;8281.627326770431;8082.919170808216;8109.959450202711;8119.634616442392;8130.390220733587;8198.344132469269;7192.352688258082;7228.674709638184;7250.347468727839;7398.075240594926;7495.213002634645;7171.675463775958;7485.4385921055045;7504.512206706765;7536.623168841426;7571.242875712384;6800.387965083166;6916.51584389108;6917.13535808024;6989.405900498515;6990.790276291719;4967.428745694291;5009.574186194214;5059.241113832954;5082.263071854486;5140.254663073759;5096.872578185575;5123.820666276812;5154.5103215194495;5163.896722065462;5203.713795741271 08:10:55 INFO - PROCESS | 3092 | |4;prototype.html;357.11079412263456;364.6535790998551;365.65080348267406;368.30758174631706;368.6921420613787;6566.802995910119;6644.103046088777;6678.766243181483;6752.932470675298;6786.355296246848;6583.07836902834;6683.766068187614;6706.128203333572;6711.463082953364;6722.764703235375;5025.170846810281;5027.09512287788;5034.395872495305;5040.949590504103;5051.419086805009;5049.2678561608545;5049.939512702337;5052.823151189709;5057.59539236862;5059.266406371093;4994.1260279451135;5005.474425185358;5008.774605142778;5010.248462730583;5027.170516864713;4769.475357710649;4903.8774030649165;5019.146745053332;5020.246962955549;5022.82420115296;4238.067625122468;4252.659787217015;4253.3619957006385;4280.400743895826;4280.5719428057255;6248.125262463259;6286.9056964145575;6299.118123462719;6299.275583307933;6322.71547780351;5727.055035919068;5736.168255602956;5741.655500669932;5748.7125643717645;5756.02147634903;6926.826829329307;6942.791716248521;6952.652367381611;6959.826004349881;6960.269171736996;4537.160625284333;4710.222813235812;4728.716277023355;4760.904781904343;4764.952350476486;7193.856122877565;7195.100612423447;7215;7233.421326293884;7258.129024517039;4787.593054590398;4807.78364973577;4820.855374338776;4843.861692502259;4853.19922212838;4848.466668666444;4866.902661946741;4881.365422495053;4891.192953162688;4899.534544218293;5717.3996730342715;5725.341585717696;5726.856828579319;5756.1653560233535;5759.971200144057;6880.931190688129;7069.08101946754;7071.36357727807;7084.043654106629;7088.362047415757;1706.5562953632145;1714.9314027438763;1730.9826901730821;1733.0641453614908;1733.4886208568503;1091.4542728635681;1102.3385968419045;1102.7684186320803;1110.938898360598;1120.2046546951592;6696.823532352005;6799.674063557559;6801.693923773442;6842.55523390978;6845.965770171118;7173.784786456415;7215.278472152742;7220.92779072213;7232;7239.674214660353;6688.598684078971;6696.698648560827;6711.194656641234;6731.663416829237;6740.561863478858;3855.845766169378;3868.7485313454536;3935.4293627423863;3936.881893543198;3943.940840887389;7474.962625186839;7525.8118547036765;7550.924490755132;7558.697652093854;7559;7250.492465527363;7262.273772622695;7263.782086537412;7306.050213472215;7325.706971721178;7477;7512.6243687815395;7539.886901696479;7549.9245007549225;7559.3196612304055;7024.1571011478945;7199.604021778643;7211.495195336276;7229.421646268391;7229.963850180716;7089.574625522485;7093.113360829896;7093.432525398059;7100.964495177491;7121.82195445118;7446.664900079401;7461.365783908429;7504.099508059068;7511.399088072832;7517.2482751726575;4843.39457567804;4851.078295124056;4853.247746599282;4862.927056094232;4868.829590964299;6995.160580730345;7131.286871312827;7198.71205151788;7206.4234861209925;7214.494985350975;6895;6921.204061532988;6931.480138989697;6940.375366217065;6962.7214911405;6891.483138764713;6926.896096558455;6936.7225310987;6947.652617369213;6967.303269673195;6807.183138023469;6823.55646882951;6850.554713943578;6851.143607049119;6875.003124546813;6852.520323577502;6923.757668481579;6968.198657154289;7011.614361210182;7041;6766.86466270662;6916.204636466669;6983.7206511741;6988.79033628992;6992.895106573304 08:10:55 INFO - PROCESS | 3092 | |5;yui.html;812.8577498937692;836.6360633124591;871.1462766488845;927.6984979881538;954.6801821389834;16709.081000544964;17030.14849257537;17106.888052276594;17107.486775396726;17126.571835704115;15773.921130394361;15834.524964251063;15870.761938570931;15942.601434964103;15963;918.3342076994193;932.8973812880578;934.2479304160148;938.2540880000416;938.5401153434836;763.8090477380655;925.6297481007617;929.2798081486834;929.9023602521739;930.1721467893581;973.4305431322649;973.5132433783108;977.1596427072711;977.1596427072711;980.431349817108;964.6334392930677;969.064852417417;969.5491596407669;973.0464145137804;974.9463779492125;710.5878590417545;712.6045045000022;713.5255055388161;715.989260161098;718.1095441652366;14096.506622268274;14174.291285435687;14197.503087391995;14327.35526901292;14367.497137600238;13837.723245535133;14095.436182552685;14098.859011409857;14103.365348559339;14158.150510969375;11926.940365298118;12243.755124897452;12267.447964841604;12346.197497162746;12398.442070106777;4003.499562554681;4039.232545816315;4085.9182816343505;4127.947373419789;4183.205191013698;59232.40767592312;59347;61136;61510.69244653793;61732.38267617311;11100;11192.216544841784;11922.880771192176;12037.398130093461;12048.216865903689;20812.167513299602;21624.56750864974;21638.567228655655;21649.242276520246;21696.674549881765;8663.090375510606;8688.609012594323;8714.433561818461;8768.868466972874;8784.516851573226;4536.228841097021;4562.703424277478;4576.679632425698;4643.303504474356;4685.789139488731;3587.264610754789;3721.8511259549855;3755.4179102239195;3756.69946404287;3775.962240377561;695.3290075077574;699.433458898294;720.1574158234878;720.6540860387043;725.5719125715852;672.314239475732;689.2074114768056;744.0178963767883;797.2983774278714;811.0632219786156;9018.774530636787;9248.21390181842;9462.668806591737;9527.857082143773;9930.950345248371;631.4537924695105;772.304925566983;772.3589420780738;778.1051790441038;793.0047790023484;4229.555896630871;4402.339649052604;4548.1813273610405;4551.795169217393;4620.861374158781;65774.34225657777;66677;66924.6653766728;67240.32759672341;67798.66100669563;56419;57947;58203.70898145567;59162;59501.40498595045;51455;52333.215001775;52410;53665;54293.45706542963;8905.73282801517;9145.725628231165;9227.723168304961;9415.199708024895;9438.764030899283;38792.418113727756;39362.40956385714;39867.80066099651;40453.79773101116;41158.588414116675;50217.74891125667;51817.7409112952;52393.47606523886;52397.47602523926;53688.73155634197;12336;12472.251664900135;12563.93718031404;12674.366281686063;12839.935800320938;13180.406881690154;13193.80209296842;13228.074034817855;13356.265405402795;14104.929475352557;12122.575709850113;12615.81076283838;12693.365331733192;12743.10798244114;12894.613161605166;11336.263142895685;11585.189036767346;11656.475458604213;11718.648440546796;12089.637310880687;11285.661430157108;12924.741505170032;14199.858001420267;14241.572752817432;14266.572002839932;10538.473076346;10837.187210959368;11161.107111431229;11310.773784524099;11363.943180284046;10974.176936729937;11044.779104418027;11165.497552610315;11261.887381126084;11279.830802538132 08:10:55 INFO - PROCESS | 3092 | __end_tp_report 08:10:55 INFO - PROCESS | 3092 | __start_cc_report 08:10:55 INFO - PROCESS | 3092 | _x_x_mozilla_cycle_collect,326 08:10:55 INFO - PROCESS | 3092 | __end_cc_report 08:10:55 INFO - PROCESS | 3092 | __startTimestamp1464448255217__endTimestamp 08:10:55 INFO - PROCESS | 3092 | 08:10:55 INFO - PROCESS | 3092 | ------- Summary: start ------- 08:10:55 INFO - PROCESS | 3092 | Number of tests: 6 08:10:55 INFO - PROCESS | 3092 | 08:10:55 INFO - PROCESS | 3092 | [#0] dojo.html Cycles:165 Average:5459.56 Median:5639.35 stddev:572.41 (10.2%) stddev-sans-first:547.92 08:10:55 INFO - PROCESS | 3092 | Values: 3275.3 3351.2 3361.6 3415.5 3422.2 5469.9 5495.5 5505.0 5518.6 5555.3 5508.9 5517.3 5524.5 5559.4 5559.9 5083.4 5086.9 5140.8 5151.7 5173.6 4952.1 5097.6 5142.8 5205.7 5241.1 4992.2 5002.1 5058.8 5143.6 5166.0 5066.3 5094.4 5108.6 5110.0 5145.3 4848.5 5008.5 5014.0 5058.4 5082.7 5302.8 5339.9 5377.9 5379.4 5408.8 5782.5 5801.9 5826.9 5835.2 5835.8 5759.8 5848.9 5875.4 5884.0 5897.1 5452.4 5527.3 5528.3 5536.6 5560.4 5898.4 5918.5 5922.9 5945.4 5959.4 5640.1 5752.6 5759.7 5763.0 5813.9 5848.6 5877.0 5878.1 5888.1 5930.4 5798.0 5810.7 5827.7 5830.7 5873.7 5664.6 5774.9 5816.3 5857.3 5858.4 4507.4 4508.1 4518.6 4521.2 4533.8 4052.0 4063.2 4073.8 4085.6 4105.9 5517.6 5575.7 5588.3 5665.6 5699.7 5764.9 5851.9 5869.3 5875.9 5924.9 5620.0 5665.2 5666.7 5696.0 5697.4 4957.3 5056.9 5104.5 5133.1 5158.5 6065.5 6089.1 6105.9 6133.7 6137.7 5650.2 5898.6 5905.0 5908.2 5932.8 6063.0 6129.4 6136.3 6137.1 6147.1 5732.7 5741.3 5745.1 5750.3 5779.2 5748.3 5789.6 5826.1 5848.8 5860.8 5639.4 5639.6 5645.5 5668.3 5677.6 5558.8 5627.2 5628.1 5658.9 5662.0 5495.9 5553.0 5569.9 5583.4 5583.7 5673.3 5683.5 5722.1 5722.6 5728.6 5574.5 5574.6 5581.3 5584.3 5585.6 08:10:55 INFO - PROCESS | 3092 | 08:10:55 INFO - PROCESS | 3092 | [#1] ext.html Cycles:180 Average:66894.57 Median:22964.89 stddev:157179.88 (684.4%) stddev-sans-first:157542.18 08:10:55 INFO - PROCESS | 3092 | Values: 678.5 682.4 684.0 729.8 744.2 39624.4 40780.0 40783.2 40866.6 40930.2 42909.4 43733.1 43787.6 43815.0 43882.0 8827.0 9040.1 9042.7 9045.8 9058.7 8764.4 8866.1 8930.1 9136.5 9151.3 9145.9 9171.3 9175.6 9219.1 9223.5 9044.3 9089.7 9097.1 9097.4 9165.0 8954.0 8995.3 9021.4 9043.9 9085.8 44372.0 44797.0 44923.8 44977.6 45005.8 3793.7 3864.9 3976.3 4126.0 4391.9 33873.2 33963.7 33983.2 34001.7 34029.1 4458.3 4564.0 4648.6 4688.1 4694.5 305386.0 305926.0 306045.0 306246.0 306973.0 39343.0 40143.0 40221.6 40385.0 60929.4 39324.6 40365.2 40393.4 40533.6 40563.2 16230.4 16336.6 16373.3 16408.5 16428.1 14617.6 14623.2 14674.0 14687.9 14813.9 8997.7 9044.6 9092.6 9132.8 9144.2 3489.9 3507.5 3549.4 3562.4 3589.6 1094.3 1147.6 1158.7 1165.3 1178.2 32797.3 33109.0 33834.3 34036.3 34275.8 1185.8 1197.8 1204.9 1214.5 1290.4 15824.9 15887.7 16068.6 16298.3 16438.4 521604.0 529901.0 990356.0 1005162.0 1006375.0 65062.7 66005.7 66203.0 66395.0 66407.0 1518.5 1554.9 1558.5 1561.9 1566.2 33372.3 33516.2 33880.0 34367.7 34566.8 55059.4 55691.4 55981.7 56190.7 56358.2 453641.0 454177.0 454358.0 457327.0 457792.0 30760.7 31517.8 31599.5 31709.5 31911.0 50429.5 50707.7 51019.2 51276.2 52237.7 40971.8 41803.8 42237.4 42977.6 43100.8 43289.4 43441.8 44137.0 44315.3 44706.0 44788.8 44937.0 45234.1 45884.0 45940.0 36770.3 36807.6 37206.8 37395.8 37670.0 28967.4 29142.6 29487.0 29723.9 29761.4 08:10:55 INFO - PROCESS | 3092 | 08:10:55 INFO - PROCESS | 3092 | [#2] jquery.html Cycles:180 Average:31414.88 Median:2177.31 stddev:90109.75 (4138.6%) stddev-sans-first:90332.49 08:10:55 INFO - PROCESS | 3092 | Values: 430.4 432.2 432.8 441.7 443.6 18975.5 19247.9 19751.1 21402.9 21505.8 18476.5 19304.3 19513.0 19697.9 19738.8 5258.4 5406.9 5441.0 5446.5 5465.6 5366.7 5379.1 5409.2 5714.3 5938.2 5910.9 5930.1 5941.3 5953.7 6008.0 5737.5 5866.6 5906.3 5919.4 5926.2 5881.9 5896.9 5898.4 5901.5 5904.8 23938.3 24296.4 24898.1 24982.1 25041.7 2382.6 2482.5 2482.8 2574.0 2933.4 10672.1 10722.5 10807.2 10997.0 12294.7 1963.8 2063.6 2115.5 2116.3 2152.1 80459.6 83049.6 83866.6 84458.6 86047.6 11558.7 11631.2 11666.5 11903.2 12042.7 16362.3 16456.3 16524.6 16623.6 16652.2 7560.5 8736.6 8755.6 8793.8 8901.0 8763.3 8869.0 8954.4 8975.9 9107.4 5113.3 5127.9 5136.1 5154.9 5173.4 2117.7 2129.8 2141.0 2202.5 2222.4 1090.9 1099.3 1114.8 1115.7 1140.1 19149.8 19369.4 19748.8 19788.9 19910.2 1055.8 1062.1 1085.8 1117.7 1121.4 10858.9 11414.2 11445.8 11476.5 11534.9 518429.0 534627.0 541179.0 553783.0 586342.0 97739.5 98996.0 101013.0 101167.0 102423.5 1031.2 1055.1 1058.1 1059.5 1075.7 17161.2 17740.3 18176.8 18193.7 19213.9 42485.9 42908.8 43293.8 43547.3 44567.0 56827.7 60139.0 60283.0 60552.7 61125.4 9271.8 9342.2 9460.0 9475.8 9661.3 13328.3 14072.4 14196.3 14224.4 14352.7 12142.2 12373.2 12385.9 12455.4 12721.2 11765.9 11947.8 12086.7 12349.3 12569.3 12683.5 12800.1 12902.6 12975.0 13103.7 9186.1 9196.2 9291.8 9303.2 9307.5 12004.6 12406.2 12453.2 12806.7 12819.4 08:10:55 INFO - PROCESS | 3092 | 08:10:55 INFO - PROCESS | 3092 | [#3] mootools.html Cycles:180 Average:5622.86 Median:2754.84 stddev:3049.82 (110.7%) stddev-sans-first:3042.88 08:10:55 INFO - PROCESS | 3092 | Values: 1532.6 1537.7 1680.8 1801.0 1822.9 7493.1 7993.5 8229.5 8419.4 8453.1 7817.1 7925.2 8000.1 8045.4 8046.5 2353.5 2411.0 2414.0 2415.2 2418.9 2320.8 2383.2 2444.2 2447.7 2448.4 2300.6 2407.8 2421.1 2441.6 2461.7 2397.2 2419.9 2428.5 2438.5 2451.7 2402.7 2411.9 2435.8 2443.1 2463.4 8397.8 8439.8 8441.6 8515.3 8520.4 5158.9 5237.2 5245.5 5279.0 5296.4 3372.6 3406.6 3443.1 3449.5 3458.7 1152.1 1156.3 1175.3 1193.0 1196.7 11733.1 11946.0 11962.6 12010.4 12012.8 4781.9 4793.4 4805.3 4846.2 4975.6 10122.9 10182.1 10204.1 10210.9 10211.2 5346.7 5366.2 5374.0 5412.7 5424.8 4240.6 4707.2 4756.7 4764.8 4945.9 4096.1 4124.8 4227.6 4238.4 4248.2 1334.9 1358.8 1373.4 1387.0 1387.3 962.6 1068.5 1083.6 1087.3 1100.9 5947.2 5986.4 6053.8 6074.6 6079.6 493.7 500.1 505.1 507.3 508.8 4118.1 4147.1 4152.6 4190.4 4264.0 9822.9 10013.4 10209.8 10299.2 10321.6 10014.3 10070.4 10143.0 10180.2 10186.8 7608.4 7847.7 7853.6 7854.6 8061.2 5693.3 5706.9 5731.8 5773.3 5956.3 8644.2 8732.3 8790.3 8887.3 9015.7 9221.2 9282.4 9338.5 9345.4 9354.6 7329.4 7919.4 7992.3 8077.4 8281.6 8082.9 8110.0 8119.6 8130.4 8198.3 7192.4 7228.7 7250.3 7398.1 7495.2 7171.7 7485.4 7504.5 7536.6 7571.2 6800.4 6916.5 6917.1 6989.4 6990.8 4967.4 5009.6 5059.2 5082.3 5140.3 5096.9 5123.8 5154.5 5163.9 5203.7 08:10:55 INFO - PROCESS | 3092 | 08:10:55 INFO - PROCESS | 3092 | [#4] prototype.html Cycles:180 Average:5821.98 Median:6717.11 stddev:1783.10 (26.5%) stddev-sans-first:1740.29 08:10:55 INFO - PROCESS | 3092 | Values: 357.1 364.7 365.7 368.3 368.7 6566.8 6644.1 6678.8 6752.9 6786.4 6583.1 6683.8 6706.1 6711.5 6722.8 5025.2 5027.1 5034.4 5040.9 5051.4 5049.3 5049.9 5052.8 5057.6 5059.3 4994.1 5005.5 5008.8 5010.2 5027.2 4769.5 4903.9 5019.1 5020.2 5022.8 4238.1 4252.7 4253.4 4280.4 4280.6 6248.1 6286.9 6299.1 6299.3 6322.7 5727.1 5736.2 5741.7 5748.7 5756.0 6926.8 6942.8 6952.7 6959.8 6960.3 4537.2 4710.2 4728.7 4760.9 4765.0 7193.9 7195.1 7215.0 7233.4 7258.1 4787.6 4807.8 4820.9 4843.9 4853.2 4848.5 4866.9 4881.4 4891.2 4899.5 5717.4 5725.3 5726.9 5756.2 5760.0 6880.9 7069.1 7071.4 7084.0 7088.4 1706.6 1714.9 1731.0 1733.1 1733.5 1091.5 1102.3 1102.8 1110.9 1120.2 6696.8 6799.7 6801.7 6842.6 6846.0 7173.8 7215.3 7220.9 7232.0 7239.7 6688.6 6696.7 6711.2 6731.7 6740.6 3855.8 3868.7 3935.4 3936.9 3943.9 7475.0 7525.8 7550.9 7558.7 7559.0 7250.5 7262.3 7263.8 7306.1 7325.7 7477.0 7512.6 7539.9 7549.9 7559.3 7024.2 7199.6 7211.5 7229.4 7230.0 7089.6 7093.1 7093.4 7101.0 7121.8 7446.7 7461.4 7504.1 7511.4 7517.2 4843.4 4851.1 4853.2 4862.9 4868.8 6995.2 7131.3 7198.7 7206.4 7214.5 6895.0 6921.2 6931.5 6940.4 6962.7 6891.5 6926.9 6936.7 6947.7 6967.3 6807.2 6823.6 6850.6 6851.1 6875.0 6852.5 6923.8 6968.2 7011.6 7041.0 6766.9 6916.2 6983.7 6988.8 6992.9 08:10:55 INFO - PROCESS | 3092 | 08:10:55 INFO - PROCESS | 3092 | [#5] yui.html Cycles:180 Average:15967.82 Median:4569.69 stddev:18717.92 (409.6%) stddev-sans-first:18735.83 08:10:55 INFO - PROCESS | 3092 | Values: 812.9 836.6 871.1 927.7 954.7 16709.1 17030.1 17106.9 17107.5 17126.6 15773.9 15834.5 15870.8 15942.6 15963.0 918.3 932.9 934.2 938.3 938.5 763.8 925.6 929.3 929.9 930.2 973.4 973.5 977.2 977.2 980.4 964.6 969.1 969.5 973.0 974.9 710.6 712.6 713.5 716.0 718.1 14096.5 14174.3 14197.5 14327.4 14367.5 13837.7 14095.4 14098.9 14103.4 14158.2 11926.9 12243.8 12267.4 12346.2 12398.4 4003.5 4039.2 4085.9 4127.9 4183.2 59232.4 59347.0 61136.0 61510.7 61732.4 11100.0 11192.2 11922.9 12037.4 12048.2 20812.2 21624.6 21638.6 21649.2 21696.7 8663.1 8688.6 8714.4 8768.9 8784.5 4536.2 4562.7 4576.7 4643.3 4685.8 3587.3 3721.9 3755.4 3756.7 3776.0 695.3 699.4 720.2 720.7 725.6 672.3 689.2 744.0 797.3 811.1 9018.8 9248.2 9462.7 9527.9 9931.0 631.5 772.3 772.4 778.1 793.0 4229.6 4402.3 4548.2 4551.8 4620.9 65774.3 66677.0 66924.7 67240.3 67798.7 56419.0 57947.0 58203.7 59162.0 59501.4 51455.0 52333.2 52410.0 53665.0 54293.5 8905.7 9145.7 9227.7 9415.2 9438.8 38792.4 39362.4 39867.8 40453.8 41158.6 50217.7 51817.7 52393.5 52397.5 53688.7 12336.0 12472.3 12563.9 12674.4 12839.9 13180.4 13193.8 13228.1 13356.3 14104.9 12122.6 12615.8 12693.4 12743.1 12894.6 11336.3 11585.2 11656.5 11718.6 12089.6 11285.7 12924.7 14199.9 14241.6 14266.6 10538.5 10837.2 11161.1 11310.8 11363.9 10974.2 11044.8 11165.5 11261.9 11279.8 08:10:55 INFO - PROCESS | 3092 | -------- Summary: end -------- 08:10:55 INFO - PROCESS | 3092 | 08:10:55 INFO - TEST-INFO | 3092: exit 0 08:10:55 INFO - TEST-OK | dromaeo_css | took 1108525ms 08:10:55 INFO - TEST-START | kraken 08:10:55 INFO - operating with platform_type : linux_ 08:10:55 INFO - Initialising browser for kraken test... 08:10:55 INFO - TEST-INFO | started process 3336 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfP6JsH/profile http://localhost:57145/getInfo.html) 08:10:59 INFO - PROCESS | 3336 | 08:10:59 INFO - PROCESS | 3336 | (process:3414): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:11:00 INFO - PROCESS | 3336 | __metrics Screen width/height:1600/1200 08:11:00 INFO - PROCESS | 3336 | colorDepth:24 08:11:00 INFO - PROCESS | 3336 | Browser inner width/height: 1024/697 08:11:00 INFO - PROCESS | 3336 | __metrics 08:11:00 ERROR - PROCESS | 3336 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 08:11:01 INFO - TEST-INFO | 3336: exit 0 08:11:01 INFO - Browser initialized. 08:11:01 INFO - Running cycle 1/1 for kraken test... 08:11:01 INFO - TEST-INFO | started process 3465 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfP6JsH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:11:03 INFO - PROCESS | 3465 | 08:11:03 INFO - PROCESS | 3465 | (process:3533): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:11:13 INFO - PROCESS | 3465 | RSS: Main: 152403968 08:11:13 INFO - PROCESS | 3465 | 08:11:15 INFO - PROCESS | 3465 | Cycle 1(1): loaded http://localhost:57145/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57145/tests/kraken/driver.html?testName=audio-beat-detection) 08:11:16 INFO - PROCESS | 3465 | RSS: Main: 157159424 08:11:16 INFO - PROCESS | 3465 | 08:11:19 INFO - PROCESS | 3465 | Cycle 1(1): loaded http://localhost:57145/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57145/tests/kraken/driver.html?testName=audio-dft) 08:11:19 INFO - PROCESS | 3465 | RSS: Main: 157937664 08:11:19 INFO - PROCESS | 3465 | 08:11:22 INFO - PROCESS | 3465 | Cycle 1(1): loaded http://localhost:57145/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57145/tests/kraken/driver.html?testName=audio-fft) 08:11:23 INFO - PROCESS | 3465 | RSS: Main: 157593600 08:11:23 INFO - PROCESS | 3465 | 08:11:25 INFO - PROCESS | 3465 | Cycle 1(1): loaded http://localhost:57145/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57145/tests/kraken/driver.html?testName=audio-oscillator) 08:11:25 INFO - PROCESS | 3465 | RSS: Main: 157499392 08:11:25 INFO - PROCESS | 3465 | 08:11:28 INFO - PROCESS | 3465 | Cycle 1(1): loaded http://localhost:57145/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57145/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:11:28 INFO - PROCESS | 3465 | RSS: Main: 157364224 08:11:28 INFO - PROCESS | 3465 | 08:11:31 INFO - PROCESS | 3465 | Cycle 1(1): loaded http://localhost:57145/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57145/tests/kraken/driver.html?testName=imaging-darkroom) 08:11:32 INFO - PROCESS | 3465 | RSS: Main: 157560832 08:11:32 INFO - PROCESS | 3465 | 08:11:35 INFO - PROCESS | 3465 | Cycle 1(1): loaded http://localhost:57145/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57145/tests/kraken/driver.html?testName=imaging-desaturate) 08:11:36 INFO - PROCESS | 3465 | RSS: Main: 157614080 08:11:36 INFO - PROCESS | 3465 | 08:11:39 INFO - PROCESS | 3465 | Cycle 1(1): loaded http://localhost:57145/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57145/tests/kraken/driver.html?testName=json-parse-financial) 08:11:39 INFO - PROCESS | 3465 | RSS: Main: 158289920 08:11:39 INFO - PROCESS | 3465 | 08:11:41 INFO - PROCESS | 3465 | Cycle 1(1): loaded http://localhost:57145/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57145/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:11:41 INFO - PROCESS | 3465 | RSS: Main: 158035968 08:11:41 INFO - PROCESS | 3465 | 08:11:43 INFO - PROCESS | 3465 | Cycle 1(1): loaded http://localhost:57145/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57145/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:11:44 INFO - PROCESS | 3465 | RSS: Main: 158228480 08:11:44 INFO - PROCESS | 3465 | 08:11:46 INFO - PROCESS | 3465 | Cycle 1(1): loaded http://localhost:57145/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57145/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:11:46 INFO - PROCESS | 3465 | RSS: Main: 158564352 08:11:46 INFO - PROCESS | 3465 | 08:11:49 INFO - PROCESS | 3465 | Cycle 1(1): loaded http://localhost:57145/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57145/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:11:49 INFO - PROCESS | 3465 | RSS: Main: 159305728 08:11:49 INFO - PROCESS | 3465 | 08:11:52 INFO - PROCESS | 3465 | Cycle 1(1): loaded http://localhost:57145/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57145/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:11:53 INFO - PROCESS | 3465 | RSS: Main: 158826496 08:11:53 INFO - PROCESS | 3465 | 08:11:54 INFO - PROCESS | 3465 | Cycle 1(1): loaded http://localhost:57145/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57145/tests/kraken/driver.html?testName=ai-astar) 08:11:55 INFO - PROCESS | 3465 | RSS: Main: 160395264 08:11:55 INFO - PROCESS | 3465 | 08:11:55 INFO - PROCESS | 3465 | __start_tp_report 08:11:55 INFO - PROCESS | 3465 | _x_x_mozilla_page_load 08:11:55 INFO - PROCESS | 3465 | _x_x_mozilla_page_load_details 08:11:55 INFO - PROCESS | 3465 | |i|pagename|runs| 08:11:55 INFO - PROCESS | 3465 | |0;ai-astar;109;113;104;110;111;112;101;110;111;113 08:11:55 INFO - PROCESS | 3465 | |1;audio-beat-detection;150;132;161;184;133;156;153;131;190;131 08:11:55 INFO - PROCESS | 3465 | |2;audio-dft;162;163;161;161;162;162;160;163;162;162 08:11:55 INFO - PROCESS | 3465 | |3;audio-fft;78;77;74;192;75;77;75;77;168;75 08:11:55 INFO - PROCESS | 3465 | |4;audio-oscillator;92;92;156;92;91;92;155;92;91;144 08:11:55 INFO - PROCESS | 3465 | |5;imaging-gaussian-blur;119;119;117;117;118;117;117;117;118;117 08:11:55 INFO - PROCESS | 3465 | |6;imaging-darkroom;146;146;146;146;146;146;147;146;147;145 08:11:55 INFO - PROCESS | 3465 | |7;imaging-desaturate;96;96;95;96;95;95;95;95;95;96 08:11:55 INFO - PROCESS | 3465 | |8;json-parse-financial;58;57;58;56;58;56;56;76;59;58 08:11:55 INFO - PROCESS | 3465 | |9;json-stringify-tinderbox;57;58;59;58;59;58;58;58;61;58 08:11:55 INFO - PROCESS | 3465 | |10;stanford-crypto-aes;73;74;73;72;75;75;74;75;74;75 08:11:55 INFO - PROCESS | 3465 | |11;stanford-crypto-ccm;126;114;119;118;115;112;124;120;130;134 08:11:55 INFO - PROCESS | 3465 | |12;stanford-crypto-pbkdf2;162;162;161;158;163;162;156;163;160;154 08:11:55 INFO - PROCESS | 3465 | |13;stanford-crypto-sha256-iterative;69;72;67;68;67;70;64;68;72;65 08:11:55 INFO - PROCESS | 3465 | __end_tp_report 08:11:55 INFO - PROCESS | 3465 | __start_cc_report 08:11:55 INFO - PROCESS | 3465 | _x_x_mozilla_cycle_collect,824 08:11:55 INFO - PROCESS | 3465 | __end_cc_report 08:11:55 INFO - PROCESS | 3465 | __startTimestamp1464448315207__endTimestamp 08:11:55 INFO - PROCESS | 3465 | 08:11:55 INFO - PROCESS | 3465 | ------- Summary: start ------- 08:11:55 INFO - PROCESS | 3465 | Number of tests: 14 08:11:55 INFO - PROCESS | 3465 | 08:11:55 INFO - PROCESS | 3465 | [#0] ai-astar Cycles:10 Average:109.40 Median:111.00 stddev:3.92 (3.5%) stddev-sans-first:4.16 08:11:55 INFO - PROCESS | 3465 | Values: 109.0 113.0 104.0 110.0 111.0 112.0 101.0 110.0 111.0 113.0 08:11:55 INFO - PROCESS | 3465 | 08:11:55 INFO - PROCESS | 3465 | [#1] audio-beat-detection Cycles:10 Average:152.10 Median:154.50 stddev:21.64 (14.0%) stddev-sans-first:22.93 08:11:55 INFO - PROCESS | 3465 | Values: 150.0 132.0 161.0 184.0 133.0 156.0 153.0 131.0 190.0 131.0 08:11:55 INFO - PROCESS | 3465 | 08:11:55 INFO - PROCESS | 3465 | [#2] audio-dft Cycles:10 Average:161.80 Median:162.00 stddev:0.92 (0.6%) stddev-sans-first:0.97 08:11:55 INFO - PROCESS | 3465 | Values: 162.0 163.0 161.0 161.0 162.0 162.0 160.0 163.0 162.0 162.0 08:11:55 INFO - PROCESS | 3465 | 08:11:55 INFO - PROCESS | 3465 | [#3] audio-fft Cycles:10 Average:96.80 Median:76.00 stddev:44.23 (58.2%) stddev-sans-first:46.39 08:11:55 INFO - PROCESS | 3465 | Values: 78.0 77.0 74.0 192.0 75.0 77.0 75.0 77.0 168.0 75.0 08:11:55 INFO - PROCESS | 3465 | 08:11:55 INFO - PROCESS | 3465 | [#4] audio-oscillator Cycles:10 Average:109.70 Median:92.00 stddev:29.13 (31.7%) stddev-sans-first:30.19 08:11:55 INFO - PROCESS | 3465 | Values: 92.0 92.0 156.0 92.0 91.0 92.0 155.0 92.0 91.0 144.0 08:11:55 INFO - PROCESS | 3465 | 08:11:55 INFO - PROCESS | 3465 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:117.50 stddev:0.84 (0.7%) stddev-sans-first:0.73 08:11:55 INFO - PROCESS | 3465 | Values: 119.0 119.0 117.0 117.0 118.0 117.0 117.0 117.0 118.0 117.0 08:11:55 INFO - PROCESS | 3465 | 08:11:55 INFO - PROCESS | 3465 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 08:11:55 INFO - PROCESS | 3465 | Values: 146.0 146.0 146.0 146.0 146.0 146.0 147.0 146.0 147.0 145.0 08:11:55 INFO - PROCESS | 3465 | 08:11:55 INFO - PROCESS | 3465 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 08:11:55 INFO - PROCESS | 3465 | Values: 96.0 96.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 96.0 08:11:55 INFO - PROCESS | 3465 | 08:11:55 INFO - PROCESS | 3465 | [#8] json-parse-financial Cycles:10 Average:59.20 Median:58.00 stddev:6.00 (10.3%) stddev-sans-first:6.34 08:11:55 INFO - PROCESS | 3465 | Values: 58.0 57.0 58.0 56.0 58.0 56.0 56.0 76.0 59.0 58.0 08:11:55 INFO - PROCESS | 3465 | 08:11:55 INFO - PROCESS | 3465 | [#9] json-stringify-tinderbox Cycles:10 Average:58.40 Median:58.00 stddev:1.07 (1.9%) stddev-sans-first:1.01 08:11:55 INFO - PROCESS | 3465 | Values: 57.0 58.0 59.0 58.0 59.0 58.0 58.0 58.0 61.0 58.0 08:11:55 INFO - PROCESS | 3465 | 08:11:55 INFO - PROCESS | 3465 | [#10] stanford-crypto-aes Cycles:10 Average:74.00 Median:74.50 stddev:1.05 (1.4%) stddev-sans-first:1.05 08:11:55 INFO - PROCESS | 3465 | Values: 73.0 74.0 73.0 72.0 75.0 75.0 74.0 75.0 74.0 75.0 08:11:55 INFO - PROCESS | 3465 | 08:11:55 INFO - PROCESS | 3465 | [#11] stanford-crypto-ccm Cycles:10 Average:121.20 Median:122.00 stddev:7.18 (5.9%) stddev-sans-first:7.40 08:11:55 INFO - PROCESS | 3465 | Values: 126.0 114.0 119.0 118.0 115.0 112.0 124.0 120.0 130.0 134.0 08:11:55 INFO - PROCESS | 3465 | 08:11:55 INFO - PROCESS | 3465 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.10 Median:162.00 stddev:3.11 (1.9%) stddev-sans-first:3.22 08:11:55 INFO - PROCESS | 3465 | Values: 162.0 162.0 161.0 158.0 163.0 162.0 156.0 163.0 160.0 154.0 08:11:55 INFO - PROCESS | 3465 | 08:11:55 INFO - PROCESS | 3465 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.20 Median:68.50 stddev:2.66 (3.9%) stddev-sans-first:2.80 08:11:55 INFO - PROCESS | 3465 | Values: 69.0 72.0 67.0 68.0 67.0 70.0 64.0 68.0 72.0 65.0 08:11:55 INFO - PROCESS | 3465 | -------- Summary: end -------- 08:11:55 INFO - PROCESS | 3465 | 08:11:55 INFO - TEST-INFO | 3465: exit 0 08:11:56 INFO - TEST-OK | kraken | took 60176ms 08:11:56 INFO - SUITE-END | took 1168s 08:11:56 INFO - Completed test suite (00:19:29) 08:11:56 INFO - javascript benchmark 08:11:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3275.2794385235247, 3351.229217280026, 3361.630220675727, 3415.4706020566805, 3422.1615704152487, 5469.945300546993, 5495.505404513593, 5504.954058728838, 5518.586106042043, 5555.250041244426, 5508.862278443041, 5517.310336207974, 5524.530414914737, 5559.444055594438, 5559.861003474905, 5083.415407228161, 5086.923696144551, 5140.794368225266, 5151.74241287936, 5173.560247378978, 4952.059108769322, 5097.617678674114, 5142.820001299955, 5205.713685747282, 5241.135212689902, 4992.151334273182, 5002.1496345621335, 5058.822941197059, 5143.639945203838, 5166.044281807877, 5066.290719299301, 5094.439611642716, 5108.565771909392, 5110.0, 5145.33110695611, 4848.490908454632, 5008.549230569266, 5013.974930125326, 5058.418281897592, 5082.720450375228, 5302.840914772563, 5339.866503337409, 5377.946220537784, 5379.435159308256, 5408.8377348679605, 5782.479576838063, 5801.9129713054335, 5826.912596311059, 5835.153902684129, 5835.795747148872, 5759.769609215627, 5848.941510584925, 5875.35371109182, 5884.0, 5897.115432685132, 5452.4274951129955, 5527.2538207341895, 5528.281323427928, 5536.640118392292, 5560.443955604448, 5898.439648233411, 5918.496927761103, 5922.940770592325, 5945.375735547792, 5959.404059594006, 5640.069388550925, 5752.568557358215, 5759.740811663485, 5763.0, 5813.88372232553, 5848.619839710405, 5876.970615146897, 5878.11828225761, 5888.087346461305, 5930.377310382348, 5798.0, 5810.680412577264, 5827.650340979555, 5830.7084645767545, 5873.706314684248, 5664.5751568631695, 5774.913376299359, 5816.302043754692, 5857.326407463111, 5858.414158584107, 4507.391502147234, 4508.120916421332, 4518.593326600621, 4521.231390663595, 4533.795979180944, 4052.0, 4063.227986682521, 4073.837046518165, 4085.632293093636, 4105.856295029719, 5517.613767036269, 5575.749091290902, 5588.329400471888, 5665.603407761417, 5699.74351154199, 5764.913526297109, 5851.912221316684, 5869.266341707286, 5875.941240587625, 5924.881502369928, 5620.0, 5665.206871038058, 5666.716664166857, 5695.971520142372, 5697.373288938214, 4957.256411538226, 5056.9494305057215, 5104.464031276662, 5133.12736834739, 5158.535731784157, 6065.4541091302, 6089.117078023662, 6105.877882442326, 6133.662648554283, 6137.693115344215, 5650.152477128299, 5898.616589921641, 5905.0, 5908.172855800278, 5932.822015339547, 6063.0, 6129.358790882775, 6136.3046386708, 6137.131844484677, 6147.139400484025, 5732.656040637575, 5741.282339707536, 5745.080787074048, 5750.338711048283, 5779.219805326227, 5748.310202775694, 5789.623674461315, 5826.067829147316, 5848.824535263949, 5860.765569377348, 5639.351474580311, 5639.6334238274385, 5645.548356131418, 5668.291463567054, 5677.602567820378, 5558.805441809517, 5627.21219029328, 5628.099504079328, 5658.915116273177, 5662.0, 5495.917561236664, 5553.028220061554, 5569.944300556943, 5583.413741557078, 5583.74873130702, 5673.262475878109, 5683.460071293221, 5722.141678748221, 5722.599418040697, 5728.627639203439, 5574.470425309752, 5574.581906356958, 5581.274434323512, 5584.329880414214, 5585.609007369608], "value": 5424.47734956504, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [678.4809620640211, 682.3654001778347, 683.9555428897124, 729.8431985303291, 744.192551082076, 39624.40563391548, 40780.0, 40783.18433631326, 40866.591334086654, 40930.181396372056, 42909.35635965455, 43733.12533749323, 43787.56212437875, 43815.0, 43882.0, 8827.029026807062, 9040.050794666564, 9042.728718138467, 9045.819083618324, 9058.682946096887, 8764.43031202973, 8866.069062748415, 8930.062343453941, 9136.543172841364, 9151.267898568098, 9145.908540914605, 9171.312151588625, 9175.587098580547, 9219.07809219076, 9223.492707901063, 9044.32167587427, 9089.68186113486, 9097.09029097085, 9097.363184577081, 9164.954175229115, 8954.0, 8995.325350598665, 9021.413608115452, 9043.864342034874, 9085.81828363429, 44372.0, 44797.0, 44923.77538112321, 44977.55022449799, 45005.77497112526, 3793.677537409296, 3864.8981648218323, 3976.284268831609, 4125.97937010316, 4391.945932976095, 33873.15317117092, 33963.660363396295, 33983.15042123942, 34001.659983400095, 34029.14927126842, 4458.308962110878, 4563.977180114111, 4648.558386953234, 4688.132695451352, 4694.507076756926, 305386.0, 305926.0, 306045.0, 306245.9999999978, 306973.0, 39343.0, 40143.0, 40221.59778402237, 40385.0, 60929.39070609326, 39324.606753932094, 40365.19269614591, 40393.39409908854, 40533.59466405298, 40563.18873622511, 16230.350785968665, 16336.591585210464, 16373.263203155886, 16408.507744767678, 16428.096454694867, 14617.561473155822, 14623.19572423527, 14673.972821902578, 14687.853121468863, 14813.925930370278, 8997.730068097968, 9044.59808729648, 9092.590833412512, 9132.771680708036, 9144.222741066951, 3489.94765078524, 3507.5440192774777, 3549.378858699769, 3562.412201986695, 3589.587197472272, 1094.2668412163869, 1147.6098126636984, 1158.6639874436487, 1165.294996527106, 1178.2281758876516, 32797.3440531188, 33109.0, 33834.32331353359, 34036.31927361439, 34275.82862085674, 1185.7687750888667, 1197.7664355450604, 1204.9337286449154, 1214.4595654933469, 1290.3548225887057, 15824.92253429915, 15887.682246355009, 16068.598285042734, 16298.266578004019, 16438.424655137253, 521604.0, 529901.0, 990356.0, 1005162.0, 1006375.0, 65062.67468662626, 66005.66997164984, 66203.0, 66395.0, 66407.0, 1518.506485392252, 1554.8678362339328, 1558.454540910695, 1561.851624095709, 1566.1542766905743, 33372.33255334928, 33516.162095947795, 33880.0, 34367.656323436444, 34566.82716586401, 55059.44940550703, 55691.443085570245, 55981.72009140091, 56190.719046404505, 56358.154627679796, 453641.0, 454177.0, 454358.0, 457327.0, 457792.0, 30760.692393075784, 31517.842410787798, 31599.526007110373, 31709.5243571342, 31911.0, 50429.49570504395, 50707.74646126746, 51019.23471147862, 51276.23085653793, 52237.7388113057, 40971.79514102411, 41803.7909810449, 42237.36643950405, 42977.57022429736, 43100.78449607732, 43289.3506597395, 43441.78279108584, 44137.0, 44315.33526997033, 44706.0, 44788.77605611951, 44937.0, 45234.0953180928, 45884.0, 45940.0, 36770.26459470742, 36807.63192368149, 37206.81396593, 37395.81302093472, 37670.0, 28967.420651586428, 29142.56286155752, 29487.0, 29723.85138074296, 29761.404771904006], "value": 20033.844338726303, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [430.44472630306893, 432.1657622101628, 432.7900968030503, 441.6533021578061, 443.6362183009931, 18975.52561185971, 19247.903760481197, 19751.111199995998, 21402.89298553509, 21505.784942150574, 18476.538086547844, 19304.3243486478, 19513.024348782576, 19697.90151049243, 19738.802611973875, 5258.447862974381, 5406.864828379303, 5441.0, 5446.537044351215, 5465.562754979612, 5366.731663416814, 5379.112446446332, 5409.161579955114, 5714.342850572175, 5938.168656388109, 5910.88178236435, 5930.080837470199, 5941.316748573904, 5953.70231488426, 6008.03871380577, 5737.512311453511, 5866.560007999417, 5906.26171728534, 5919.437653422918, 5926.229590153295, 5881.852953676193, 5896.882062358772, 5898.41015898411, 5901.527877769769, 5904.793332233394, 23938.28185154448, 24296.392590185387, 24898.1285655003, 24982.1256256032, 25041.749582504122, 2382.60686986647, 2482.515909397668, 2482.8137889658346, 2573.9871300643376, 2933.3546619743624, 10672.146228301717, 10722.463876806129, 10807.243492955497, 10997.0, 12294.692632684166, 1963.803619638039, 2063.5769667218333, 2115.502856828644, 2116.291042500764, 2152.13914434226, 80459.5977020117, 83049.58475207645, 83866.58066709689, 84458.57770711169, 86047.56976215141, 11558.711032224093, 11631.185816992729, 11666.533338666528, 11903.166778325607, 12042.698932526582, 16362.263698133374, 16456.259468323955, 16524.586885327964, 16623.584410389594, 16652.16739163037, 7560.508566943241, 8736.606852691517, 8755.649774008969, 8793.824123517494, 8900.955495222483, 8763.342749293828, 8868.955655221811, 8954.417962832395, 8975.865362019575, 9107.362484626145, 5113.284140220372, 5127.87180320495, 5136.101182293084, 5154.871128221825, 5173.379194496684, 2117.74587049555, 2129.808317251424, 2140.989295053515, 2202.48241663209, 2222.411061068818, 1090.8963648453384, 1099.3184225780067, 1114.7658991611852, 1115.701654591544, 1140.1334985411147, 19149.808501915082, 19369.4189174325, 19748.802511974696, 19788.94984560978, 19910.203591856454, 1055.8363453664695, 1062.0919114157439, 1085.8099832529276, 1117.6647005898199, 1121.3720316622716, 10858.945705271422, 11414.201005929504, 11445.828312575319, 11476.4835582399, 11534.94232528832, 518429.0, 534627.0, 541179.0, 553783.0, 586342.0, 97739.51130244303, 98996.0, 101013.0, 101167.0, 102423.4878825601, 1031.185363562777, 1055.0715370473933, 1058.1111866032722, 1059.4861492176287, 1075.736444571085, 17161.227744751268, 17740.29038838432, 18176.818231817513, 18193.727094093334, 19213.903930480257, 42485.93785155396, 42908.78545607252, 43293.78353108215, 43547.34678979754, 44567.0, 56827.71586142043, 60139.0, 60283.0, 60552.69723651354, 61125.38874611197, 9271.814563708553, 9342.15920567125, 9459.952700236454, 9475.830515217878, 9661.275404344562, 13328.333583320602, 14072.366743496363, 14196.29018549089, 14224.359903804147, 14352.712945741236, 12142.150049496451, 12373.195742276723, 12385.93807030959, 12455.439505222106, 12721.173123746927, 11765.941170294094, 11947.820782688093, 12086.697832553904, 12349.32078735678, 12569.308688022247, 12683.492660293485, 12800.103992720793, 12902.612921612366, 12975.0, 13103.73792524125, 9186.08139186076, 9196.218321442751, 9291.814163716823, 9303.162715355651, 9307.488088155216, 12004.639860804189, 12406.193597416139, 12453.1905426147, 12806.743865122831, 12819.42312595954], "value": 9790.060817387926, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1532.570880153557, 1537.6770878115592, 1680.7899012623423, 1800.981990180098, 1822.8815127016735, 7493.063367079115, 7993.5203887766775, 8229.506229626226, 8419.410641255115, 8453.112423195567, 7817.140114587405, 7925.24710152536, 8000.0799908010595, 8045.436819422643, 8046.476978996376, 2353.541059493395, 2411.0, 2414.034386245507, 2415.2271273192587, 2418.9395265118337, 2320.756320586331, 2383.189715496731, 2444.2056331692183, 2447.7062752469637, 2448.4490989527394, 2300.5858945389823, 2407.7712617301418, 2421.140495124232, 2441.5727247731666, 2461.7415171406924, 2397.184957114581, 2419.8790060496904, 2428.5021570577987, 2438.5244877248942, 2451.705795304557, 2402.6756387887763, 2411.8552886826847, 2435.8294919355653, 2443.1326878957893, 2463.4457247119435, 8397.790055248668, 8439.831203375898, 8441.620127094295, 8515.276201522878, 8520.360972926994, 5158.92261616076, 5237.188235823453, 5245.501677340647, 5279.023380674587, 5296.3909150447425, 3372.578427696538, 3406.6423025582203, 3443.070370999816, 3449.534312867756, 3458.654134586546, 1152.0840931459427, 1156.3004382348643, 1175.306569124221, 1192.994035029828, 1196.7068068323317, 11733.061355091657, 11946.044316454663, 11962.641120766391, 12010.399480026052, 12012.759744805055, 4781.856544303677, 4793.35554781914, 4805.303231031551, 4846.176150054499, 4975.601951843843, 10122.949385253174, 10182.134518565857, 10204.081632652948, 10210.897891020995, 10211.234157438073, 5346.705931173823, 5366.248725178478, 5373.9731301343245, 5412.729363531807, 5424.755885985141, 4240.554741752133, 4707.176244157327, 4756.714597124114, 4764.809407623726, 4945.901081978413, 4096.139810639799, 4124.819588911585, 4227.598378154071, 4238.449001629769, 4248.192843359813, 1334.9399277032558, 1358.7961805729021, 1373.4231622718482, 1387.0429403711407, 1387.320213095596, 962.5668449197889, 1068.4604274841156, 1083.5990683447017, 1087.2606627493221, 1100.9394483303495, 5947.226860508106, 5986.4013598639785, 6053.801634417201, 6074.574779765374, 6079.604825686316, 493.69884370533947, 500.1098045479053, 505.105962446475, 507.2695318741001, 508.84480233529126, 4118.094019315746, 4147.149834283965, 4152.563980781974, 4190.42673244584, 4264.0, 9822.901770982342, 10013.39919604826, 10209.846852297222, 10299.176065914859, 10321.638742644122, 10014.298999069995, 10070.446125463024, 10143.036411540892, 10180.236482263712, 10186.847197292047, 7608.429367797437, 7847.686092556234, 7853.568053757098, 7854.60726963661, 8061.234182752629, 5693.259876216065, 5706.942930570641, 5731.770729170787, 5773.278340207474, 5956.344802071682, 8644.178803013703, 8732.34507411934, 8790.296776258012, 8887.289016878505, 9015.684451044182, 9221.216196623362, 9282.35023548345, 9338.533073346169, 9345.439273643604, 9354.579043942902, 7329.413646908341, 7919.406044546567, 7992.320652744349, 8077.353811695168, 8281.627326770431, 8082.919170808216, 8109.959450202711, 8119.634616442392, 8130.390220733587, 8198.344132469269, 7192.352688258082, 7228.674709638184, 7250.347468727839, 7398.075240594926, 7495.213002634645, 7171.675463775958, 7485.4385921055045, 7504.512206706765, 7536.623168841426, 7571.242875712384, 6800.387965083166, 6916.51584389108, 6917.13535808024, 6989.405900498515, 6990.790276291719, 4967.428745694291, 5009.574186194214, 5059.241113832954, 5082.263071854486, 5140.254663073759, 5096.872578185575, 5123.820666276812, 5154.5103215194495, 5163.896722065462, 5203.713795741271], "value": 4536.426995143606, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [357.11079412263456, 364.6535790998551, 365.65080348267406, 368.30758174631706, 368.6921420613787, 6566.802995910119, 6644.103046088777, 6678.766243181483, 6752.932470675298, 6786.355296246848, 6583.07836902834, 6683.766068187614, 6706.128203333572, 6711.463082953364, 6722.764703235375, 5025.170846810281, 5027.09512287788, 5034.395872495305, 5040.949590504103, 5051.419086805009, 5049.2678561608545, 5049.939512702337, 5052.823151189709, 5057.59539236862, 5059.266406371093, 4994.1260279451135, 5005.474425185358, 5008.774605142778, 5010.248462730583, 5027.170516864713, 4769.475357710649, 4903.8774030649165, 5019.146745053332, 5020.246962955549, 5022.82420115296, 4238.067625122468, 4252.659787217015, 4253.3619957006385, 4280.400743895826, 4280.5719428057255, 6248.125262463259, 6286.9056964145575, 6299.118123462719, 6299.275583307933, 6322.71547780351, 5727.055035919068, 5736.168255602956, 5741.655500669932, 5748.7125643717645, 5756.02147634903, 6926.826829329307, 6942.791716248521, 6952.652367381611, 6959.826004349881, 6960.269171736996, 4537.160625284333, 4710.222813235812, 4728.716277023355, 4760.904781904343, 4764.952350476486, 7193.856122877565, 7195.100612423447, 7215.0, 7233.421326293884, 7258.129024517039, 4787.593054590398, 4807.78364973577, 4820.855374338776, 4843.861692502259, 4853.19922212838, 4848.466668666444, 4866.902661946741, 4881.365422495053, 4891.192953162688, 4899.534544218293, 5717.3996730342715, 5725.341585717696, 5726.856828579319, 5756.1653560233535, 5759.971200144057, 6880.931190688129, 7069.08101946754, 7071.36357727807, 7084.043654106629, 7088.362047415757, 1706.5562953632145, 1714.9314027438763, 1730.9826901730821, 1733.0641453614908, 1733.4886208568503, 1091.4542728635681, 1102.3385968419045, 1102.7684186320803, 1110.938898360598, 1120.2046546951592, 6696.823532352005, 6799.674063557559, 6801.693923773442, 6842.55523390978, 6845.965770171118, 7173.784786456415, 7215.278472152742, 7220.92779072213, 7232.0, 7239.674214660353, 6688.598684078971, 6696.698648560827, 6711.194656641234, 6731.663416829237, 6740.561863478858, 3855.845766169378, 3868.7485313454536, 3935.4293627423863, 3936.881893543198, 3943.940840887389, 7474.962625186839, 7525.8118547036765, 7550.924490755132, 7558.697652093854, 7559.0, 7250.492465527363, 7262.273772622695, 7263.782086537412, 7306.050213472215, 7325.706971721178, 7477.0, 7512.6243687815395, 7539.886901696479, 7549.9245007549225, 7559.3196612304055, 7024.1571011478945, 7199.604021778643, 7211.495195336276, 7229.421646268391, 7229.963850180716, 7089.574625522485, 7093.113360829896, 7093.432525398059, 7100.964495177491, 7121.82195445118, 7446.664900079401, 7461.365783908429, 7504.099508059068, 7511.399088072832, 7517.2482751726575, 4843.39457567804, 4851.078295124056, 4853.247746599282, 4862.927056094232, 4868.829590964299, 6995.160580730345, 7131.286871312827, 7198.71205151788, 7206.4234861209925, 7214.494985350975, 6895.0, 6921.204061532988, 6931.480138989697, 6940.375366217065, 6962.7214911405, 6891.483138764713, 6926.896096558455, 6936.7225310987, 6947.652617369213, 6967.303269673195, 6807.183138023469, 6823.55646882951, 6850.554713943578, 6851.143607049119, 6875.003124546813, 6852.520323577502, 6923.757668481579, 6968.198657154289, 7011.614361210182, 7041.0, 6766.86466270662, 6916.204636466669, 6983.7206511741, 6988.79033628992, 6992.895106573304], "value": 5234.205810624364, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [812.8577498937692, 836.6360633124591, 871.1462766488845, 927.6984979881538, 954.6801821389834, 16709.081000544964, 17030.14849257537, 17106.888052276594, 17107.486775396726, 17126.571835704115, 15773.921130394361, 15834.524964251063, 15870.761938570931, 15942.601434964103, 15963.0, 918.3342076994193, 932.8973812880578, 934.2479304160148, 938.2540880000416, 938.5401153434836, 763.8090477380655, 925.6297481007617, 929.2798081486834, 929.9023602521739, 930.1721467893581, 973.4305431322649, 973.5132433783108, 977.1596427072711, 977.1596427072711, 980.431349817108, 964.6334392930677, 969.064852417417, 969.5491596407669, 973.0464145137804, 974.9463779492125, 710.5878590417545, 712.6045045000022, 713.5255055388161, 715.989260161098, 718.1095441652366, 14096.506622268274, 14174.291285435687, 14197.503087391995, 14327.35526901292, 14367.497137600238, 13837.723245535133, 14095.436182552685, 14098.859011409857, 14103.365348559339, 14158.150510969375, 11926.940365298118, 12243.755124897452, 12267.447964841604, 12346.197497162746, 12398.442070106777, 4003.499562554681, 4039.232545816315, 4085.9182816343505, 4127.947373419789, 4183.205191013698, 59232.40767592312, 59347.0, 61136.0, 61510.69244653793, 61732.38267617311, 11100.0, 11192.216544841784, 11922.880771192176, 12037.398130093461, 12048.216865903689, 20812.167513299602, 21624.56750864974, 21638.567228655655, 21649.242276520246, 21696.674549881765, 8663.090375510606, 8688.609012594323, 8714.433561818461, 8768.868466972874, 8784.516851573226, 4536.228841097021, 4562.703424277478, 4576.679632425698, 4643.303504474356, 4685.789139488731, 3587.264610754789, 3721.8511259549855, 3755.4179102239195, 3756.69946404287, 3775.962240377561, 695.3290075077574, 699.433458898294, 720.1574158234878, 720.6540860387043, 725.5719125715852, 672.314239475732, 689.2074114768056, 744.0178963767883, 797.2983774278714, 811.0632219786156, 9018.774530636787, 9248.21390181842, 9462.668806591737, 9527.857082143773, 9930.950345248371, 631.4537924695105, 772.304925566983, 772.3589420780738, 778.1051790441038, 793.0047790023484, 4229.555896630871, 4402.339649052604, 4548.1813273610405, 4551.795169217393, 4620.861374158781, 65774.34225657777, 66677.0, 66924.6653766728, 67240.32759672341, 67798.66100669563, 56419.0, 57947.0, 58203.70898145567, 59162.0, 59501.40498595045, 51455.0, 52333.215001775, 52410.0, 53665.0, 54293.45706542963, 8905.73282801517, 9145.725628231165, 9227.723168304961, 9415.199708024895, 9438.764030899283, 38792.418113727756, 39362.40956385714, 39867.80066099651, 40453.79773101116, 41158.588414116675, 50217.74891125667, 51817.7409112952, 52393.47606523886, 52397.47602523926, 53688.73155634197, 12336.0, 12472.251664900135, 12563.93718031404, 12674.366281686063, 12839.935800320938, 13180.406881690154, 13193.80209296842, 13228.074034817855, 13356.265405402795, 14104.929475352557, 12122.575709850113, 12615.81076283838, 12693.365331733192, 12743.10798244114, 12894.613161605166, 11336.263142895685, 11585.189036767346, 11656.475458604213, 11718.648440546796, 12089.637310880687, 11285.661430157108, 12924.741505170032, 14199.858001420267, 14241.572752817432, 14266.572002839932, 10538.473076346, 10837.187210959368, 11161.107111431229, 11310.773784524099, 11363.943180284046, 10974.176936729937, 11044.779104418027, 11165.497552610315, 11261.887381126084, 11279.830802538132], "value": 7225.8044273765445, "unit": "score"}], "name": "dromaeo_css", "value": 7531.813779497058, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 113.0, 104.0, 110.0, 111.0, 112.0, 101.0, 110.0, 111.0, 113.0], "value": 109.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 132.0, 161.0, 184.0, 133.0, 156.0, 153.0, 131.0, 190.0, 131.0], "value": 152.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 161.0, 161.0, 162.0, 162.0, 160.0, 163.0, 162.0, 162.0], "value": 161.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 77.0, 74.0, 192.0, 75.0, 77.0, 75.0, 77.0, 168.0, 75.0], "value": 96.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 156.0, 92.0, 91.0, 92.0, 155.0, 92.0, 91.0, 144.0], "value": 109.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 119.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 118.0, 117.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 147.0, 145.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 57.0, 58.0, 56.0, 58.0, 56.0, 56.0, 76.0, 59.0, 58.0], "value": 59.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 58.0, 59.0, 58.0, 59.0, 58.0, 58.0, 58.0, 61.0, 58.0], "value": 58.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 73.0, 72.0, 75.0, 75.0, 74.0, 75.0, 74.0, 75.0], "value": 74.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 114.0, 119.0, 118.0, 115.0, 112.0, 124.0, 120.0, 130.0, 134.0], "value": 121.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 161.0, 158.0, 163.0, 162.0, 156.0, 163.0, 160.0, 154.0], "value": 160.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 72.0, 67.0, 68.0, 67.0, 70.0, 64.0, 68.0, 72.0, 65.0], "value": 68.2, "unit": "score"}], "name": "kraken", "value": 1530.0000000000002, "alertThreshold": 2.0}]} 08:11:56 INFO - Return code: 0 08:11:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 08:11:56 ERROR - # TBPL SUCCESS # 08:11:56 INFO - Running post-action listener: _resource_record_post_action 08:11:56 INFO - Running post-run listener: _resource_record_post_run 08:11:57 INFO - Total resource usage - Wall time: 1186s; CPU: 13.0%; Read bytes: 8192; Write bytes: 501784576; Read time: 188; Write time: 340608 08:11:57 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 4096; Write bytes: 248565760; Read time: 172; Write time: 203400 08:11:57 INFO - run-tests - Wall time: 1170s; CPU: 13.0%; Read bytes: 4096; Write bytes: 252620800; Read time: 16; Write time: 137208 08:11:57 INFO - Running post-run listener: _upload_blobber_files 08:11:57 INFO - Blob upload gear active. 08:11:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:11:57 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 08:11:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:11:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:11:58 INFO - (blobuploader) - INFO - Open directory for files ... 08:11:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:11:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:11:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:11:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:11:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:11:58 INFO - (blobuploader) - INFO - Done attempting. 08:11:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:11:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:11:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:12:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:12:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:12:00 INFO - (blobuploader) - INFO - Done attempting. 08:12:00 INFO - (blobuploader) - INFO - Iteration through files over. 08:12:00 INFO - Return code: 0 08:12:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:12:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:12:00 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/33324aa722669da982dfb5347f7b238903d502d507fefcddfff1d7d6bf369a5fab78e02115c925e2d0e1fc821b6d67e83c6fdd428bf281b407b7d17290ac0cdf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4abc621acdf86b2f9c3521b0c3aee24962546b3ebf9ec0bbe0f4a631e7932e7d7fe19543fd33846070b1e7aa5152fa1af598369cc819a88f4b7635c01477b00d"} 08:12:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:12:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:12:00 INFO - Contents: 08:12:00 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/33324aa722669da982dfb5347f7b238903d502d507fefcddfff1d7d6bf369a5fab78e02115c925e2d0e1fc821b6d67e83c6fdd428bf281b407b7d17290ac0cdf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4abc621acdf86b2f9c3521b0c3aee24962546b3ebf9ec0bbe0f4a631e7932e7d7fe19543fd33846070b1e7aa5152fa1af598369cc819a88f4b7635c01477b00d"} 08:12:00 INFO - Running post-run listener: copy_logs_to_upload_dir 08:12:00 INFO - Copying logs to upload dir... 08:12:00 INFO - mkdir: /builds/slave/test/build/upload/logs 08:12:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.826518 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-05-28 08:12:00.018336) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-28 08:12:00.022037) ========= 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=6dbc10da6d83fee962c624be000001a8-1464445622.817643-482957209 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/33324aa722669da982dfb5347f7b238903d502d507fefcddfff1d7d6bf369a5fab78e02115c925e2d0e1fc821b6d67e83c6fdd428bf281b407b7d17290ac0cdf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4abc621acdf86b2f9c3521b0c3aee24962546b3ebf9ec0bbe0f4a631e7932e7d7fe19543fd33846070b1e7aa5152fa1af598369cc819a88f4b7635c01477b00d"} build_url:https://queue.taskcluster.net/v1/task/dgqWuW-xToS7oa47Vy7qQw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011350 build_url: 'https://queue.taskcluster.net/v1/task/dgqWuW-xToS7oa47Vy7qQw/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/33324aa722669da982dfb5347f7b238903d502d507fefcddfff1d7d6bf369a5fab78e02115c925e2d0e1fc821b6d67e83c6fdd428bf281b407b7d17290ac0cdf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4abc621acdf86b2f9c3521b0c3aee24962546b3ebf9ec0bbe0f4a631e7932e7d7fe19543fd33846070b1e7aa5152fa1af598369cc819a88f4b7635c01477b00d"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-28 08:12:00.047213) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 08:12:00.047571) ========= 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=6dbc10da6d83fee962c624be000001a8-1464445622.817643-482957209 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004470 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 08:12:00.131039) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-28 08:12:00.131365) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-28 08:12:00.131688) ========= ========= Total master_lag: 0.17 =========