builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-026 starttime: 1461466245.6 results: success (0) buildid: 20160423181244 builduid: 3f130655a1f04869bfb0e5e1739c2feb revision: ab8a76ac7b34db20dd3c220c9846826334f3efdc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-23 19:50:45.597625) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-23 19:50:45.597976) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-23 19:50:45.598235) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-23 19:50:45.616248) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 19:50:45.616491) ========= 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=41bf3e9aed84707956354da8000001c5-1461462925.912122-2000355471 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-23 19:50:45-- 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% 104M=0s 2016-04-23 19:50:45 (104 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.122311 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 19:50:45.751989) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 19:50:45.752356) ========= 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=41bf3e9aed84707956354da8000001c5-1461462925.912122-2000355471 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018825 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 19:50:45.801397) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 19:50:45.801792) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev ab8a76ac7b34db20dd3c220c9846826334f3efdc --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev ab8a76ac7b34db20dd3c220c9846826334f3efdc --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=41bf3e9aed84707956354da8000001c5-1461462925.912122-2000355471 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-23 19:50:45,970 truncating revision to first 12 chars 2016-04-23 19:50:45,970 Setting DEBUG logging. 2016-04-23 19:50:45,970 attempt 1/10 2016-04-23 19:50:45,970 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/ab8a76ac7b34?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-23 19:50:46,423 unpacking tar archive at: mozilla-central-ab8a76ac7b34/testing/mozharness/ program finished with exit code 0 elapsedTime=0.737500 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 19:50:46.552103) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-23 19:50:46.552399) ========= script_repo_revision: ab8a76ac7b34db20dd3c220c9846826334f3efdc ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-23 19:50:46.552810) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-23 19:50:46.553151) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-23 19:50:46.561136) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-04-23 19:50:46.561493) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 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', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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=41bf3e9aed84707956354da8000001c5-1461462925.912122-2000355471 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:50:46 INFO - MultiFileLogger online at 20160423 19:50:46 in /builds/slave/test 19:50:46 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 19:50:46 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:50:46 INFO - {'append_to_log': False, 19:50:46 INFO - 'base_work_dir': '/builds/slave/test', 19:50:46 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 19:50:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:50:46 INFO - 'branch': 'Firefox-Non-PGO', 19:50:46 INFO - 'buildbot_json_path': 'buildprops.json', 19:50:46 INFO - 'config_files': ('talos/linux_config.py',), 19:50:46 INFO - 'default_actions': ('clobber', 19:50:46 INFO - 'read-buildbot-config', 19:50:46 INFO - 'download-and-extract', 19:50:46 INFO - 'populate-webroot', 19:50:46 INFO - 'create-virtualenv', 19:50:46 INFO - 'install', 19:50:46 INFO - 'run-tests'), 19:50:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:50:46 INFO - 'download_minidump_stackwalk': True, 19:50:46 INFO - 'download_symbols': 'ondemand', 19:50:46 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:50:46 INFO - 'tooltool.py': '/tools/tooltool.py', 19:50:46 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:50:46 INFO - '/tools/misc-python/virtualenv.py')}, 19:50:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:50:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:50:46 INFO - 'installer_path': 'installer.exe', 19:50:46 INFO - 'log_level': 'info', 19:50:46 INFO - 'log_name': 'talos', 19:50:46 INFO - 'log_to_console': True, 19:50:46 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:50:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:50:46 INFO - 'opt_config_files': (), 19:50:46 INFO - 'pip_index': False, 19:50:46 INFO - 'sps_profile': False, 19:50:46 INFO - 'sps_profile_interval': 0, 19:50:46 INFO - 'suite': 'dromaeojs-e10s', 19:50:46 INFO - 'system_bits': '32', 19:50:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:50:46 INFO - 'title': 'talos-linux64-ix-026', 19:50:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:50:46 INFO - 'use_talos_json': True, 19:50:46 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:50:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:50:46 INFO - 'work_dir': 'build'} 19:50:46 INFO - ##### 19:50:46 INFO - ##### Running clobber step. 19:50:46 INFO - ##### 19:50:46 INFO - Running pre-action listener: _resource_record_pre_action 19:50:46 INFO - Running main action method: clobber 19:50:46 INFO - rmtree: /builds/slave/test/build 19:50:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:50:47 INFO - Running post-action listener: _resource_record_post_action 19:50:47 INFO - ##### 19:50:47 INFO - ##### Running read-buildbot-config step. 19:50:47 INFO - ##### 19:50:47 INFO - Running pre-action listener: _resource_record_pre_action 19:50:47 INFO - Running main action method: read_buildbot_config 19:50:47 INFO - Using buildbot properties: 19:50:47 INFO - { 19:50:47 INFO - "project": "", 19:50:47 INFO - "product": "firefox", 19:50:47 INFO - "script_repo_revision": "production", 19:50:47 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 19:50:47 INFO - "repository": "", 19:50:47 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 19:50:47 INFO - "buildid": "20160423181244", 19:50:47 INFO - "pgo_build": "False", 19:50:47 INFO - "basedir": "/builds/slave/test", 19:50:47 INFO - "buildnumber": 36, 19:50:47 INFO - "slavename": "talos-linux64-ix-026", 19:50:47 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 19:50:47 INFO - "platform": "ubuntu64_hw", 19:50:47 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 19:50:47 INFO - "branch": "mozilla-central", 19:50:47 INFO - "repo_path": "mozilla-central", 19:50:47 INFO - "revision": "ab8a76ac7b34db20dd3c220c9846826334f3efdc", 19:50:47 INFO - "stage_platform": "linux64", 19:50:47 INFO - "builduid": "3f130655a1f04869bfb0e5e1739c2feb", 19:50:47 INFO - "slavebuilddir": "test" 19:50:47 INFO - } 19:50:47 INFO - Found installer url https://queue.taskcluster.net/v1/task/PkjyxxzxTE6x9odUV932Mw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 19:50:47 INFO - Running post-action listener: _resource_record_post_action 19:50:47 INFO - ##### 19:50:47 INFO - ##### Running download-and-extract step. 19:50:47 INFO - ##### 19:50:47 INFO - Running pre-action listener: _resource_record_pre_action 19:50:47 INFO - Running main action method: download_and_extract 19:50:47 INFO - mkdir: /builds/slave/test/build/tests 19:50:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:50:47 INFO - https://queue.taskcluster.net/v1/task/PkjyxxzxTE6x9odUV932Mw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 19:50:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PkjyxxzxTE6x9odUV932Mw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 19:50:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PkjyxxzxTE6x9odUV932Mw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 19:50:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PkjyxxzxTE6x9odUV932Mw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 19:50:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PkjyxxzxTE6x9odUV932Mw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 19:50:47 INFO - Downloaded 1361 bytes. 19:50:47 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 19:50:47 INFO - Using the following test package requirements: 19:50:47 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 19:50:47 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 19:50:47 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:50:47 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 19:50:47 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 19:50:47 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 19:50:47 INFO - u'jsshell-linux-x86_64.zip'], 19:50:47 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 19:50:47 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:50:47 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 19:50:47 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 19:50:47 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:50:47 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 19:50:47 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:50:47 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 19:50:47 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:50:47 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 19:50:47 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:50:47 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:50:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:50:47 INFO - https://queue.taskcluster.net/v1/task/PkjyxxzxTE6x9odUV932Mw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:50:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PkjyxxzxTE6x9odUV932Mw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 19:50:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PkjyxxzxTE6x9odUV932Mw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 19:50:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PkjyxxzxTE6x9odUV932Mw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 19:50:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PkjyxxzxTE6x9odUV932Mw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:50:57 INFO - Downloaded 22285370 bytes. 19:50:57 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:50:57 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 19:50:58 INFO - Return code: 0 19:50:58 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 19:50:58 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')]} 19:50:58 INFO - https://queue.taskcluster.net/v1/task/PkjyxxzxTE6x9odUV932Mw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:50:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PkjyxxzxTE6x9odUV932Mw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 19:50:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PkjyxxzxTE6x9odUV932Mw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 19:50:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PkjyxxzxTE6x9odUV932Mw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 19:50:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PkjyxxzxTE6x9odUV932Mw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:51:06 INFO - Downloaded 22285370 bytes. 19:51:06 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:51:06 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 19:51:07 INFO - Return code: 0 19:51: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')]} 19:51:07 INFO - https://queue.taskcluster.net/v1/task/PkjyxxzxTE6x9odUV932Mw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:51:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PkjyxxzxTE6x9odUV932Mw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 19:51:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PkjyxxzxTE6x9odUV932Mw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 19:51:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PkjyxxzxTE6x9odUV932Mw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 19:51:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PkjyxxzxTE6x9odUV932Mw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 19:51:09 INFO - Downloaded 10840145 bytes. 19:51:09 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:51:09 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 19:51:09 INFO - Return code: 0 19:51:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:51:09 INFO - https://queue.taskcluster.net/v1/task/PkjyxxzxTE6x9odUV932Mw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:51:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PkjyxxzxTE6x9odUV932Mw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 19:51:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PkjyxxzxTE6x9odUV932Mw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 19:51:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PkjyxxzxTE6x9odUV932Mw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 19:51:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PkjyxxzxTE6x9odUV932Mw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 19:51:10 INFO - Downloaded 54744618 bytes. 19:51:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PkjyxxzxTE6x9odUV932Mw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 19:51:10 INFO - mkdir: /builds/slave/test/properties 19:51:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:51:10 INFO - Writing to file /builds/slave/test/properties/build_url 19:51:10 INFO - Contents: 19:51:10 INFO - build_url:https://queue.taskcluster.net/v1/task/PkjyxxzxTE6x9odUV932Mw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 19:51:11 INFO - Running post-action listener: _resource_record_post_action 19:51:11 INFO - Running post-action listener: set_extra_try_arguments 19:51:11 INFO - ##### 19:51:11 INFO - ##### Running populate-webroot step. 19:51:11 INFO - ##### 19:51:11 INFO - Running pre-action listener: _resource_record_pre_action 19:51:11 INFO - Running main action method: populate_webroot 19:51:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:51:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:51:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:51:11 INFO - '--tppagecycles', 19:51:11 INFO - '7'], 19:51:11 INFO - 'tests': ['tsvgm']}}, 19:51:11 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:51:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:51:11 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:51:11 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:51:11 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:51:11 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:51:11 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:51:11 INFO - 'talos_options': ['--disable-e10s'], 19:51:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:51:11 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:51:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:51:11 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:51:11 INFO - 'talos_options': ['--disable-e10s'], 19:51:11 INFO - 'tests': ['damp', 'tps']}, 19:51:11 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:51:11 INFO - 'tests': ['damp', 'tps']}, 19:51:11 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:51:11 INFO - 'tests': ['dromaeo_dom']}, 19:51:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:51:11 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:51:11 INFO - 'tests': ['a11yr', 19:51:11 INFO - 'ts_paint', 19:51:11 INFO - 'tpaint', 19:51:11 INFO - 'sessionrestore', 19:51:11 INFO - 'sessionrestore_no_auto_restore', 19:51:11 INFO - 'tabpaint']}, 19:51:11 INFO - 'other-e10s': {'tests': ['a11yr', 19:51:11 INFO - 'ts_paint', 19:51:11 INFO - 'tpaint', 19:51:11 INFO - 'sessionrestore', 19:51:11 INFO - 'sessionrestore_no_auto_restore', 19:51:11 INFO - 'tabpaint']}, 19:51:11 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:51:11 INFO - 'ts_paint', 19:51:11 INFO - 'tpaint', 19:51:11 INFO - 'sessionrestore', 19:51:11 INFO - 'sessionrestore_no_auto_restore', 19:51:11 INFO - 'tabpaint']}, 19:51:11 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:51:11 INFO - 'ts_paint', 19:51:11 INFO - 'tpaint', 19:51:11 INFO - 'sessionrestore', 19:51:11 INFO - 'sessionrestore_no_auto_restore', 19:51:11 INFO - 'tabpaint']}, 19:51:11 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:51:11 INFO - 'tests': ['a11yr', 19:51:11 INFO - 'ts_paint', 19:51:11 INFO - 'tpaint', 19:51:11 INFO - 'sessionrestore', 19:51:11 INFO - 'sessionrestore_no_auto_restore', 19:51:11 INFO - 'tabpaint']}, 19:51:11 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:51:11 INFO - 'tests': ['a11yr', 19:51:11 INFO - 'ts_paint', 19:51:11 INFO - 'tpaint', 19:51:11 INFO - 'sessionrestore', 19:51:11 INFO - 'sessionrestore_no_auto_restore', 19:51:11 INFO - 'tabpaint']}, 19:51:11 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:51:11 INFO - 'tests': ['tsvgx', 19:51:11 INFO - 'tsvgr_opacity', 19:51:11 INFO - 'tart', 19:51:11 INFO - 'tscrollx', 19:51:11 INFO - 'cart']}, 19:51:11 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:51:11 INFO - 'tsvgr_opacity', 19:51:11 INFO - 'tart', 19:51:11 INFO - 'tscrollx', 19:51:11 INFO - 'cart']}, 19:51:11 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:51:11 INFO - 'talos_options': ['--disable-e10s'], 19:51:11 INFO - 'tests': ['tp5o']}, 19:51:11 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:51:11 INFO - 'tests': ['tp5o']}, 19:51:11 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:51:11 INFO - 'talos_options': ['--disable-e10s', 19:51:11 INFO - '--xperf_path', 19:51:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:51:11 INFO - 'tests': ['tp5n']}, 19:51:11 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:51:11 INFO - 'talos_options': ['--xperf_path', 19:51:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:51:11 INFO - 'tests': ['tp5n']}}, 19:51:11 INFO - 'talos.zip': {'path': '', 19:51:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:51:11 INFO - Running post-action listener: _resource_record_post_action 19:51:11 INFO - ##### 19:51:11 INFO - ##### Running create-virtualenv step. 19:51:11 INFO - ##### 19:51:11 INFO - Running pre-action listener: _resource_record_pre_action 19:51:11 INFO - Running main action method: create_virtualenv 19:51:11 INFO - Creating virtualenv /builds/slave/test/build/venv 19:51:11 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 19:51:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:51:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:51:11 INFO - Using real prefix '/usr' 19:51:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:51:11 INFO - Installing distribute.............................................................................................................................................................................................done. 19:51:13 INFO - Installing pip.................done. 19:51:13 INFO - Return code: 0 19:51:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:51:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:51:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:51:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:51:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:51:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:13 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 0x7f446324bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bc45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c53410>, '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 0x2c54310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c547a0>, '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': '41bf3e9aed84707956354da8000001c5-1461462925.912122-2000355471', '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 19:51:13 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 19:51:13 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 19:51:13 INFO - Using env: {'DISPLAY': ':0', 19:51:13 INFO - 'HOME': '/home/cltbld', 19:51:13 INFO - 'LANG': 'en_US.UTF-8', 19:51:13 INFO - 'LANGUAGE': 'en_US:en', 19:51:13 INFO - 'LOGNAME': 'cltbld', 19:51:13 INFO - 'MAIL': '/var/mail/cltbld', 19:51:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:51:13 INFO - 'MOZ_NO_REMOTE': '1', 19:51:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:51:13 INFO - 'NO_EM_RESTART': '1', 19:51:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:51:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:51:13 INFO - 'PWD': '/builds/slave/test', 19:51:13 INFO - 'SHELL': '/bin/bash', 19:51:13 INFO - 'SHLVL': '1', 19:51:13 INFO - 'TERM': 'linux', 19:51:13 INFO - 'TMOUT': '86400', 19:51:13 INFO - 'USER': 'cltbld', 19:51:13 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1461462925.912122-2000355471', 19:51:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:51:13 INFO - '_': '/tools/buildbot/bin/python'} 19:51:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:51:14 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 19:51:14 INFO - Cleaning up... 19:51:14 INFO - Return code: 0 19:51:14 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 19:51:14 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')]} 19:51:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:51:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:14 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')]} 19:51:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:51:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:14 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 0x7f446324bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bc45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c53410>, '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 0x2c54310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c547a0>, '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': '41bf3e9aed84707956354da8000001c5-1461462925.912122-2000355471', '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 19:51:14 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 19:51:14 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 19:51:14 INFO - Using env: {'DISPLAY': ':0', 19:51:14 INFO - 'HOME': '/home/cltbld', 19:51:14 INFO - 'LANG': 'en_US.UTF-8', 19:51:14 INFO - 'LANGUAGE': 'en_US:en', 19:51:14 INFO - 'LOGNAME': 'cltbld', 19:51:14 INFO - 'MAIL': '/var/mail/cltbld', 19:51:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:51:14 INFO - 'MOZ_NO_REMOTE': '1', 19:51:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:51:14 INFO - 'NO_EM_RESTART': '1', 19:51:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:51:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:51:14 INFO - 'PWD': '/builds/slave/test', 19:51:14 INFO - 'SHELL': '/bin/bash', 19:51:14 INFO - 'SHLVL': '1', 19:51:14 INFO - 'TERM': 'linux', 19:51:14 INFO - 'TMOUT': '86400', 19:51:14 INFO - 'USER': 'cltbld', 19:51:14 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1461462925.912122-2000355471', 19:51:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:51:14 INFO - '_': '/tools/buildbot/bin/python'} 19:51:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:51:14 INFO - Downloading/unpacking psutil>=0.7.1 19:51:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:51:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:51:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:51:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:51:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:51:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:51:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:51:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:51:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:51:16 INFO - Installing collected packages: psutil 19:51:16 INFO - Running setup.py install for psutil 19:51:16 INFO - building 'psutil._psutil_linux' extension 19:51:16 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 19:51:16 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 19:51:16 INFO - building 'psutil._psutil_posix' extension 19:51:16 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 19:51:16 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 19:51:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:51:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:51:16 INFO - Successfully installed psutil 19:51:16 INFO - Cleaning up... 19:51:16 INFO - Return code: 0 19:51:16 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 19:51:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:51:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:51:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:51:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:51:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:16 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 0x7f446324bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bc45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c53410>, '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 0x2c54310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c547a0>, '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': '41bf3e9aed84707956354da8000001c5-1461462925.912122-2000355471', '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 19:51:16 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 19:51:16 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 19:51:16 INFO - Using env: {'DISPLAY': ':0', 19:51:16 INFO - 'HOME': '/home/cltbld', 19:51:16 INFO - 'LANG': 'en_US.UTF-8', 19:51:16 INFO - 'LANGUAGE': 'en_US:en', 19:51:16 INFO - 'LOGNAME': 'cltbld', 19:51:16 INFO - 'MAIL': '/var/mail/cltbld', 19:51:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:51:16 INFO - 'MOZ_NO_REMOTE': '1', 19:51:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:51:16 INFO - 'NO_EM_RESTART': '1', 19:51:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:51:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:51:16 INFO - 'PWD': '/builds/slave/test', 19:51:16 INFO - 'SHELL': '/bin/bash', 19:51:16 INFO - 'SHLVL': '1', 19:51:16 INFO - 'TERM': 'linux', 19:51:16 INFO - 'TMOUT': '86400', 19:51:16 INFO - 'USER': 'cltbld', 19:51:16 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1461462925.912122-2000355471', 19:51:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:51:16 INFO - '_': '/tools/buildbot/bin/python'} 19:51:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:51:17 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 19:51:17 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 19:51:17 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 19:51:17 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 19:51:17 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 19:51:17 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 19:51:17 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 19:51:18 INFO - Downloading mozsystemmonitor-0.0.tar.gz 19:51:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:51:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 19:51:19 INFO - Installing collected packages: mozsystemmonitor 19:51:19 INFO - Running setup.py install for mozsystemmonitor 19:51:19 INFO - Successfully installed mozsystemmonitor 19:51:19 INFO - Cleaning up... 19:51:19 INFO - Return code: 0 19:51:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:51:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:51:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:51:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:51:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:51:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:19 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 0x7f446324bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bc45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c53410>, '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 0x2c54310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c547a0>, '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': '41bf3e9aed84707956354da8000001c5-1461462925.912122-2000355471', '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 19:51:19 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 19:51:19 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 19:51:19 INFO - Using env: {'DISPLAY': ':0', 19:51:19 INFO - 'HOME': '/home/cltbld', 19:51:19 INFO - 'LANG': 'en_US.UTF-8', 19:51:19 INFO - 'LANGUAGE': 'en_US:en', 19:51:19 INFO - 'LOGNAME': 'cltbld', 19:51:19 INFO - 'MAIL': '/var/mail/cltbld', 19:51:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:51:19 INFO - 'MOZ_NO_REMOTE': '1', 19:51:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:51:19 INFO - 'NO_EM_RESTART': '1', 19:51:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:51:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:51:19 INFO - 'PWD': '/builds/slave/test', 19:51:19 INFO - 'SHELL': '/bin/bash', 19:51:19 INFO - 'SHLVL': '1', 19:51:19 INFO - 'TERM': 'linux', 19:51:19 INFO - 'TMOUT': '86400', 19:51:19 INFO - 'USER': 'cltbld', 19:51:19 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1461462925.912122-2000355471', 19:51:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:51:19 INFO - '_': '/tools/buildbot/bin/python'} 19:51:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:51:19 INFO - Downloading/unpacking blobuploader==1.2.4 19:51:19 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 19:51:19 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 19:51:19 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 19:51:19 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 19:51:19 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 19:51:19 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 19:51:21 INFO - Downloading blobuploader-1.2.4.tar.gz 19:51:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:51:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:51:21 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 19:51:21 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 19:51:21 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 19:51:21 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 19:51:21 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 19:51:21 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 19:51:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:51:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:51:21 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 19:51:21 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 19:51:21 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 19:51:21 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 19:51:21 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 19:51:21 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 19:51:21 INFO - Downloading docopt-0.6.1.tar.gz 19:51:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:51:21 INFO - Installing collected packages: blobuploader, requests, docopt 19:51:21 INFO - Running setup.py install for blobuploader 19:51:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:51:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:51:22 INFO - Running setup.py install for requests 19:51:22 INFO - Running setup.py install for docopt 19:51:22 INFO - Successfully installed blobuploader requests docopt 19:51:22 INFO - Cleaning up... 19:51:22 INFO - Return code: 0 19:51:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:51:22 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')]} 19:51:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:51:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:22 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')]} 19:51:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:51:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:22 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 0x7f446324bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bc45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c53410>, '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 0x2c54310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c547a0>, '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': '41bf3e9aed84707956354da8000001c5-1461462925.912122-2000355471', '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 19:51:22 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 19:51:22 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 19:51:22 INFO - Using env: {'DISPLAY': ':0', 19:51:22 INFO - 'HOME': '/home/cltbld', 19:51:22 INFO - 'LANG': 'en_US.UTF-8', 19:51:22 INFO - 'LANGUAGE': 'en_US:en', 19:51:22 INFO - 'LOGNAME': 'cltbld', 19:51:22 INFO - 'MAIL': '/var/mail/cltbld', 19:51:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:51:22 INFO - 'MOZ_NO_REMOTE': '1', 19:51:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:51:22 INFO - 'NO_EM_RESTART': '1', 19:51:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:51:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:51:22 INFO - 'PWD': '/builds/slave/test', 19:51:22 INFO - 'SHELL': '/bin/bash', 19:51:22 INFO - 'SHLVL': '1', 19:51:22 INFO - 'TERM': 'linux', 19:51:22 INFO - 'TMOUT': '86400', 19:51:22 INFO - 'USER': 'cltbld', 19:51:22 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1461462925.912122-2000355471', 19:51:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:51:22 INFO - '_': '/tools/buildbot/bin/python'} 19:51:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:51:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:51:22 INFO - Running setup.py (path:/tmp/pip-UXjKCk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:51:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:51:22 INFO - Running setup.py (path:/tmp/pip-VzlU4A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:51:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:51:22 INFO - Running setup.py (path:/tmp/pip-GPOELZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:51:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:51:23 INFO - Running setup.py (path:/tmp/pip-7Xy7J2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:51:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:51:23 INFO - Running setup.py (path:/tmp/pip-tp2Kx6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:51:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:51:23 INFO - Running setup.py (path:/tmp/pip-U6iNxp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:51:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:51:23 INFO - Running setup.py (path:/tmp/pip-9hkUHo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:51:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:51:23 INFO - Running setup.py (path:/tmp/pip-ufe1h5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:51:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:51:23 INFO - Running setup.py (path:/tmp/pip-lirUrd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:51:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:51:23 INFO - Running setup.py (path:/tmp/pip-qFZHQA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:51:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:51:23 INFO - Running setup.py (path:/tmp/pip-myYJFG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:51:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:51:23 INFO - Running setup.py (path:/tmp/pip-Z3xlYe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:51:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:51:23 INFO - Running setup.py (path:/tmp/pip-zAF34E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:51:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:51:23 INFO - Running setup.py (path:/tmp/pip-FVflLM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:51:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:51:23 INFO - Running setup.py (path:/tmp/pip-_735sT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:51:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:51:23 INFO - Running setup.py (path:/tmp/pip-LJpSpN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:51:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:51:23 INFO - Running setup.py (path:/tmp/pip-acN1__-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:51:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:51:24 INFO - Running setup.py install for manifestparser 19:51:24 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:51:24 INFO - Running setup.py install for mozcrash 19:51:24 INFO - Running setup.py install for mozdebug 19:51:24 INFO - Running setup.py install for mozdevice 19:51:24 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:51:24 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:51:24 INFO - Running setup.py install for mozfile 19:51:24 INFO - Running setup.py install for mozhttpd 19:51:24 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:51:24 INFO - Running setup.py install for mozinfo 19:51:24 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:51:24 INFO - Running setup.py install for mozInstall 19:51:24 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:51:24 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:51:24 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:51:24 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:51:24 INFO - Running setup.py install for mozleak 19:51:24 INFO - Running setup.py install for mozlog 19:51:25 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:51:25 INFO - Running setup.py install for moznetwork 19:51:25 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:51:25 INFO - Running setup.py install for mozprocess 19:51:25 INFO - Running setup.py install for mozprofile 19:51:25 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:51:25 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:51:25 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:51:25 INFO - Running setup.py install for mozrunner 19:51:25 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:51:25 INFO - Running setup.py install for mozscreenshot 19:51:25 INFO - Running setup.py install for moztest 19:51:25 INFO - Running setup.py install for mozversion 19:51:25 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:51:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:51:25 INFO - Cleaning up... 19:51:25 INFO - Return code: 0 19:51:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:51:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:51:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:51:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:51:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:51:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:25 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 0x7f446324bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bc45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c53410>, '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 0x2c54310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c547a0>, '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': '41bf3e9aed84707956354da8000001c5-1461462925.912122-2000355471', '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 19:51:25 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 19:51:25 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 19:51:25 INFO - Using env: {'DISPLAY': ':0', 19:51:25 INFO - 'HOME': '/home/cltbld', 19:51:25 INFO - 'LANG': 'en_US.UTF-8', 19:51:25 INFO - 'LANGUAGE': 'en_US:en', 19:51:25 INFO - 'LOGNAME': 'cltbld', 19:51:25 INFO - 'MAIL': '/var/mail/cltbld', 19:51:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:51:25 INFO - 'MOZ_NO_REMOTE': '1', 19:51:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:51:25 INFO - 'NO_EM_RESTART': '1', 19:51:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:51:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:51:25 INFO - 'PWD': '/builds/slave/test', 19:51:25 INFO - 'SHELL': '/bin/bash', 19:51:25 INFO - 'SHLVL': '1', 19:51:25 INFO - 'TERM': 'linux', 19:51:25 INFO - 'TMOUT': '86400', 19:51:25 INFO - 'USER': 'cltbld', 19:51:25 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1461462925.912122-2000355471', 19:51:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:51:25 INFO - '_': '/tools/buildbot/bin/python'} 19:51:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:51:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:51:26 INFO - Running setup.py (path:/tmp/pip-ccYRLS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:51:26 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)) 19:51:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:51:26 INFO - Running setup.py (path:/tmp/pip-ukfE65-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:51:26 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)) 19:51:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:51:26 INFO - Running setup.py (path:/tmp/pip-mIEsYF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:51:26 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)) 19:51:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:51:26 INFO - Running setup.py (path:/tmp/pip-XWPPBD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:51:26 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)) 19:51:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:51:26 INFO - Running setup.py (path:/tmp/pip-CL6U2a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:51:26 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)) 19:51:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:51:26 INFO - Running setup.py (path:/tmp/pip-8k2gZA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:51:26 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)) 19:51:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:51:26 INFO - Running setup.py (path:/tmp/pip-Y0uf1p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:51:26 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)) 19:51:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:51:26 INFO - Running setup.py (path:/tmp/pip-RPA4WU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:51:26 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)) 19:51:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:51:26 INFO - Running setup.py (path:/tmp/pip-vuBUKc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:51:26 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)) 19:51:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:51:26 INFO - Running setup.py (path:/tmp/pip-EkvNzA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:51:26 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)) 19:51:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:51:26 INFO - Running setup.py (path:/tmp/pip-kYYJoD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:51:26 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)) 19:51:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:51:26 INFO - Running setup.py (path:/tmp/pip-Aj9YIV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:51:26 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)) 19:51:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:51:26 INFO - Running setup.py (path:/tmp/pip-MfXyae-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:51:26 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)) 19:51:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:51:26 INFO - Running setup.py (path:/tmp/pip-LuBrbc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:51:27 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)) 19:51:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:51:27 INFO - Running setup.py (path:/tmp/pip-iSZ8E6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:51:27 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)) 19:51:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:51:27 INFO - Running setup.py (path:/tmp/pip-emV9XN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:51:27 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)) 19:51:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:51:27 INFO - Running setup.py (path:/tmp/pip-IBZWCx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:51:27 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)) 19:51:27 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)) 19:51:27 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)) 19:51:27 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)) 19:51:27 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)) 19:51:27 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)) 19:51:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:51:27 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 19:51:27 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 19:51:27 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 19:51:27 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 19:51:27 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 19:51:27 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 19:51:29 INFO - Downloading blessings-1.6.tar.gz 19:51:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:51:29 INFO - Installing collected packages: blessings 19:51:29 INFO - Running setup.py install for blessings 19:51:29 INFO - Successfully installed blessings 19:51:29 INFO - Cleaning up... 19:51:29 INFO - Return code: 0 19:51:29 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:51:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:51:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:51:29 INFO - Reading from file tmpfile_stdout 19:51:29 INFO - Current package versions: 19:51:29 INFO - argparse == 1.2.1 19:51:29 INFO - blessings == 1.6 19:51:29 INFO - blobuploader == 1.2.4 19:51:29 INFO - docopt == 0.6.1 19:51:29 INFO - manifestparser == 1.1 19:51:29 INFO - mozInstall == 1.12 19:51:29 INFO - mozcrash == 0.17 19:51:29 INFO - mozdebug == 0.1 19:51:29 INFO - mozdevice == 0.48 19:51:29 INFO - mozfile == 1.2 19:51:29 INFO - mozhttpd == 0.7 19:51:29 INFO - mozinfo == 0.9 19:51:29 INFO - mozleak == 0.1 19:51:29 INFO - mozlog == 3.1 19:51:29 INFO - moznetwork == 0.27 19:51:29 INFO - mozprocess == 0.22 19:51:29 INFO - mozprofile == 0.28 19:51:29 INFO - mozrunner == 6.11 19:51:29 INFO - mozscreenshot == 0.1 19:51:29 INFO - mozsystemmonitor == 0.0 19:51:29 INFO - moztest == 0.7 19:51:29 INFO - mozversion == 1.4 19:51:29 INFO - psutil == 3.1.1 19:51:29 INFO - requests == 1.2.3 19:51:29 INFO - wsgiref == 0.1.2 19:51:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:51:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:51:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:51:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:51:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:51:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:29 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 0x7f446324bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bc45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c53410>, '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 0x2c54310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c547a0>, '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': '41bf3e9aed84707956354da8000001c5-1461462925.912122-2000355471', '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 19:51:29 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 19:51:29 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 19:51:29 INFO - Using env: {'DISPLAY': ':0', 19:51:29 INFO - 'HOME': '/home/cltbld', 19:51:29 INFO - 'LANG': 'en_US.UTF-8', 19:51:29 INFO - 'LANGUAGE': 'en_US:en', 19:51:29 INFO - 'LOGNAME': 'cltbld', 19:51:29 INFO - 'MAIL': '/var/mail/cltbld', 19:51:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:51:29 INFO - 'MOZ_NO_REMOTE': '1', 19:51:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:51:29 INFO - 'NO_EM_RESTART': '1', 19:51:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:51:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:51:29 INFO - 'PWD': '/builds/slave/test', 19:51:29 INFO - 'SHELL': '/bin/bash', 19:51:29 INFO - 'SHLVL': '1', 19:51:29 INFO - 'TERM': 'linux', 19:51:29 INFO - 'TMOUT': '86400', 19:51:29 INFO - 'USER': 'cltbld', 19:51:29 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1461462925.912122-2000355471', 19:51:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:51:29 INFO - '_': '/tools/buildbot/bin/python'} 19:51:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:51:29 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)) 19:51:29 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)) 19:51:29 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)) 19:51:29 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)) 19:51:29 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)) 19:51:29 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)) 19:51:29 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)) 19:51:29 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)) 19:51:29 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)) 19:51:29 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)) 19:51:29 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)) 19:51:29 INFO - Cleaning up... 19:51:29 INFO - Return code: 0 19:51:29 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:51:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:51:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:51:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:51:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:51:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:29 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 0x7f446324bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bc45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c53410>, '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 0x2c54310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c547a0>, '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': '41bf3e9aed84707956354da8000001c5-1461462925.912122-2000355471', '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 19:51:29 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 19:51:29 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 19:51:29 INFO - Using env: {'DISPLAY': ':0', 19:51:29 INFO - 'HOME': '/home/cltbld', 19:51:29 INFO - 'LANG': 'en_US.UTF-8', 19:51:29 INFO - 'LANGUAGE': 'en_US:en', 19:51:29 INFO - 'LOGNAME': 'cltbld', 19:51:29 INFO - 'MAIL': '/var/mail/cltbld', 19:51:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:51:29 INFO - 'MOZ_NO_REMOTE': '1', 19:51:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:51:29 INFO - 'NO_EM_RESTART': '1', 19:51:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:51:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:51:29 INFO - 'PWD': '/builds/slave/test', 19:51:29 INFO - 'SHELL': '/bin/bash', 19:51:29 INFO - 'SHLVL': '1', 19:51:29 INFO - 'TERM': 'linux', 19:51:29 INFO - 'TMOUT': '86400', 19:51:29 INFO - 'USER': 'cltbld', 19:51:29 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1461462925.912122-2000355471', 19:51:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:51:29 INFO - '_': '/tools/buildbot/bin/python'} 19:51:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:51:29 INFO - Downloading/unpacking jsonschema 19:51:29 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 19:51:29 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 19:51:29 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 19:51:29 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 19:51:29 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 19:51:29 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 19:51:31 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:51:31 INFO - Downloading/unpacking functools32 (from jsonschema) 19:51:31 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 19:51:31 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 19:51:31 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 19:51:31 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 19:51:31 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 19:51:31 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 19:51:32 INFO - Downloading functools32-3.2.3-2.tar.gz 19:51:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:51:32 INFO - warning: no files found matching '*.txt' 19:51:32 INFO - no previously-included directories found matching 'build' 19:51:32 INFO - no previously-included directories found matching 'dist' 19:51:32 INFO - no previously-included directories found matching '.git*' 19:51:32 INFO - Installing collected packages: jsonschema, functools32 19:51:32 INFO - Running setup.py install for functools32 19:51:32 INFO - warning: no files found matching '*.txt' 19:51:32 INFO - no previously-included directories found matching 'build' 19:51:32 INFO - no previously-included directories found matching 'dist' 19:51:32 INFO - no previously-included directories found matching '.git*' 19:51:32 INFO - Successfully installed jsonschema functools32 19:51:32 INFO - Cleaning up... 19:51:32 INFO - Return code: 0 19:51:32 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 19:51:32 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')]} 19:51:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:51:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:32 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')]} 19:51:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:51:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:32 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 0x7f446324bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bc45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c53410>, '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 0x2c54310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c547a0>, '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': '41bf3e9aed84707956354da8000001c5-1461462925.912122-2000355471', '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 19:51:32 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 19:51:32 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 19:51:32 INFO - Using env: {'DISPLAY': ':0', 19:51:32 INFO - 'HOME': '/home/cltbld', 19:51:32 INFO - 'LANG': 'en_US.UTF-8', 19:51:32 INFO - 'LANGUAGE': 'en_US:en', 19:51:32 INFO - 'LOGNAME': 'cltbld', 19:51:32 INFO - 'MAIL': '/var/mail/cltbld', 19:51:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:51:32 INFO - 'MOZ_NO_REMOTE': '1', 19:51:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:51:32 INFO - 'NO_EM_RESTART': '1', 19:51:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:51:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:51:32 INFO - 'PWD': '/builds/slave/test', 19:51:32 INFO - 'SHELL': '/bin/bash', 19:51:32 INFO - 'SHLVL': '1', 19:51:32 INFO - 'TERM': 'linux', 19:51:32 INFO - 'TMOUT': '86400', 19:51:32 INFO - 'USER': 'cltbld', 19:51:32 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1461462925.912122-2000355471', 19:51:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:51:32 INFO - '_': '/tools/buildbot/bin/python'} 19:51:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:51:32 INFO - Downloading/unpacking flake8 19:51:32 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 19:51:32 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 19:51:32 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 19:51:32 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 19:51:32 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 19:51:32 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 19:51:34 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:51:34 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:51:34 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 19:51:34 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 19:51:34 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 19:51:34 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 19:51:34 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 19:51:34 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 19:51:34 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:51:34 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:51:34 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 19:51:34 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 19:51:34 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 19:51:34 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 19:51:34 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 19:51:34 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 19:51:34 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:51:34 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 19:51:34 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 19:51:34 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 19:51:34 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 19:51:34 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 19:51:34 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 19:51:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 19:51:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:51:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:51:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:51:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:51:35 INFO - no previously-included directories found matching 'docs/_build' 19:51:35 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:51:35 INFO - Running setup.py install for pep8 19:51:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:51:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:51:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:51:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:51:35 INFO - no previously-included directories found matching 'docs/_build' 19:51:35 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 19:51:35 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:51:35 INFO - Cleaning up... 19:51:35 INFO - Return code: 0 19:51:35 INFO - Running post-action listener: _resource_record_post_action 19:51:35 INFO - Running post-action listener: _start_resource_monitoring 19:51:35 INFO - Starting resource monitoring. 19:51:35 INFO - ##### 19:51:35 INFO - ##### Running install step. 19:51:35 INFO - ##### 19:51:35 INFO - Running pre-action listener: _resource_record_pre_action 19:51:35 INFO - Running main action method: install 19:51:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:51:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:51:35 INFO - Reading from file tmpfile_stdout 19:51:35 INFO - Detecting whether we're running mozinstall >=1.0... 19:51:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:51:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:51:35 INFO - Reading from file tmpfile_stdout 19:51:35 INFO - Output received: 19:51:35 INFO - Usage: mozinstall [options] installer 19:51:35 INFO - Options: 19:51:35 INFO - -h, --help show this help message and exit 19:51:35 INFO - -d DEST, --destination=DEST 19:51:35 INFO - Directory to install application into. [default: 19:51:35 INFO - "/builds/slave/test"] 19:51:35 INFO - --app=APP Application being installed. [default: firefox] 19:51:35 INFO - mkdir: /builds/slave/test/build/application 19:51:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 19:51:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 19:51:51 INFO - Reading from file tmpfile_stdout 19:51:51 INFO - Output received: 19:51:51 INFO - /builds/slave/test/build/application/firefox/firefox 19:51:51 INFO - Running post-action listener: _resource_record_post_action 19:51:51 INFO - ##### 19:51:51 INFO - ##### Running run-tests step. 19:51:51 INFO - ##### 19:51:51 INFO - Running pre-action listener: _resource_record_pre_action 19:51:51 INFO - Running main action method: run_tests 19:51:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:51:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:51:51 INFO - Python 2.7.3 19:51:51 INFO - Return code: 0 19:51:51 INFO - grabbing minidump binary from tooltool 19: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')]} 19:51:51 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 0x2c53410>, '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 0x2c54310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c547a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:51:51 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 19:51:51 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 19:51:51 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:51:51 INFO - Return code: 0 19:51:51 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:51:51 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:51:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:51:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:51:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:51:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 19:51:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 19:51:52 INFO - Return code: 0 19:51:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PkjyxxzxTE6x9odUV932Mw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--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 19:51:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/PkjyxxzxTE6x9odUV932Mw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-026 --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 19:51:52 INFO - Using env: {'DISPLAY': ':0', 19:51:52 INFO - 'HOME': '/home/cltbld', 19:51:52 INFO - 'LANG': 'en_US.UTF-8', 19:51:52 INFO - 'LANGUAGE': 'en_US:en', 19:51:52 INFO - 'LOGNAME': 'cltbld', 19:51:52 INFO - 'MAIL': '/var/mail/cltbld', 19:51:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:51:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:51:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:51:52 INFO - 'MOZ_NO_REMOTE': '1', 19:51:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:51:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:51:52 INFO - 'NO_EM_RESTART': '1', 19:51:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:51:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:51:52 INFO - 'PWD': '/builds/slave/test', 19:51:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:51:52 INFO - 'SHELL': '/bin/bash', 19:51:52 INFO - 'SHLVL': '1', 19:51:52 INFO - 'TERM': 'linux', 19:51:52 INFO - 'TMOUT': '86400', 19:51:52 INFO - 'USER': 'cltbld', 19:51:52 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1461462925.912122-2000355471', 19:51:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:51:52 INFO - '_': '/tools/buildbot/bin/python'} 19:51:52 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PkjyxxzxTE6x9odUV932Mw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--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 19:51:52 INFO - mozversion application_buildid: 20160423181244 19:51:52 INFO - mozversion application_changeset: ab8a76ac7b34db20dd3c220c9846826334f3efdc 19:51:52 INFO - mozversion application_display_name: Nightly 19:51:52 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:51:52 INFO - mozversion application_name: Firefox 19:51:52 INFO - mozversion application_remotingname: firefox 19:51:52 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 19:51:52 INFO - mozversion application_vendor: Mozilla 19:51:52 INFO - mozversion application_version: 48.0a1 19:51:52 INFO - mozversion platform_buildid: 20160423181244 19:51:52 INFO - mozversion platform_changeset: ab8a76ac7b34db20dd3c220c9846826334f3efdc 19:51:52 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 19:51:52 INFO - mozversion platform_version: 48.0a1 19:51:52 INFO - using testdate: 1461466312 19:51:52 INFO - actual date: 1461466312 19:51:52 INFO - starting webserver on 'localhost:56208' 19:51:52 INFO - SUITE-START | Running 2 tests 19:51:52 INFO - TEST-START | dromaeo_css 19:51:52 INFO - operating with platform_type : linux_ 19:51:52 INFO - Initialising browser for dromaeo_css test... 19:51:52 INFO - TEST-INFO | started process 13306 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHoGknB/profile http://localhost:56208/getInfo.html) 19:51:56 INFO - PROCESS | 13306 | 19:51:56 INFO - PROCESS | 13306 | (process:13374): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:51:57 INFO - PROCESS | 13306 | __metrics Screen width/height:1600/1200 19:51:57 INFO - PROCESS | 13306 | colorDepth:24 19:51:57 INFO - PROCESS | 13306 | Browser inner width/height: 1024/697 19:51:57 INFO - PROCESS | 13306 | __metrics 19:51:58 ERROR - PROCESS | 13306 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 19:51:59 INFO - TEST-INFO | 13306: exit 0 19:51:59 INFO - Browser initialized. 19:51:59 INFO - Running cycle 1/1 for dromaeo_css test... 19:51:59 INFO - TEST-INFO | started process 13425 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHoGknB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:52:01 INFO - PROCESS | 13425 | 19:52:01 INFO - PROCESS | 13425 | (process:13485): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:52:11 INFO - PROCESS | 13425 | RSS: Main: 165904384 19:52:11 INFO - PROCESS | 13425 | 19:53:00 INFO - PROCESS | 13425 | 1461466380782 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] 19:55:12 INFO - PROCESS | 13425 | Cycle 1(1): loaded http://localhost:56208/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56208/tests/dromaeo/cssquery-ext.html) 19:55:13 INFO - PROCESS | 13425 | RSS: Main: 170139648 19:55:13 INFO - PROCESS | 13425 | 19:58:15 INFO - PROCESS | 13425 | Cycle 1(1): loaded http://localhost:56208/tests/dromaeo/cssquery-ext.html (next: http://localhost:56208/tests/dromaeo/cssquery-jquery.html) 19:58:16 INFO - PROCESS | 13425 | RSS: Main: 166379520 19:58:16 INFO - PROCESS | 13425 | 20:01:18 INFO - PROCESS | 13425 | Cycle 1(1): loaded http://localhost:56208/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56208/tests/dromaeo/cssquery-mootools.html) 20:01:19 INFO - PROCESS | 13425 | RSS: Main: 167010304 20:01:19 INFO - PROCESS | 13425 | 20:04:20 INFO - PROCESS | 13425 | Cycle 1(1): loaded http://localhost:56208/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56208/tests/dromaeo/cssquery-prototype.html) 20:04:21 INFO - PROCESS | 13425 | RSS: Main: 164528128 20:04:21 INFO - PROCESS | 13425 | 20:07:24 INFO - PROCESS | 13425 | Cycle 1(1): loaded http://localhost:56208/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56208/tests/dromaeo/cssquery-yui.html) 20:07:24 INFO - PROCESS | 13425 | RSS: Main: 165433344 20:07:24 INFO - PROCESS | 13425 | 20:10:27 INFO - PROCESS | 13425 | Cycle 1(1): loaded http://localhost:56208/tests/dromaeo/cssquery-yui.html (next: http://localhost:56208/tests/dromaeo/cssquery-dojo.html) 20:10:27 INFO - PROCESS | 13425 | RSS: Main: 168857600 20:10:27 INFO - PROCESS | 13425 | 20:10:27 INFO - PROCESS | 13425 | __start_tp_report 20:10:27 INFO - PROCESS | 13425 | _x_x_mozilla_page_load 20:10:27 INFO - PROCESS | 13425 | _x_x_mozilla_page_load_details 20:10:27 INFO - PROCESS | 13425 | |i|pagename|runs| 20:10:27 INFO - PROCESS | 13425 | |0;dojo.html;2659.507991021661;2694.865256737163;2733.658292713411;2740.2738274357284;2749.5738160585106;4742.810287588497;4766.952330476694;4791.113643975863;4804.255340422232;4847.466778654345;4728.66899317048;4747.786349614267;4808.7114773113635;4812.8074877004965;4838.056578967103;4402.251617225072;4461.910761784762;4522.773861306938;4537.546245375453;4557.179707652621;616.3115275129202;4334.60988511034;4375.51869294379;4393.121375724868;4402.339649052636;4333;4334.328179132223;4411.514733379326;4424.513303536608;4543.568361005699;4388.605025547684;4389.297712366006;4390.275604525282;4407.779611019436;4437.0460351024685;4276.593723596254;4374.671899607542;4378.474583050022;4382.780860956939;4416.757078360689;4655.37152484417;4672.883177920545;4677.111348843709;4680.836170734042;4744.525547445262;5093.006863661588;5129.9743501282255;5140.1004824156;5152.355955505562;5175.792968281265;5083.847484575469;5164.767585458626;5220.660657057279;5266.4470230626;5296.205569164617;4839;4860.076585448754;4910.165271903785;4910.754462276872;4931.211006238985;5392.5416339611575;5404.972975135099;5406.053940560386;5406.756695948692;5408.3509978802795;4933.555979961749;5110.744462776846;5137.255098010767;5146.639735218499;5161.5870730341485;5119.820806271762;5127.461616530285;5136.666116702402;5145.819896303611;5146.099432599281;5125.231215317732;5129.615278854101;5136.178211486144;5141.126008578551;5143.485651434827;5027.145385284511;5112.284280200774;5143.691378517226;5173.249878767558;5226.790928362823;4355.324924636687;4378.846740364072;4381.890452738707;4382.255016647114;4417.823287068545;3766.0961369271727;3772.245550889833;3806.352920003606;3854.9398915298516;3866.729328947003;4320.503142138631;4398.318260669537;4441.68908176431;4449.310356894686;4520.841770538082;5194.558462530727;5209.1925751507815;5215.374155101412;5243.152433011059;5285.762140703678;4283.271843786564;4474.351219073281;4479.686421950498;4485.596296333346;4511.210538155809;4698.1778188816825;4714.363560919301;4720.929186062212;4765.142274390573;4779.378680771478;4762.738049407316;4813.326134341195;4813.374261346003;4819.879503012453;4853.053654537402;5042.798288068583;5133.512316329943;5148.253503242084;5199.038177937094;5216.530512253916;4827.203511420576;4841.95158048415;4844.733539655353;4868.659193856396;4881.633877459134;5114.820981265638;5114.974425127999;5115.820946266863;5120.206368012964;5121.513456221653;4966.081274964144;5142.202958541432;5177.4822517747925;5180.948190518046;5187.273781670494;4991.07665081961;5006.574441172395;5013.122703526941;5013.172826483589;5041.6470847040355;4993.775280112476;4998.800047998185;5002.599792016703;5012;5064.18972964324;4866.099771542276;4943.406791185081;4962.454130045764;4978.47725988766;5044.54599086084;5054.570361519312;5086.033653605803;5091.338126043591;5106.2595923590125;5140.100482415488;4959.801607935642;4969.105560999054;4973.428055773487;4987.825426110068;4994.9500504994485 20:10:27 INFO - PROCESS | 13425 | |1;ext.html;575.4676923845442;610.41095342994;617.1483352972897;628.7767842415942;638.5179189711766;34269.31461370771;35365.64634353656;35426.2914741705;35477.82261088697;35546.64453355466;36285.45571816425;36857;36900.815495922485;36926.630733692655;36955.81522092393;7461.925380746205;7589.772306830776;7627.580483073429;7629.465937384385;7632.274933881273;6770.32296770324;6791.558548694319;7140.393066589346;7146.4282857371545;7157.89263161053;6754.729810807562;6777.356151165656;6798.150231221098;6799.932000680004;7027.191872934627;6752.054712340252;6763.053172555846;6769.05233267343;6788.185417749902;7031.402330801888;7617.352525035379;7648.9235107648765;7731.7680469586;7734.690612375498;7736.419768517328;29148.27129321784;36289.274214515826;36780.26439471196;36865.63134368676;36885.81557092197;2884.4086962172705;2915.6792752797173;3093.7989030713156;3111.222194451387;3222.419964406406;24218.63672044921;24284.878575607185;24317.39206519851;24766.876165619236;25111.497770044498;3109.5180247061517;3251.122197006795;3253.837308134584;3294.67053294671;3380.2056516718553;168283;168724;169620;170003;171372;32946.50580241298;34193.487097693556;48248;48563.5143648559;48653.270200947016;31450;31553.211169720482;31608.525872111935;31614.367712645617;31719.365612687616;12199.512019519298;12340.876591233973;12411.131220814455;12449.066320026035;12473.75052498945;10731.087857532197;10736;10775.6228532001;10809.189310801721;10821.29661572011;8133.454643617812;8151.8777218341775;8168.06067302256;8209.58952052395;8231.382646301552;3196.7922085064397;3204.327091310804;3280.3603297356785;3287.375398674244;3289.5723555938052;974.498133461268;990.2968892086699;1036.3108532825586;1057.286331726082;1077.671310250381;27713.86143069272;28176.29559261035;28625.57061644077;29678.258043549085;30011.249718757204;953.4851180362665;982.4498280962683;992.9950350248203;1007.5063219022773;1055.2876808154465;13542.255175965416;13895.374708138159;14051.437942482391;14088.506902258372;14282.57152285433;347220;350868;354174;354780;355802;46519.30221046687;47186.999999999316;47503.287450688265;47680.5231947683;47749.04501910012;1209.9939500302619;1259.924404535731;1278.8145718870712;1301.316808675434;1313.2908229555933;26002.60996085098;26900.327491812863;26947.191584252505;27326.45347093007;27619.171424857286;40749.59250407458;41804.79097604614;42028.15943681171;42066.57933420627;42128;297904;300175;302367;302824;304556;24180.758192417852;24353.39116522101;24571.754282457663;24581.508369832147;24612.261632151065;38868.22263554657;39901.60098398979;40108.39837402383;40157.196856063296;40165;33841;34812.651873481955;35232.29535409329;35339;35629.64370356367;34318;34977.65022349744;35259.823700882356;35527.289454211284;35620.643793561736;30192.396152077275;33044.339113218084;34583.65416345804;35223.975200800516;35471.467927980586;27106.32234194161;27963.58054629223;28024.71975280221;28082.578761319004;28292.575611365435;22114;22287.331380058626;22342.441438963506;22460.438489037904;22668.206612769132 20:10:27 INFO - PROCESS | 13425 | |2;jquery.html;381.2337202223531;387.6433681013467;389.72719096632346;390.6406106382128;397.73749325445175;15086;16041.839581604181;16179.676406471894;16187.919060404682;16223.02661840289;15470;16209.432669856558;16923;16976.74534881978;17007;5004.54959053686;5220.504052115043;5292.55013323866;5294.629375943686;5300.708461034642;3692.593814680383;5720.399358067405;6104.664243466607;6110.083487476892;6110.480609148228;4912.410510738699;6007.068904319815;6007.8197654070445;6015.578909476339;6022.909656355158;5154.046501397253;5163.7676304566385;5186.403563590197;5190.4809519047985;5217.165253559431;4967.304577359173;5207.609429292818;5388.164834450667;5401.918971215396;5426.2674538937135;11716.472758725879;11958.342291173982;11998.880011199864;12037.638870833889;12526.874731252661;1907.6089401672623;1927.3543362973421;1971.122850331603;1997.439690770427;2485.192312498445;8562.186592273723;8831.77920551985;9228.723138305862;9256.398334108262;9272.582733776997;1758.8592912566965;1801.4505575799376;1818.8635852310997;1845.4463660901677;1863.413024897153;66727;68210.65894670544;68592;69478;69882.99999999949;9776.608935642495;9973.700788976343;10187.337823041627;10243.897561024443;10275.537600807982;13829.654258643413;14090.365933533016;14096.506622268376;14099;14117.364718587689;7224.241454647292;7282.708691652275;7316.304951029643;7448.292412220831;7451.776446706607;6665.100211471487;6675.499337549703;6773.221079575814;6820.6930688119155;6947.3747362737595;4411.514733379326;4421.2262854001065;4431.047324825178;4431.224535706238;4432.601065904084;1696.8642508599282;1823.4803081121815;1899.6295722334012;1899.8765080269739;1917.3481016454473;905.6151135767404;915;932.9253659707207;938.5354249646332;1006.8873894346641;15094.622634434007;15476.922615387077;16031.278592463366;16249.268782904797;16540.421085261958;848.325581162977;857.652650676477;858.1590041759112;879.8768172455862;922.4603606890045;9083.727488175233;9251.722448326562;9285.535723213947;9333.719988400358;9399.34204605671;306511;311643;313927;316115;371011;66635.66682166558;71081.28918710747;71405.2859471409;72005;73920.26079739134;979.9363041402286;997.6159178716101;1016.5577973581368;1064.808334499782;1069.2354966199205;15294.464693735667;15317.693646127238;15365.231738412811;15478.9226053869;15538.922305388402;35046.47430288599;35459.46810797788;35483.467747984316;36023.45964810478;36633.45049824201;47397.35979180863;49405.25892111549;49759.59741909797;49813.501864980884;50411.243831343294;7457.589832559044;7657.693692252247;7806.726764563213;7910.920890791019;7943.165967573553;11017.504212310305;11589.884101159218;11689.88310116888;11706.35615041181;11918.52325906954;10030.29787914839;10060.39637621745;10371.58513659445;10456.947715261374;10487.37075775456;9284.535773211448;10210.438425886647;10599.099076578577;10626.309289896131;10634.202434817575;9601.087896649808;10334.741631459274;10400.323978941344;10566.26036177491;10750.677479675622;7612.7716168515035;7626.161122276434;7652.693892244248;7814.88277675824;7865.6460459280615;9377.906220937703;10371.481425928825;10606.681799546026;10665.146788256765;10794.892051079703 20:10:27 INFO - PROCESS | 13425 | |3;mootools.html;1465.8900582456317;1499.8725108365786;1608.6300150965278;1753;1809.9276028958834;6835.658217089151;7457.328840404362;7477.2896574825445;7725.92274077259;7740.458167928247;7551.622418879061;7552.848943021137;7585.393168546517;7635.694572217105;7646.235376462351;2211.944701382466;2230.7434645015787;2233.798958093771;2237.7538470768204;2238;2188.102877820094;2197.230969160789;2239.8880055997133;2246.9551658478804;2251.7297924249115;2228.4985878177363;2256.8871556422196;2268.6823844661762;2276.112316196685;2295.334353037617;2202.1411649456722;2204.2836078274463;2209.3924170853065;2217.2793842001415;2221.911123555056;2134.925277615276;2138.647123224666;2151.2363111095647;2154.4721543222013;2156.6657168138963;7453.888191677129;7606.429517786189;7654.578998155099;7666.041744781903;7684.846303073963;4569.451665800092;4767.737774422405;4773.856784296477;4774.259989701602;4781.545753153445;2807.3122085089285;2958.097780177045;2963.0518234165074;2972.5541168824634;2985.507391280436;918.1002617434951;918.5040078357746;925;926.2589928057527;951.4624237305969;10370.066693997502;10439.217058720626;10456.058954694037;10473.847876733553;10483.685489435253;4208.494980602347;4234.513031001413;4353.521112677603;4384.364267181241;4410.360497727876;8912.108789121035;8936.46381217129;8936.955315223513;8970.41692289999;8994;4599.862004139881;4622.838200663028;4636.420447444069;4639;4656.557627025427;3657.0674478007936;3863.188730366598;3977.582353852804;4281.850135245251;4307.052448461333;3584.462330650423;3602.189507360823;3630.945535816965;3693.7229707772026;3734.141147536082;1204.265398107154;1245.7383949370553;1252.630474010169;1255.5793809074062;1265.5697062998624;790.6876783670418;870.3907264914459;905.3803339517625;914.3736540469799;935.6210734652477;5263.921041184385;5395.190721391823;5414.512693857493;5425.810096646598;5610.747516361774;415.1841631194717;428.53503948216536;433.8850204695758;438.3709377043952;450.31776858060067;3707.073231692077;3720.869769558107;3786.8295926683363;3807.0672685192303;3819.4079917612817;9019.233365164035;9469.100435458759;9487.383320084173;9548.236141108695;9563.569639366246;9377.718668439958;9398.389104708309;9408.905910940939;9417.670381536613;9430.90569094314;7047;7254.96372518134;7329.706811727578;7354.70581176747;7356.668949897267;5263.947360526499;5311.946880531145;5376.220448035091;5494.423085575957;5563.360213575491;8627.69803056915;8674.956625216833;8746;8763.649454022023;8785.12148785142;8664.78338041554;8803.955980220058;8808.779780505538;8914.687985920462;8936.508492033001;6204.286507051746;6561.507886908596;6765;6825.965870170618;6945.722171113099;7203.279672032755;7243.275672432715;7260.854782904206;7328.523645962995;7340.11918569775;6448.387403196689;6612.603243805387;6640.90038649411;6656.600603963778;6727.730890764315;6400.103985442135;6403.903941440975;6601.801945941629;6627.801165965029;6649.73401063952;6389.520785941166;6472;6475.481961442979;6478.805635830932;6485.935140648533;4650.255959046536;4687.39063921688;4718.056388722338;4762.9285560715925;4774.95225047745;4455.420795296591;4559.45286565601;4680.5085466025575;4684.273937539687;4736.73947932867 20:10:27 INFO - PROCESS | 13425 | |4;prototype.html;299.24291542397725;309.11746962422285;313.0327288677985;317.9713825755682;325.59463467982357;5249.790008399669;5364.517193452589;5413.296271484706;5531.557475401968;5569.944300556993;5439.401665816757;5466.508014278714;5468.343798744157;5472.1244600863865;5484.533814625762;4205.537390887008;4241.575842415765;4246.554111818261;4251.5535868733805;4254.680898932577;4149.605787450202;4234.449521562193;4242.130363275536;4247.341662042389;4252.978735106336;4174.791260436981;4190.455240818689;4202.117555313388;4208.579142085782;4210.347396153601;4171.270027745132;4185.727927684706;4197.580241975808;4219.620234178908;4246.447961764981;3715.9628403716156;3745.6628903398823;3745.771266096668;3748.3253014457387;3756.398976163801;4947.529984651453;5200.76596553156;5223.085959956992;5250.264962905197;5295.073362161645;4768.807798050488;4791.688540244908;4802;4826.589739872115;4831.4926932671915;5420.268263784378;5733.31200255972;5770.394108618577;5783.132530120473;5798.304203495608;3964.185428345878;3988.960110398888;3993.2612466693754;3996.500437445319;4010.137820368635;6012.96993515034;6063.666498342589;6072.574919755619;6073.208403520972;6098.664573448458;3971.1155477418292;4104.240715467648;4104.8768536943935;4120.979395103005;4131.834726610962;4149.792510374529;4166.812493437803;4167.562405947392;4170.457840480779;4190.664746820247;4788.95211047892;4791.353167322437;4793.161196790547;4804.807807687654;4812.807487700523;5100.336956195671;5660.603757736919;5698.373178950312;5735.885282294331;5743.396943320975;1403.361470530906;1451.5137428961204;1453.0482533940285;1455.083297522554;1457.227669335254;947.5357075033185;949.7720547068792;969.2730452160879;970.8446648536342;983.2772911909741;4916.975415122973;4928.753562321869;4942.2438946401;4942.75286235694;4945.925811112764;5910.8817823643285;5947.167396564484;5950.940490595125;5951.910721339097;5954.7320370582565;4678.906421871544;4907.87730306738;4933.161362568372;4936.3829521309835;4943.6786608871025;3184.490481522945;3227.564278822329;3248.5776849009476;3253.251752097031;3259.1689119274433;5631;5631.831045068655;5636.267285252891;5637.295338082739;5642.407547207484;5910.852228694231;6109;6118.847028824315;6157.907631385443;6195.535334849904;5566.248556444909;5572.972135139298;5590.5248053915875;5614.522765564972;5621.606487545832;5643.435656434323;5955.40445955401;5960.4635582797755;5995.190649262294;6041.24484439445;5888.263967004124;5899.203607512931;5900.0264956281735;5901.645901245939;5924.111383292368;5558.944410555842;5595.524380427709;5611.494965453129;5631.774729010794;5639.351474580476;4037.2127435149864;4248.957510424856;4254.064105896698;4259.38238955356;4261.552536983572;5672.234248376416;5794.1308803679785;5926.407359264039;5941.881162376815;5974.9103763444455;5757.769689212385;5772.913406298825;5776.508996735324;5807.303123625192;5815.331236907809;5729.799457018984;5762;5784.768609255582;5786.4213578643485;5787.421257874179;5583.385827559046;5689.800856969986;5701.315842098975;5713.628614140234;5736.569757268305;5793.304803423616;5799.652020878592;5808.5062769665055;5818.156367326798;5819.214406055128;5499.120140777616;5673.06394444912;5673.971630141823;5679.74441150141;5680.488756011979 20:10:27 INFO - PROCESS | 13425 | |5;yui.html;763.4007304266153;770.6378002338902;773.8993930789001;775.75175943698;792.9444938854275;11303.26528775631;11322.60370887019;11326.490307936143;11540.884591154076;11689.473973671184;11882.168248222628;12086.637400877966;12159.878401215985;12598.748025039517;12600.747985040316;638.8339031851729;787.7518581646791;800.1118758178432;807.8505476486869;812.2405550809982;806.0408114343941;808.030363563723;808.0424696734359;813.7233340664174;813.8168911994784;851.7657644147878;855.6363545493172;855.9786005349854;856.6316483911916;856.6316483911916;849.8597731374316;851.4423052900361;851.8466675998318;854.7905763088052;855.3969451536652;614.9815505534841;618.505195843328;620.3920158244945;620.5811077522654;621.5773274173561;12155.574554890536;12194;12224.960878325353;12249.203801752858;12314.261144331369;12888;13132.0807543472;13178.209307441584;13209.273489958048;13342.599722008355;10150.796984060351;10176.236782241362;10265.948670256601;10283.691489255334;10421.635242766466;3364.96635033649;3395.4058039843176;3410.2326976430104;3416.521686963827;3439.4496880499;48280.7585962068;48399.516004839854;48491.272630910564;48852.267215991786;49151.50848491505;9267.67563135287;9319.90680093204;9438.811223775487;9538.856917146248;9663.323567350219;17865.821341786417;17961.461156165336;17983.1008449577;18021.45935621907;18052.9097354515;6967.372936435644;6980.197277313073;7129.89305160423;7145.857082858418;7146.499745017799;3871.3225185592974;3917.314469967744;3917.764934103963;3918.275119102975;3930.8427662893164;2782.4017836164917;2814.32456210508;2860.084772872702;2860.184847318504;2864.4271145770513;497.7884399130355;502.50754260824596;515.1114327784617;515.5823782735996;522.4096770649143;498.0686116961306;630.7981445937256;633.8098570428945;635.5011316116826;636.0776873533302;7971.920280797234;8178.141295163922;8258.752237432887;8463.873041904377;8506.31949444043;630.3736360190697;637.7704026550438;639.4947991086989;662.7084083003463;663.1577896071962;3810.4855844460644;3953.4069889516804;4030.2544029354663;4087.570805065485;4093.3859921012086;53083.893890097825;54407.45592544024;54540.18189727157;54695.45304546904;54766;45610.08779824385;47591.5240847594;48304.516954830004;48625;49875.25187122196;44110.11779764387;44175;44382.33426498605;44563.33155002678;44982.55017449784;7561.206073362438;7759.107702614272;7773.455858089879;7791.883121753065;7897.302080052817;30176.69823301739;30382.696173038872;30633.23416914595;30699.693003070577;30814;37425.4386184202;38643.227135457695;41603.583964159974;41763.37354939617;42203;9854.162396196403;9959.302848800515;9991.550380233053;10229.488525573543;10231.13035392;10818.1345492362;10940.835887461853;10945.83581246266;10997.835032474359;11051.060659844003;9894.20846332306;9902.603895844086;9932.205423566242;10037.598496060076;10387.68836934893;9872.308938374244;10104.747381315527;10287.738289489227;10313.680896599928;10380.636677716244;9896.505174741378;9897.703068907944;9931.406344042629;9944.651937182163;9982.950085249528;8472.703455379033;8721.575497568689;8848.336374772047;8897.866532001895;9032.86450703227;8722.607482663423;8744.475331480131;8808.647654093764;8818.944546492628;9043.909560904307 20:10:27 INFO - PROCESS | 13425 | __end_tp_report 20:10:27 INFO - PROCESS | 13425 | __start_cc_report 20:10:27 INFO - PROCESS | 13425 | _x_x_mozilla_cycle_collect,373 20:10:27 INFO - PROCESS | 13425 | __end_cc_report 20:10:27 INFO - PROCESS | 13425 | __startTimestamp1461467427450__endTimestamp 20:10:27 INFO - PROCESS | 13425 | 20:10:27 INFO - PROCESS | 13425 | ------- Summary: start ------- 20:10:27 INFO - PROCESS | 13425 | Number of tests: 6 20:10:27 INFO - PROCESS | 13425 | 20:10:27 INFO - PROCESS | 13425 | [#0] dojo.html Cycles:165 Average:4744.75 Median:4910.17 stddev:600.08 (12.2%) stddev-sans-first:579.19 20:10:27 INFO - PROCESS | 13425 | Values: 2659.5 2694.9 2733.7 2740.3 2749.6 4742.8 4767.0 4791.1 4804.3 4847.5 4728.7 4747.8 4808.7 4812.8 4838.1 4402.3 4461.9 4522.8 4537.5 4557.2 616.3 4334.6 4375.5 4393.1 4402.3 4333.0 4334.3 4411.5 4424.5 4543.6 4388.6 4389.3 4390.3 4407.8 4437.0 4276.6 4374.7 4378.5 4382.8 4416.8 4655.4 4672.9 4677.1 4680.8 4744.5 5093.0 5130.0 5140.1 5152.4 5175.8 5083.8 5164.8 5220.7 5266.4 5296.2 4839.0 4860.1 4910.2 4910.8 4931.2 5392.5 5405.0 5406.1 5406.8 5408.4 4933.6 5110.7 5137.3 5146.6 5161.6 5119.8 5127.5 5136.7 5145.8 5146.1 5125.2 5129.6 5136.2 5141.1 5143.5 5027.1 5112.3 5143.7 5173.2 5226.8 4355.3 4378.8 4381.9 4382.3 4417.8 3766.1 3772.2 3806.4 3854.9 3866.7 4320.5 4398.3 4441.7 4449.3 4520.8 5194.6 5209.2 5215.4 5243.2 5285.8 4283.3 4474.4 4479.7 4485.6 4511.2 4698.2 4714.4 4720.9 4765.1 4779.4 4762.7 4813.3 4813.4 4819.9 4853.1 5042.8 5133.5 5148.3 5199.0 5216.5 4827.2 4842.0 4844.7 4868.7 4881.6 5114.8 5115.0 5115.8 5120.2 5121.5 4966.1 5142.2 5177.5 5180.9 5187.3 4991.1 5006.6 5013.1 5013.2 5041.6 4993.8 4998.8 5002.6 5012.0 5064.2 4866.1 4943.4 4962.5 4978.5 5044.5 5054.6 5086.0 5091.3 5106.3 5140.1 4959.8 4969.1 4973.4 4987.8 4995.0 20:10:27 INFO - PROCESS | 13425 | 20:10:27 INFO - PROCESS | 13425 | [#1] ext.html Cycles:180 Average:41320.85 Median:34231.40 stddev:75356.66 (220.1%) stddev-sans-first:75505.96 20:10:27 INFO - PROCESS | 13425 | Values: 575.5 610.4 617.1 628.8 638.5 34269.3 35365.6 35426.3 35477.8 35546.6 36285.5 36857.0 36900.8 36926.6 36955.8 7461.9 7589.8 7627.6 7629.5 7632.3 6770.3 6791.6 7140.4 7146.4 7157.9 6754.7 6777.4 6798.2 6799.9 7027.2 6752.1 6763.1 6769.1 6788.2 7031.4 7617.4 7648.9 7731.8 7734.7 7736.4 29148.3 36289.3 36780.3 36865.6 36885.8 2884.4 2915.7 3093.8 3111.2 3222.4 24218.6 24284.9 24317.4 24766.9 25111.5 3109.5 3251.1 3253.8 3294.7 3380.2 168283.0 168724.0 169620.0 170003.0 171372.0 32946.5 34193.5 48248.0 48563.5 48653.3 31450.0 31553.2 31608.5 31614.4 31719.4 12199.5 12340.9 12411.1 12449.1 12473.8 10731.1 10736.0 10775.6 10809.2 10821.3 8133.5 8151.9 8168.1 8209.6 8231.4 3196.8 3204.3 3280.4 3287.4 3289.6 974.5 990.3 1036.3 1057.3 1077.7 27713.9 28176.3 28625.6 29678.3 30011.2 953.5 982.4 993.0 1007.5 1055.3 13542.3 13895.4 14051.4 14088.5 14282.6 347220.0 350868.0 354174.0 354780.0 355802.0 46519.3 47187.0 47503.3 47680.5 47749.0 1210.0 1259.9 1278.8 1301.3 1313.3 26002.6 26900.3 26947.2 27326.5 27619.2 40749.6 41804.8 42028.2 42066.6 42128.0 297904.0 300175.0 302367.0 302824.0 304556.0 24180.8 24353.4 24571.8 24581.5 24612.3 38868.2 39901.6 40108.4 40157.2 40165.0 33841.0 34812.7 35232.3 35339.0 35629.6 34318.0 34977.7 35259.8 35527.3 35620.6 30192.4 33044.3 34583.7 35224.0 35471.5 27106.3 27963.6 28024.7 28082.6 28292.6 22114.0 22287.3 22342.4 22460.4 22668.2 20:10:27 INFO - PROCESS | 13425 | 20:10:27 INFO - PROCESS | 13425 | [#2] jquery.html Cycles:180 Average:21932.29 Median:4416.37 stddev:53944.68 (1221.5%) stddev-sans-first:54071.74 20:10:27 INFO - PROCESS | 13425 | Values: 381.2 387.6 389.7 390.6 397.7 15086.0 16041.8 16179.7 16187.9 16223.0 15470.0 16209.4 16923.0 16976.7 17007.0 5004.5 5220.5 5292.6 5294.6 5300.7 3692.6 5720.4 6104.7 6110.1 6110.5 4912.4 6007.1 6007.8 6015.6 6022.9 5154.0 5163.8 5186.4 5190.5 5217.2 4967.3 5207.6 5388.2 5401.9 5426.3 11716.5 11958.3 11998.9 12037.6 12526.9 1907.6 1927.4 1971.1 1997.4 2485.2 8562.2 8831.8 9228.7 9256.4 9272.6 1758.9 1801.5 1818.9 1845.4 1863.4 66727.0 68210.7 68592.0 69478.0 69883.0 9776.6 9973.7 10187.3 10243.9 10275.5 13829.7 14090.4 14096.5 14099.0 14117.4 7224.2 7282.7 7316.3 7448.3 7451.8 6665.1 6675.5 6773.2 6820.7 6947.4 4411.5 4421.2 4431.0 4431.2 4432.6 1696.9 1823.5 1899.6 1899.9 1917.3 905.6 915.0 932.9 938.5 1006.9 15094.6 15476.9 16031.3 16249.3 16540.4 848.3 857.7 858.2 879.9 922.5 9083.7 9251.7 9285.5 9333.7 9399.3 306511.0 311643.0 313927.0 316115.0 371011.0 66635.7 71081.3 71405.3 72005.0 73920.3 979.9 997.6 1016.6 1064.8 1069.2 15294.5 15317.7 15365.2 15478.9 15538.9 35046.5 35459.5 35483.5 36023.5 36633.5 47397.4 49405.3 49759.6 49813.5 50411.2 7457.6 7657.7 7806.7 7910.9 7943.2 11017.5 11589.9 11689.9 11706.4 11918.5 10030.3 10060.4 10371.6 10456.9 10487.4 9284.5 10210.4 10599.1 10626.3 10634.2 9601.1 10334.7 10400.3 10566.3 10750.7 7612.8 7626.2 7652.7 7814.9 7865.6 9377.9 10371.5 10606.7 10665.1 10794.9 20:10:27 INFO - PROCESS | 13425 | 20:10:27 INFO - PROCESS | 13425 | [#3] mootools.html Cycles:180 Average:5101.48 Median:5263.93 stddev:2800.97 (53.2%) stddev-sans-first:2795.51 20:10:27 INFO - PROCESS | 13425 | Values: 1465.9 1499.9 1608.6 1753.0 1809.9 6835.7 7457.3 7477.3 7725.9 7740.5 7551.6 7552.8 7585.4 7635.7 7646.2 2211.9 2230.7 2233.8 2237.8 2238.0 2188.1 2197.2 2239.9 2247.0 2251.7 2228.5 2256.9 2268.7 2276.1 2295.3 2202.1 2204.3 2209.4 2217.3 2221.9 2134.9 2138.6 2151.2 2154.5 2156.7 7453.9 7606.4 7654.6 7666.0 7684.8 4569.5 4767.7 4773.9 4774.3 4781.5 2807.3 2958.1 2963.1 2972.6 2985.5 918.1 918.5 925.0 926.3 951.5 10370.1 10439.2 10456.1 10473.8 10483.7 4208.5 4234.5 4353.5 4384.4 4410.4 8912.1 8936.5 8937.0 8970.4 8994.0 4599.9 4622.8 4636.4 4639.0 4656.6 3657.1 3863.2 3977.6 4281.9 4307.1 3584.5 3602.2 3630.9 3693.7 3734.1 1204.3 1245.7 1252.6 1255.6 1265.6 790.7 870.4 905.4 914.4 935.6 5263.9 5395.2 5414.5 5425.8 5610.7 415.2 428.5 433.9 438.4 450.3 3707.1 3720.9 3786.8 3807.1 3819.4 9019.2 9469.1 9487.4 9548.2 9563.6 9377.7 9398.4 9408.9 9417.7 9430.9 7047.0 7255.0 7329.7 7354.7 7356.7 5263.9 5311.9 5376.2 5494.4 5563.4 8627.7 8675.0 8746.0 8763.6 8785.1 8664.8 8804.0 8808.8 8914.7 8936.5 6204.3 6561.5 6765.0 6826.0 6945.7 7203.3 7243.3 7260.9 7328.5 7340.1 6448.4 6612.6 6640.9 6656.6 6727.7 6400.1 6403.9 6601.8 6627.8 6649.7 6389.5 6472.0 6475.5 6478.8 6485.9 4650.3 4687.4 4718.1 4762.9 4775.0 4455.4 4559.5 4680.5 4684.3 4736.7 20:10:27 INFO - PROCESS | 13425 | 20:10:27 INFO - PROCESS | 13425 | [#4] prototype.html Cycles:180 Average:4753.36 Median:5452.95 stddev:1399.17 (25.7%) stddev-sans-first:1362.57 20:10:27 INFO - PROCESS | 13425 | Values: 299.2 309.1 313.0 318.0 325.6 5249.8 5364.5 5413.3 5531.6 5569.9 5439.4 5466.5 5468.3 5472.1 5484.5 4205.5 4241.6 4246.6 4251.6 4254.7 4149.6 4234.4 4242.1 4247.3 4253.0 4174.8 4190.5 4202.1 4208.6 4210.3 4171.3 4185.7 4197.6 4219.6 4246.4 3716.0 3745.7 3745.8 3748.3 3756.4 4947.5 5200.8 5223.1 5250.3 5295.1 4768.8 4791.7 4802.0 4826.6 4831.5 5420.3 5733.3 5770.4 5783.1 5798.3 3964.2 3989.0 3993.3 3996.5 4010.1 6013.0 6063.7 6072.6 6073.2 6098.7 3971.1 4104.2 4104.9 4121.0 4131.8 4149.8 4166.8 4167.6 4170.5 4190.7 4789.0 4791.4 4793.2 4804.8 4812.8 5100.3 5660.6 5698.4 5735.9 5743.4 1403.4 1451.5 1453.0 1455.1 1457.2 947.5 949.8 969.3 970.8 983.3 4917.0 4928.8 4942.2 4942.8 4945.9 5910.9 5947.2 5950.9 5951.9 5954.7 4678.9 4907.9 4933.2 4936.4 4943.7 3184.5 3227.6 3248.6 3253.3 3259.2 5631.0 5631.8 5636.3 5637.3 5642.4 5910.9 6109.0 6118.8 6157.9 6195.5 5566.2 5573.0 5590.5 5614.5 5621.6 5643.4 5955.4 5960.5 5995.2 6041.2 5888.3 5899.2 5900.0 5901.6 5924.1 5558.9 5595.5 5611.5 5631.8 5639.4 4037.2 4249.0 4254.1 4259.4 4261.6 5672.2 5794.1 5926.4 5941.9 5974.9 5757.8 5772.9 5776.5 5807.3 5815.3 5729.8 5762.0 5784.8 5786.4 5787.4 5583.4 5689.8 5701.3 5713.6 5736.6 5793.3 5799.7 5808.5 5818.2 5819.2 5499.1 5673.1 5674.0 5679.7 5680.5 20:10:27 INFO - PROCESS | 13425 | 20:10:27 INFO - PROCESS | 13425 | [#5] yui.html Cycles:180 Average:12930.23 Median:508.81 stddev:15111.25 (2969.9%) stddev-sans-first:15126.02 20:10:27 INFO - PROCESS | 13425 | Values: 763.4 770.6 773.9 775.8 792.9 11303.3 11322.6 11326.5 11540.9 11689.5 11882.2 12086.6 12159.9 12598.7 12600.7 638.8 787.8 800.1 807.9 812.2 806.0 808.0 808.0 813.7 813.8 851.8 855.6 856.0 856.6 856.6 849.9 851.4 851.8 854.8 855.4 615.0 618.5 620.4 620.6 621.6 12155.6 12194.0 12225.0 12249.2 12314.3 12888.0 13132.1 13178.2 13209.3 13342.6 10150.8 10176.2 10265.9 10283.7 10421.6 3365.0 3395.4 3410.2 3416.5 3439.4 48280.8 48399.5 48491.3 48852.3 49151.5 9267.7 9319.9 9438.8 9538.9 9663.3 17865.8 17961.5 17983.1 18021.5 18052.9 6967.4 6980.2 7129.9 7145.9 7146.5 3871.3 3917.3 3917.8 3918.3 3930.8 2782.4 2814.3 2860.1 2860.2 2864.4 497.8 502.5 515.1 515.6 522.4 498.1 630.8 633.8 635.5 636.1 7971.9 8178.1 8258.8 8463.9 8506.3 630.4 637.8 639.5 662.7 663.2 3810.5 3953.4 4030.3 4087.6 4093.4 53083.9 54407.5 54540.2 54695.5 54766.0 45610.1 47591.5 48304.5 48625.0 49875.3 44110.1 44175.0 44382.3 44563.3 44982.6 7561.2 7759.1 7773.5 7791.9 7897.3 30176.7 30382.7 30633.2 30699.7 30814.0 37425.4 38643.2 41603.6 41763.4 42203.0 9854.2 9959.3 9991.6 10229.5 10231.1 10818.1 10940.8 10945.8 10997.8 11051.1 9894.2 9902.6 9932.2 10037.6 10387.7 9872.3 10104.7 10287.7 10313.7 10380.6 9896.5 9897.7 9931.4 9944.7 9983.0 8472.7 8721.6 8848.3 8897.9 9032.9 8722.6 8744.5 8808.6 8818.9 9043.9 20:10:27 INFO - PROCESS | 13425 | -------- Summary: end -------- 20:10:27 INFO - PROCESS | 13425 | 20:10:28 INFO - TEST-INFO | 13425: exit 0 20:10:28 INFO - TEST-OK | dromaeo_css | took 1115580ms 20:10:28 INFO - TEST-START | kraken 20:10:28 INFO - operating with platform_type : linux_ 20:10:28 INFO - Initialising browser for kraken test... 20:10:28 INFO - TEST-INFO | started process 13659 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpj1GMuZ/profile http://localhost:56208/getInfo.html) 20:10:32 INFO - PROCESS | 13659 | 20:10:32 INFO - PROCESS | 13659 | (process:13725): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 20:10:32 INFO - PROCESS | 13659 | __metrics Screen width/height:1600/1200 20:10:32 INFO - PROCESS | 13659 | colorDepth:24 20:10:32 INFO - PROCESS | 13659 | Browser inner width/height: 1024/697 20:10:32 INFO - PROCESS | 13659 | __metrics 20:10:33 ERROR - PROCESS | 13659 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 20:10:34 INFO - TEST-INFO | 13659: exit 0 20:10:34 INFO - Browser initialized. 20:10:34 INFO - Running cycle 1/1 for kraken test... 20:10:34 INFO - TEST-INFO | started process 13776 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpj1GMuZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:10:36 INFO - PROCESS | 13776 | 20:10:36 INFO - PROCESS | 13776 | (process:13836): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 20:10:46 INFO - PROCESS | 13776 | RSS: Main: 165994496 20:10:46 INFO - PROCESS | 13776 | 20:10:49 INFO - PROCESS | 13776 | Cycle 1(1): loaded http://localhost:56208/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56208/tests/kraken/driver.html?testName=audio-beat-detection) 20:10:50 INFO - PROCESS | 13776 | RSS: Main: 170033152 20:10:50 INFO - PROCESS | 13776 | 20:10:52 INFO - PROCESS | 13776 | Cycle 1(1): loaded http://localhost:56208/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56208/tests/kraken/driver.html?testName=audio-dft) 20:10:53 INFO - PROCESS | 13776 | RSS: Main: 172883968 20:10:53 INFO - PROCESS | 13776 | 20:10:56 INFO - PROCESS | 13776 | Cycle 1(1): loaded http://localhost:56208/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56208/tests/kraken/driver.html?testName=audio-fft) 20:10:57 INFO - PROCESS | 13776 | RSS: Main: 164524032 20:10:57 INFO - PROCESS | 13776 | 20:10:59 INFO - PROCESS | 13776 | Cycle 1(1): loaded http://localhost:56208/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56208/tests/kraken/driver.html?testName=audio-oscillator) 20:10:59 INFO - PROCESS | 13776 | RSS: Main: 165015552 20:10:59 INFO - PROCESS | 13776 | 20:11:02 INFO - PROCESS | 13776 | Cycle 1(1): loaded http://localhost:56208/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56208/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:11:02 INFO - PROCESS | 13776 | RSS: Main: 166035456 20:11:02 INFO - PROCESS | 13776 | 20:11:06 INFO - PROCESS | 13776 | Cycle 1(1): loaded http://localhost:56208/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56208/tests/kraken/driver.html?testName=imaging-darkroom) 20:11:06 INFO - PROCESS | 13776 | RSS: Main: 166141952 20:11:06 INFO - PROCESS | 13776 | 20:11:10 INFO - PROCESS | 13776 | Cycle 1(1): loaded http://localhost:56208/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56208/tests/kraken/driver.html?testName=imaging-desaturate) 20:11:10 INFO - PROCESS | 13776 | RSS: Main: 165240832 20:11:10 INFO - PROCESS | 13776 | 20:11:13 INFO - PROCESS | 13776 | Cycle 1(1): loaded http://localhost:56208/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56208/tests/kraken/driver.html?testName=json-parse-financial) 20:11:14 INFO - PROCESS | 13776 | RSS: Main: 165982208 20:11:14 INFO - PROCESS | 13776 | 20:11:16 INFO - PROCESS | 13776 | Cycle 1(1): loaded http://localhost:56208/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56208/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:11:16 INFO - PROCESS | 13776 | RSS: Main: 166264832 20:11:16 INFO - PROCESS | 13776 | 20:11:18 INFO - PROCESS | 13776 | Cycle 1(1): loaded http://localhost:56208/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56208/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:11:19 INFO - PROCESS | 13776 | RSS: Main: 166064128 20:11:19 INFO - PROCESS | 13776 | 20:11:21 INFO - PROCESS | 13776 | Cycle 1(1): loaded http://localhost:56208/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56208/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:11:22 INFO - PROCESS | 13776 | RSS: Main: 166686720 20:11:22 INFO - PROCESS | 13776 | 20:11:24 INFO - PROCESS | 13776 | Cycle 1(1): loaded http://localhost:56208/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56208/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:11:25 INFO - PROCESS | 13776 | RSS: Main: 167030784 20:11:25 INFO - PROCESS | 13776 | 20:11:28 INFO - PROCESS | 13776 | Cycle 1(1): loaded http://localhost:56208/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56208/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:11:29 INFO - PROCESS | 13776 | RSS: Main: 167022592 20:11:29 INFO - PROCESS | 13776 | 20:11:30 INFO - PROCESS | 13776 | Cycle 1(1): loaded http://localhost:56208/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56208/tests/kraken/driver.html?testName=ai-astar) 20:11:31 INFO - PROCESS | 13776 | RSS: Main: 168611840 20:11:31 INFO - PROCESS | 13776 | 20:11:31 INFO - PROCESS | 13776 | __start_tp_report 20:11:31 INFO - PROCESS | 13776 | _x_x_mozilla_page_load 20:11:31 INFO - PROCESS | 13776 | _x_x_mozilla_page_load_details 20:11:31 INFO - PROCESS | 13776 | |i|pagename|runs| 20:11:31 INFO - PROCESS | 13776 | |0;ai-astar;115;108;114;114;115;128;116;113;116;116 20:11:31 INFO - PROCESS | 13776 | |1;audio-beat-detection;158;133;155;185;132;158;172;142;206;134 20:11:31 INFO - PROCESS | 13776 | |2;audio-dft;163;162;164;169;162;162;162;165;165;162 20:11:31 INFO - PROCESS | 13776 | |3;audio-fft;77;85;75;170;78;75;77;73;157;77 20:11:31 INFO - PROCESS | 13776 | |4;audio-oscillator;95;97;149;96;94;95;156;94;93;145 20:11:31 INFO - PROCESS | 13776 | |5;imaging-gaussian-blur;119;119;118;118;117;118;118;119;117;117 20:11:31 INFO - PROCESS | 13776 | |6;imaging-darkroom;147;146;147;148;149;147;148;147;146;149 20:11:31 INFO - PROCESS | 13776 | |7;imaging-desaturate;98;95;95;96;96;95;95;95;96;95 20:11:31 INFO - PROCESS | 13776 | |8;json-parse-financial;67;67;69;70;74;67;66;81;64;64 20:11:31 INFO - PROCESS | 13776 | |9;json-stringify-tinderbox;64;65;65;65;65;64;65;64;65;68 20:11:31 INFO - PROCESS | 13776 | |10;stanford-crypto-aes;87;87;82;77;79;80;82;82;89;80 20:11:31 INFO - PROCESS | 13776 | |11;stanford-crypto-ccm;137;134;135;134;135;135;138;134;180;138 20:11:31 INFO - PROCESS | 13776 | |12;stanford-crypto-pbkdf2;179;181;177;175;176;171;173;184;178;174 20:11:31 INFO - PROCESS | 13776 | |13;stanford-crypto-sha256-iterative;73;77;72;73;74;72;76;75;73;72 20:11:31 INFO - PROCESS | 13776 | __end_tp_report 20:11:31 INFO - PROCESS | 13776 | __start_cc_report 20:11:31 INFO - PROCESS | 13776 | _x_x_mozilla_cycle_collect,929 20:11:31 INFO - PROCESS | 13776 | __end_cc_report 20:11:31 INFO - PROCESS | 13776 | __startTimestamp1461467491199__endTimestamp 20:11:31 INFO - PROCESS | 13776 | 20:11:31 INFO - PROCESS | 13776 | ------- Summary: start ------- 20:11:31 INFO - PROCESS | 13776 | Number of tests: 14 20:11:31 INFO - PROCESS | 13776 | 20:11:31 INFO - PROCESS | 13776 | [#0] ai-astar Cycles:10 Average:115.50 Median:115.50 stddev:4.99 (4.3%) stddev-sans-first:5.29 20:11:31 INFO - PROCESS | 13776 | Values: 115.0 108.0 114.0 114.0 115.0 128.0 116.0 113.0 116.0 116.0 20:11:31 INFO - PROCESS | 13776 | 20:11:31 INFO - PROCESS | 13776 | [#1] audio-beat-detection Cycles:10 Average:157.50 Median:158.00 stddev:24.42 (15.5%) stddev-sans-first:25.90 20:11:31 INFO - PROCESS | 13776 | Values: 158.0 133.0 155.0 185.0 132.0 158.0 172.0 142.0 206.0 134.0 20:11:31 INFO - PROCESS | 13776 | 20:11:31 INFO - PROCESS | 13776 | [#2] audio-dft Cycles:10 Average:163.60 Median:163.50 stddev:2.27 (1.4%) stddev-sans-first:2.40 20:11:31 INFO - PROCESS | 13776 | Values: 163.0 162.0 164.0 169.0 162.0 162.0 162.0 165.0 165.0 162.0 20:11:31 INFO - PROCESS | 13776 | 20:11:31 INFO - PROCESS | 13776 | [#3] audio-fft Cycles:10 Average:94.40 Median:77.00 stddev:36.68 (47.6%) stddev-sans-first:38.36 20:11:31 INFO - PROCESS | 13776 | Values: 77.0 85.0 75.0 170.0 78.0 75.0 77.0 73.0 157.0 77.0 20:11:31 INFO - PROCESS | 13776 | 20:11:31 INFO - PROCESS | 13776 | [#4] audio-oscillator Cycles:10 Average:111.40 Median:94.50 stddev:26.79 (28.3%) stddev-sans-first:27.75 20:11:31 INFO - PROCESS | 13776 | Values: 95.0 97.0 149.0 96.0 94.0 95.0 156.0 94.0 93.0 145.0 20:11:31 INFO - PROCESS | 13776 | 20:11:31 INFO - PROCESS | 13776 | [#5] imaging-gaussian-blur Cycles:10 Average:118.00 Median:118.00 stddev:0.82 (0.7%) stddev-sans-first:0.78 20:11:31 INFO - PROCESS | 13776 | Values: 119.0 119.0 118.0 118.0 117.0 118.0 118.0 119.0 117.0 117.0 20:11:31 INFO - PROCESS | 13776 | 20:11:31 INFO - PROCESS | 13776 | [#6] imaging-darkroom Cycles:10 Average:147.40 Median:147.50 stddev:1.07 (0.7%) stddev-sans-first:1.13 20:11:31 INFO - PROCESS | 13776 | Values: 147.0 146.0 147.0 148.0 149.0 147.0 148.0 147.0 146.0 149.0 20:11:31 INFO - PROCESS | 13776 | 20:11:31 INFO - PROCESS | 13776 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:95.50 stddev:0.97 (1.0%) stddev-sans-first:0.50 20:11:31 INFO - PROCESS | 13776 | Values: 98.0 95.0 95.0 96.0 96.0 95.0 95.0 95.0 96.0 95.0 20:11:31 INFO - PROCESS | 13776 | 20:11:31 INFO - PROCESS | 13776 | [#8] json-parse-financial Cycles:10 Average:68.90 Median:68.00 stddev:5.17 (7.6%) stddev-sans-first:5.44 20:11:31 INFO - PROCESS | 13776 | Values: 67.0 67.0 69.0 70.0 74.0 67.0 66.0 81.0 64.0 64.0 20:11:31 INFO - PROCESS | 13776 | 20:11:31 INFO - PROCESS | 13776 | [#9] json-stringify-tinderbox Cycles:10 Average:65.00 Median:65.00 stddev:1.15 (1.8%) stddev-sans-first:1.17 20:11:31 INFO - PROCESS | 13776 | Values: 64.0 65.0 65.0 65.0 65.0 64.0 65.0 64.0 65.0 68.0 20:11:31 INFO - PROCESS | 13776 | 20:11:31 INFO - PROCESS | 13776 | [#10] stanford-crypto-aes Cycles:10 Average:82.50 Median:82.00 stddev:3.92 (4.8%) stddev-sans-first:3.81 20:11:31 INFO - PROCESS | 13776 | Values: 87.0 87.0 82.0 77.0 79.0 80.0 82.0 82.0 89.0 80.0 20:11:31 INFO - PROCESS | 13776 | 20:11:31 INFO - PROCESS | 13776 | [#11] stanford-crypto-ccm Cycles:10 Average:140.00 Median:136.00 stddev:14.14 (10.4%) stddev-sans-first:14.96 20:11:31 INFO - PROCESS | 13776 | Values: 137.0 134.0 135.0 134.0 135.0 135.0 138.0 134.0 180.0 138.0 20:11:31 INFO - PROCESS | 13776 | 20:11:31 INFO - PROCESS | 13776 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.80 Median:177.50 stddev:3.88 (2.2%) stddev-sans-first:4.03 20:11:31 INFO - PROCESS | 13776 | Values: 179.0 181.0 177.0 175.0 176.0 171.0 173.0 184.0 178.0 174.0 20:11:31 INFO - PROCESS | 13776 | 20:11:31 INFO - PROCESS | 13776 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.70 Median:73.50 stddev:1.77 (2.4%) stddev-sans-first:1.86 20:11:31 INFO - PROCESS | 13776 | Values: 73.0 77.0 72.0 73.0 74.0 72.0 76.0 75.0 73.0 72.0 20:11:31 INFO - PROCESS | 13776 | -------- Summary: end -------- 20:11:31 INFO - PROCESS | 13776 | 20:11:32 INFO - TEST-INFO | 13776: exit 0 20:11:32 INFO - TEST-OK | kraken | took 64016ms 20:11:32 INFO - SUITE-END | took 1179s 20:11:32 INFO - Completed test suite (00:19:39) 20:11:32 INFO - javascript benchmark 20:11:32 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2659.507991021661, 2694.865256737163, 2733.658292713411, 2740.2738274357284, 2749.5738160585106, 4742.810287588497, 4766.952330476694, 4791.113643975863, 4804.255340422232, 4847.466778654345, 4728.66899317048, 4747.786349614267, 4808.7114773113635, 4812.8074877004965, 4838.056578967103, 4402.251617225072, 4461.910761784762, 4522.773861306938, 4537.546245375453, 4557.179707652621, 616.3115275129202, 4334.60988511034, 4375.51869294379, 4393.121375724868, 4402.339649052636, 4333.0, 4334.328179132223, 4411.514733379326, 4424.513303536608, 4543.568361005699, 4388.605025547684, 4389.297712366006, 4390.275604525282, 4407.779611019436, 4437.0460351024685, 4276.593723596254, 4374.671899607542, 4378.474583050022, 4382.780860956939, 4416.757078360689, 4655.37152484417, 4672.883177920545, 4677.111348843709, 4680.836170734042, 4744.525547445262, 5093.006863661588, 5129.9743501282255, 5140.1004824156, 5152.355955505562, 5175.792968281265, 5083.847484575469, 5164.767585458626, 5220.660657057279, 5266.4470230626, 5296.205569164617, 4839.0, 4860.076585448754, 4910.165271903785, 4910.754462276872, 4931.211006238985, 5392.5416339611575, 5404.972975135099, 5406.053940560386, 5406.756695948692, 5408.3509978802795, 4933.555979961749, 5110.744462776846, 5137.255098010767, 5146.639735218499, 5161.5870730341485, 5119.820806271762, 5127.461616530285, 5136.666116702402, 5145.819896303611, 5146.099432599281, 5125.231215317732, 5129.615278854101, 5136.178211486144, 5141.126008578551, 5143.485651434827, 5027.145385284511, 5112.284280200774, 5143.691378517226, 5173.249878767558, 5226.790928362823, 4355.324924636687, 4378.846740364072, 4381.890452738707, 4382.255016647114, 4417.823287068545, 3766.0961369271727, 3772.245550889833, 3806.352920003606, 3854.9398915298516, 3866.729328947003, 4320.503142138631, 4398.318260669537, 4441.68908176431, 4449.310356894686, 4520.841770538082, 5194.558462530727, 5209.1925751507815, 5215.374155101412, 5243.152433011059, 5285.762140703678, 4283.271843786564, 4474.351219073281, 4479.686421950498, 4485.596296333346, 4511.210538155809, 4698.1778188816825, 4714.363560919301, 4720.929186062212, 4765.142274390573, 4779.378680771478, 4762.738049407316, 4813.326134341195, 4813.374261346003, 4819.879503012453, 4853.053654537402, 5042.798288068583, 5133.512316329943, 5148.253503242084, 5199.038177937094, 5216.530512253916, 4827.203511420576, 4841.95158048415, 4844.733539655353, 4868.659193856396, 4881.633877459134, 5114.820981265638, 5114.974425127999, 5115.820946266863, 5120.206368012964, 5121.513456221653, 4966.081274964144, 5142.202958541432, 5177.4822517747925, 5180.948190518046, 5187.273781670494, 4991.07665081961, 5006.574441172395, 5013.122703526941, 5013.172826483589, 5041.6470847040355, 4993.775280112476, 4998.800047998185, 5002.599792016703, 5012.0, 5064.18972964324, 4866.099771542276, 4943.406791185081, 4962.454130045764, 4978.47725988766, 5044.54599086084, 5054.570361519312, 5086.033653605803, 5091.338126043591, 5106.2595923590125, 5140.100482415488, 4959.801607935642, 4969.105560999054, 4973.428055773487, 4987.825426110068, 4994.9500504994485], "value": 4708.167264872427, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [575.4676923845442, 610.41095342994, 617.1483352972897, 628.7767842415942, 638.5179189711766, 34269.31461370771, 35365.64634353656, 35426.2914741705, 35477.82261088697, 35546.64453355466, 36285.45571816425, 36857.0, 36900.815495922485, 36926.630733692655, 36955.81522092393, 7461.925380746205, 7589.772306830776, 7627.580483073429, 7629.465937384385, 7632.274933881273, 6770.32296770324, 6791.558548694319, 7140.393066589346, 7146.4282857371545, 7157.89263161053, 6754.729810807562, 6777.356151165656, 6798.150231221098, 6799.932000680004, 7027.191872934627, 6752.054712340252, 6763.053172555846, 6769.05233267343, 6788.185417749902, 7031.402330801888, 7617.352525035379, 7648.9235107648765, 7731.7680469586, 7734.690612375498, 7736.419768517328, 29148.27129321784, 36289.274214515826, 36780.26439471196, 36865.63134368676, 36885.81557092197, 2884.4086962172705, 2915.6792752797173, 3093.7989030713156, 3111.222194451387, 3222.419964406406, 24218.63672044921, 24284.878575607185, 24317.39206519851, 24766.876165619236, 25111.497770044498, 3109.5180247061517, 3251.122197006795, 3253.837308134584, 3294.67053294671, 3380.2056516718553, 168283.0, 168724.0, 169620.0, 170003.0, 171372.0, 32946.50580241298, 34193.487097693556, 48248.0, 48563.5143648559, 48653.270200947016, 31450.0, 31553.211169720482, 31608.525872111935, 31614.367712645617, 31719.365612687616, 12199.512019519298, 12340.876591233973, 12411.131220814455, 12449.066320026035, 12473.75052498945, 10731.087857532197, 10736.0, 10775.6228532001, 10809.189310801721, 10821.29661572011, 8133.454643617812, 8151.8777218341775, 8168.06067302256, 8209.58952052395, 8231.382646301552, 3196.7922085064397, 3204.327091310804, 3280.3603297356785, 3287.375398674244, 3289.5723555938052, 974.498133461268, 990.2968892086699, 1036.3108532825586, 1057.286331726082, 1077.671310250381, 27713.86143069272, 28176.29559261035, 28625.57061644077, 29678.258043549085, 30011.249718757204, 953.4851180362665, 982.4498280962683, 992.9950350248203, 1007.5063219022773, 1055.2876808154465, 13542.255175965416, 13895.374708138159, 14051.437942482391, 14088.506902258372, 14282.57152285433, 347220.0, 350868.0, 354174.0, 354780.0, 355802.0, 46519.30221046687, 47186.999999999316, 47503.287450688265, 47680.5231947683, 47749.04501910012, 1209.9939500302619, 1259.924404535731, 1278.8145718870712, 1301.316808675434, 1313.2908229555933, 26002.60996085098, 26900.327491812863, 26947.191584252505, 27326.45347093007, 27619.171424857286, 40749.59250407458, 41804.79097604614, 42028.15943681171, 42066.57933420627, 42128.0, 297904.0, 300175.0, 302367.0, 302824.0, 304556.0, 24180.758192417852, 24353.39116522101, 24571.754282457663, 24581.508369832147, 24612.261632151065, 38868.22263554657, 39901.60098398979, 40108.39837402383, 40157.196856063296, 40165.0, 33841.0, 34812.651873481955, 35232.29535409329, 35339.0, 35629.64370356367, 34318.0, 34977.65022349744, 35259.823700882356, 35527.289454211284, 35620.643793561736, 30192.396152077275, 33044.339113218084, 34583.65416345804, 35223.975200800516, 35471.467927980586, 27106.32234194161, 27963.58054629223, 28024.71975280221, 28082.578761319004, 28292.575611365435, 22114.0, 22287.331380058626, 22342.441438963506, 22460.438489037904, 22668.206612769132], "value": 15545.743197828051, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [381.2337202223531, 387.6433681013467, 389.72719096632346, 390.6406106382128, 397.73749325445175, 15086.0, 16041.839581604181, 16179.676406471894, 16187.919060404682, 16223.02661840289, 15470.0, 16209.432669856558, 16923.0, 16976.74534881978, 17007.0, 5004.54959053686, 5220.504052115043, 5292.55013323866, 5294.629375943686, 5300.708461034642, 3692.593814680383, 5720.399358067405, 6104.664243466607, 6110.083487476892, 6110.480609148228, 4912.410510738699, 6007.068904319815, 6007.8197654070445, 6015.578909476339, 6022.909656355158, 5154.046501397253, 5163.7676304566385, 5186.403563590197, 5190.4809519047985, 5217.165253559431, 4967.304577359173, 5207.609429292818, 5388.164834450667, 5401.918971215396, 5426.2674538937135, 11716.472758725879, 11958.342291173982, 11998.880011199864, 12037.638870833889, 12526.874731252661, 1907.6089401672623, 1927.3543362973421, 1971.122850331603, 1997.439690770427, 2485.192312498445, 8562.186592273723, 8831.77920551985, 9228.723138305862, 9256.398334108262, 9272.582733776997, 1758.8592912566965, 1801.4505575799376, 1818.8635852310997, 1845.4463660901677, 1863.413024897153, 66727.0, 68210.65894670544, 68592.0, 69478.0, 69882.99999999949, 9776.608935642495, 9973.700788976343, 10187.337823041627, 10243.897561024443, 10275.537600807982, 13829.654258643413, 14090.365933533016, 14096.506622268376, 14099.0, 14117.364718587689, 7224.241454647292, 7282.708691652275, 7316.304951029643, 7448.292412220831, 7451.776446706607, 6665.100211471487, 6675.499337549703, 6773.221079575814, 6820.6930688119155, 6947.3747362737595, 4411.514733379326, 4421.2262854001065, 4431.047324825178, 4431.224535706238, 4432.601065904084, 1696.8642508599282, 1823.4803081121815, 1899.6295722334012, 1899.8765080269739, 1917.3481016454473, 905.6151135767404, 915.0, 932.9253659707207, 938.5354249646332, 1006.8873894346641, 15094.622634434007, 15476.922615387077, 16031.278592463366, 16249.268782904797, 16540.421085261958, 848.325581162977, 857.652650676477, 858.1590041759112, 879.8768172455862, 922.4603606890045, 9083.727488175233, 9251.722448326562, 9285.535723213947, 9333.719988400358, 9399.34204605671, 306511.0, 311643.0, 313927.0, 316115.0, 371011.0, 66635.66682166558, 71081.28918710747, 71405.2859471409, 72005.0, 73920.26079739134, 979.9363041402286, 997.6159178716101, 1016.5577973581368, 1064.808334499782, 1069.2354966199205, 15294.464693735667, 15317.693646127238, 15365.231738412811, 15478.9226053869, 15538.922305388402, 35046.47430288599, 35459.46810797788, 35483.467747984316, 36023.45964810478, 36633.45049824201, 47397.35979180863, 49405.25892111549, 49759.59741909797, 49813.501864980884, 50411.243831343294, 7457.589832559044, 7657.693692252247, 7806.726764563213, 7910.920890791019, 7943.165967573553, 11017.504212310305, 11589.884101159218, 11689.88310116888, 11706.35615041181, 11918.52325906954, 10030.29787914839, 10060.39637621745, 10371.58513659445, 10456.947715261374, 10487.37075775456, 9284.535773211448, 10210.438425886647, 10599.099076578577, 10626.309289896131, 10634.202434817575, 9601.087896649808, 10334.741631459274, 10400.323978941344, 10566.26036177491, 10750.677479675622, 7612.7716168515035, 7626.161122276434, 7652.693892244248, 7814.88277675824, 7865.6460459280615, 9377.906220937703, 10371.481425928825, 10606.681799546026, 10665.146788256765, 10794.892051079703], "value": 8078.949024724663, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1465.8900582456317, 1499.8725108365786, 1608.6300150965278, 1753.0, 1809.9276028958834, 6835.658217089151, 7457.328840404362, 7477.2896574825445, 7725.92274077259, 7740.458167928247, 7551.622418879061, 7552.848943021137, 7585.393168546517, 7635.694572217105, 7646.235376462351, 2211.944701382466, 2230.7434645015787, 2233.798958093771, 2237.7538470768204, 2238.0, 2188.102877820094, 2197.230969160789, 2239.8880055997133, 2246.9551658478804, 2251.7297924249115, 2228.4985878177363, 2256.8871556422196, 2268.6823844661762, 2276.112316196685, 2295.334353037617, 2202.1411649456722, 2204.2836078274463, 2209.3924170853065, 2217.2793842001415, 2221.911123555056, 2134.925277615276, 2138.647123224666, 2151.2363111095647, 2154.4721543222013, 2156.6657168138963, 7453.888191677129, 7606.429517786189, 7654.578998155099, 7666.041744781903, 7684.846303073963, 4569.451665800092, 4767.737774422405, 4773.856784296477, 4774.259989701602, 4781.545753153445, 2807.3122085089285, 2958.097780177045, 2963.0518234165074, 2972.5541168824634, 2985.507391280436, 918.1002617434951, 918.5040078357746, 925.0, 926.2589928057527, 951.4624237305969, 10370.066693997502, 10439.217058720626, 10456.058954694037, 10473.847876733553, 10483.685489435253, 4208.494980602347, 4234.513031001413, 4353.521112677603, 4384.364267181241, 4410.360497727876, 8912.108789121035, 8936.46381217129, 8936.955315223513, 8970.41692289999, 8994.0, 4599.862004139881, 4622.838200663028, 4636.420447444069, 4639.0, 4656.557627025427, 3657.0674478007936, 3863.188730366598, 3977.582353852804, 4281.850135245251, 4307.052448461333, 3584.462330650423, 3602.189507360823, 3630.945535816965, 3693.7229707772026, 3734.141147536082, 1204.265398107154, 1245.7383949370553, 1252.630474010169, 1255.5793809074062, 1265.5697062998624, 790.6876783670418, 870.3907264914459, 905.3803339517625, 914.3736540469799, 935.6210734652477, 5263.921041184385, 5395.190721391823, 5414.512693857493, 5425.810096646598, 5610.747516361774, 415.1841631194717, 428.53503948216536, 433.8850204695758, 438.3709377043952, 450.31776858060067, 3707.073231692077, 3720.869769558107, 3786.8295926683363, 3807.0672685192303, 3819.4079917612817, 9019.233365164035, 9469.100435458759, 9487.383320084173, 9548.236141108695, 9563.569639366246, 9377.718668439958, 9398.389104708309, 9408.905910940939, 9417.670381536613, 9430.90569094314, 7047.0, 7254.96372518134, 7329.706811727578, 7354.70581176747, 7356.668949897267, 5263.947360526499, 5311.946880531145, 5376.220448035091, 5494.423085575957, 5563.360213575491, 8627.69803056915, 8674.956625216833, 8746.0, 8763.649454022023, 8785.12148785142, 8664.78338041554, 8803.955980220058, 8808.779780505538, 8914.687985920462, 8936.508492033001, 6204.286507051746, 6561.507886908596, 6765.0, 6825.965870170618, 6945.722171113099, 7203.279672032755, 7243.275672432715, 7260.854782904206, 7328.523645962995, 7340.11918569775, 6448.387403196689, 6612.603243805387, 6640.90038649411, 6656.600603963778, 6727.730890764315, 6400.103985442135, 6403.903941440975, 6601.801945941629, 6627.801165965029, 6649.73401063952, 6389.520785941166, 6472.0, 6475.481961442979, 6478.805635830932, 6485.935140648533, 4650.255959046536, 4687.39063921688, 4718.056388722338, 4762.9285560715925, 4774.95225047745, 4455.420795296591, 4559.45286565601, 4680.5085466025575, 4684.273937539687, 4736.73947932867], "value": 4086.636978869259, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [299.24291542397725, 309.11746962422285, 313.0327288677985, 317.9713825755682, 325.59463467982357, 5249.790008399669, 5364.517193452589, 5413.296271484706, 5531.557475401968, 5569.944300556993, 5439.401665816757, 5466.508014278714, 5468.343798744157, 5472.1244600863865, 5484.533814625762, 4205.537390887008, 4241.575842415765, 4246.554111818261, 4251.5535868733805, 4254.680898932577, 4149.605787450202, 4234.449521562193, 4242.130363275536, 4247.341662042389, 4252.978735106336, 4174.791260436981, 4190.455240818689, 4202.117555313388, 4208.579142085782, 4210.347396153601, 4171.270027745132, 4185.727927684706, 4197.580241975808, 4219.620234178908, 4246.447961764981, 3715.9628403716156, 3745.6628903398823, 3745.771266096668, 3748.3253014457387, 3756.398976163801, 4947.529984651453, 5200.76596553156, 5223.085959956992, 5250.264962905197, 5295.073362161645, 4768.807798050488, 4791.688540244908, 4802.0, 4826.589739872115, 4831.4926932671915, 5420.268263784378, 5733.31200255972, 5770.394108618577, 5783.132530120473, 5798.304203495608, 3964.185428345878, 3988.960110398888, 3993.2612466693754, 3996.500437445319, 4010.137820368635, 6012.96993515034, 6063.666498342589, 6072.574919755619, 6073.208403520972, 6098.664573448458, 3971.1155477418292, 4104.240715467648, 4104.8768536943935, 4120.979395103005, 4131.834726610962, 4149.792510374529, 4166.812493437803, 4167.562405947392, 4170.457840480779, 4190.664746820247, 4788.95211047892, 4791.353167322437, 4793.161196790547, 4804.807807687654, 4812.807487700523, 5100.336956195671, 5660.603757736919, 5698.373178950312, 5735.885282294331, 5743.396943320975, 1403.361470530906, 1451.5137428961204, 1453.0482533940285, 1455.083297522554, 1457.227669335254, 947.5357075033185, 949.7720547068792, 969.2730452160879, 970.8446648536342, 983.2772911909741, 4916.975415122973, 4928.753562321869, 4942.2438946401, 4942.75286235694, 4945.925811112764, 5910.8817823643285, 5947.167396564484, 5950.940490595125, 5951.910721339097, 5954.7320370582565, 4678.906421871544, 4907.87730306738, 4933.161362568372, 4936.3829521309835, 4943.6786608871025, 3184.490481522945, 3227.564278822329, 3248.5776849009476, 3253.251752097031, 3259.1689119274433, 5631.0, 5631.831045068655, 5636.267285252891, 5637.295338082739, 5642.407547207484, 5910.852228694231, 6109.0, 6118.847028824315, 6157.907631385443, 6195.535334849904, 5566.248556444909, 5572.972135139298, 5590.5248053915875, 5614.522765564972, 5621.606487545832, 5643.435656434323, 5955.40445955401, 5960.4635582797755, 5995.190649262294, 6041.24484439445, 5888.263967004124, 5899.203607512931, 5900.0264956281735, 5901.645901245939, 5924.111383292368, 5558.944410555842, 5595.524380427709, 5611.494965453129, 5631.774729010794, 5639.351474580476, 4037.2127435149864, 4248.957510424856, 4254.064105896698, 4259.38238955356, 4261.552536983572, 5672.234248376416, 5794.1308803679785, 5926.407359264039, 5941.881162376815, 5974.9103763444455, 5757.769689212385, 5772.913406298825, 5776.508996735324, 5807.303123625192, 5815.331236907809, 5729.799457018984, 5762.0, 5784.768609255582, 5786.4213578643485, 5787.421257874179, 5583.385827559046, 5689.800856969986, 5701.315842098975, 5713.628614140234, 5736.569757268305, 5793.304803423616, 5799.652020878592, 5808.5062769665055, 5818.156367326798, 5819.214406055128, 5499.120140777616, 5673.06394444912, 5673.971630141823, 5679.74441150141, 5680.488756011979], "value": 4301.1961017604435, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [763.4007304266153, 770.6378002338902, 773.8993930789001, 775.75175943698, 792.9444938854275, 11303.26528775631, 11322.60370887019, 11326.490307936143, 11540.884591154076, 11689.473973671184, 11882.168248222628, 12086.637400877966, 12159.878401215985, 12598.748025039517, 12600.747985040316, 638.8339031851729, 787.7518581646791, 800.1118758178432, 807.8505476486869, 812.2405550809982, 806.0408114343941, 808.030363563723, 808.0424696734359, 813.7233340664174, 813.8168911994784, 851.7657644147878, 855.6363545493172, 855.9786005349854, 856.6316483911916, 856.6316483911916, 849.8597731374316, 851.4423052900361, 851.8466675998318, 854.7905763088052, 855.3969451536652, 614.9815505534841, 618.505195843328, 620.3920158244945, 620.5811077522654, 621.5773274173561, 12155.574554890536, 12194.0, 12224.960878325353, 12249.203801752858, 12314.261144331369, 12888.0, 13132.0807543472, 13178.209307441584, 13209.273489958048, 13342.599722008355, 10150.796984060351, 10176.236782241362, 10265.948670256601, 10283.691489255334, 10421.635242766466, 3364.96635033649, 3395.4058039843176, 3410.2326976430104, 3416.521686963827, 3439.4496880499, 48280.7585962068, 48399.516004839854, 48491.272630910564, 48852.267215991786, 49151.50848491505, 9267.67563135287, 9319.90680093204, 9438.811223775487, 9538.856917146248, 9663.323567350219, 17865.821341786417, 17961.461156165336, 17983.1008449577, 18021.45935621907, 18052.9097354515, 6967.372936435644, 6980.197277313073, 7129.89305160423, 7145.857082858418, 7146.499745017799, 3871.3225185592974, 3917.314469967744, 3917.764934103963, 3918.275119102975, 3930.8427662893164, 2782.4017836164917, 2814.32456210508, 2860.084772872702, 2860.184847318504, 2864.4271145770513, 497.7884399130355, 502.50754260824596, 515.1114327784617, 515.5823782735996, 522.4096770649143, 498.0686116961306, 630.7981445937256, 633.8098570428945, 635.5011316116826, 636.0776873533302, 7971.920280797234, 8178.141295163922, 8258.752237432887, 8463.873041904377, 8506.31949444043, 630.3736360190697, 637.7704026550438, 639.4947991086989, 662.7084083003463, 663.1577896071962, 3810.4855844460644, 3953.4069889516804, 4030.2544029354663, 4087.570805065485, 4093.3859921012086, 53083.893890097825, 54407.45592544024, 54540.18189727157, 54695.45304546904, 54766.0, 45610.08779824385, 47591.5240847594, 48304.516954830004, 48625.0, 49875.25187122196, 44110.11779764387, 44175.0, 44382.33426498605, 44563.33155002678, 44982.55017449784, 7561.206073362438, 7759.107702614272, 7773.455858089879, 7791.883121753065, 7897.302080052817, 30176.69823301739, 30382.696173038872, 30633.23416914595, 30699.693003070577, 30814.0, 37425.4386184202, 38643.227135457695, 41603.583964159974, 41763.37354939617, 42203.0, 9854.162396196403, 9959.302848800515, 9991.550380233053, 10229.488525573543, 10231.13035392, 10818.1345492362, 10940.835887461853, 10945.83581246266, 10997.835032474359, 11051.060659844003, 9894.20846332306, 9902.603895844086, 9932.205423566242, 10037.598496060076, 10387.68836934893, 9872.308938374244, 10104.747381315527, 10287.738289489227, 10313.680896599928, 10380.636677716244, 9896.505174741378, 9897.703068907944, 9931.406344042629, 9944.651937182163, 9982.950085249528, 8472.703455379033, 8721.575497568689, 8848.336374772047, 8897.866532001895, 9032.86450703227, 8722.607482663423, 8744.475331480131, 8808.647654093764, 8818.944546492628, 9043.909560904307], "value": 5939.459467961488, "unit": "score"}], "name": "dromaeo_css", "value": 6286.757542243664, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 108.0, 114.0, 114.0, 115.0, 128.0, 116.0, 113.0, 116.0, 116.0], "value": 115.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 133.0, 155.0, 185.0, 132.0, 158.0, 172.0, 142.0, 206.0, 134.0], "value": 157.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 164.0, 169.0, 162.0, 162.0, 162.0, 165.0, 165.0, 162.0], "value": 163.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 85.0, 75.0, 170.0, 78.0, 75.0, 77.0, 73.0, 157.0, 77.0], "value": 94.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 97.0, 149.0, 96.0, 94.0, 95.0, 156.0, 94.0, 93.0, 145.0], "value": 111.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 119.0, 118.0, 118.0, 117.0, 118.0, 118.0, 119.0, 117.0, 117.0], "value": 118.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 147.0, 148.0, 149.0, 147.0, 148.0, 147.0, 146.0, 149.0], "value": 147.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 95.0, 95.0, 96.0, 96.0, 95.0, 95.0, 95.0, 96.0, 95.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 69.0, 70.0, 74.0, 67.0, 66.0, 81.0, 64.0, 64.0], "value": 68.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 65.0, 65.0, 65.0, 64.0, 65.0, 64.0, 65.0, 68.0], "value": 65.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 82.0, 77.0, 79.0, 80.0, 82.0, 82.0, 89.0, 80.0], "value": 82.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 134.0, 135.0, 134.0, 135.0, 135.0, 138.0, 134.0, 180.0, 138.0], "value": 140.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 181.0, 177.0, 175.0, 176.0, 171.0, 173.0, 184.0, 178.0, 174.0], "value": 176.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 77.0, 72.0, 73.0, 74.0, 72.0, 76.0, 75.0, 73.0, 72.0], "value": 73.7, "unit": "score"}], "name": "kraken", "value": 1610.3, "alertThreshold": 2.0}]} 20:11:32 INFO - Return code: 0 20:11:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 20:11:32 ERROR - # TBPL SUCCESS # 20:11:32 INFO - Running post-action listener: _resource_record_post_action 20:11:32 INFO - Running post-run listener: _resource_record_post_run 20:11:33 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 4096; Write bytes: 518832128; Read time: 16; Write time: 460612 20:11:33 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 234577920; Read time: 0; Write time: 254648 20:11:33 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 4096; Write bytes: 282734592; Read time: 16; Write time: 205884 20:11:33 INFO - Running post-run listener: _upload_blobber_files 20:11:33 INFO - Blob upload gear active. 20:11:33 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:11:33 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 20:11:33 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', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:11:33 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 Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:11:34 INFO - (blobuploader) - INFO - Open directory for files ... 20:11:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 20:11:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:11:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:11:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 20:11:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:11:34 INFO - (blobuploader) - INFO - Done attempting. 20:11:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 20:11:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:11:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:11:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 20:11:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:11:35 INFO - (blobuploader) - INFO - Done attempting. 20:11:35 INFO - (blobuploader) - INFO - Iteration through files over. 20:11:35 INFO - Return code: 0 20:11:35 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:11:35 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:11:35 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/32b2f9d732c969b3beb7b0cf13cf18da1dd5fdc486694359e3b79b6c145cda451eb28fbe8d27d2211559195f8de9a7bb8293dd4e96c6c3e61cf23656ab8377fe", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/800d2c891c95e23847159b29bd7edce926cf751708da4461b942cc2daea321f93b29d3e3da1e635b406239e4c321ae75a735fa9895f4e7e2cd3a531171cf4b6b"} 20:11:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:11:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:11:35 INFO - Contents: 20:11:35 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/32b2f9d732c969b3beb7b0cf13cf18da1dd5fdc486694359e3b79b6c145cda451eb28fbe8d27d2211559195f8de9a7bb8293dd4e96c6c3e61cf23656ab8377fe", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/800d2c891c95e23847159b29bd7edce926cf751708da4461b942cc2daea321f93b29d3e3da1e635b406239e4c321ae75a735fa9895f4e7e2cd3a531171cf4b6b"} 20:11:35 INFO - Running post-run listener: copy_logs_to_upload_dir 20:11:35 INFO - Copying logs to upload dir... 20:11:35 INFO - mkdir: /builds/slave/test/build/upload/logs 20:11:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.853697 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-04-23 20:11:35.431425) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-23 20:11:35.435497) ========= 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=41bf3e9aed84707956354da8000001c5-1461462925.912122-2000355471 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/Firefox-Non-PGO/sha512/32b2f9d732c969b3beb7b0cf13cf18da1dd5fdc486694359e3b79b6c145cda451eb28fbe8d27d2211559195f8de9a7bb8293dd4e96c6c3e61cf23656ab8377fe", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/800d2c891c95e23847159b29bd7edce926cf751708da4461b942cc2daea321f93b29d3e3da1e635b406239e4c321ae75a735fa9895f4e7e2cd3a531171cf4b6b"} build_url:https://queue.taskcluster.net/v1/task/PkjyxxzxTE6x9odUV932Mw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011115 build_url: 'https://queue.taskcluster.net/v1/task/PkjyxxzxTE6x9odUV932Mw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/32b2f9d732c969b3beb7b0cf13cf18da1dd5fdc486694359e3b79b6c145cda451eb28fbe8d27d2211559195f8de9a7bb8293dd4e96c6c3e61cf23656ab8377fe", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/800d2c891c95e23847159b29bd7edce926cf751708da4461b942cc2daea321f93b29d3e3da1e635b406239e4c321ae75a735fa9895f4e7e2cd3a531171cf4b6b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-23 20:11:35.459786) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 20:11:35.460145) ========= 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=41bf3e9aed84707956354da8000001c5-1461462925.912122-2000355471 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004397 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 20:11:35.544248) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-23 20:11:35.544707) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-23 20:11:35.545107) ========= ========= Total master_lag: 0.17 =========