builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-017 starttime: 1469139116.78 results: success (0) buildid: 20160721122919 builduid: e8a2fa54ac4f4284b19c92c533ed26aa revision: ccf0f9620bdcd4378568c385b9d936f38ce1fb97 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-21 15:11:56.793248) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-21 15:11:56.793764) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-21 15:11:56.794042) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-21 15:11:56.809063) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 15:11:56.809421) ========= 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=0333a256a5e4f052382dd180000001b1-1469133520.357670-2070270743 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-21 15:11:56-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.4M=0s 2016-07-21 15:11:57 (43.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.089951 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 15:11:56.919331) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 15:11:56.922653) ========= 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=0333a256a5e4f052382dd180000001b1-1469133520.357670-2070270743 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023038 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 15:11:56.972197) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-21 15:11:56.972559) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev ccf0f9620bdcd4378568c385b9d936f38ce1fb97 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev ccf0f9620bdcd4378568c385b9d936f38ce1fb97 --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=0333a256a5e4f052382dd180000001b1-1469133520.357670-2070270743 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-21 15:11:57,142 truncating revision to first 12 chars 2016-07-21 15:11:57,142 Setting DEBUG logging. 2016-07-21 15:11:57,142 attempt 1/10 2016-07-21 15:11:57,142 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/ccf0f9620bdc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-21 15:11:58,333 unpacking tar archive at: mozilla-beta-ccf0f9620bdc/testing/mozharness/ program finished with exit code 0 elapsedTime=1.530461 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-21 15:11:58.519643) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-21 15:11:58.519949) ========= script_repo_revision: ccf0f9620bdcd4378568c385b9d936f38ce1fb97 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-21 15:11:58.520331) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-21 15:11:58.523628) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-21 15:11:58.533962) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-07-21 15:11:58.534226) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0333a256a5e4f052382dd180000001b1-1469133520.357670-2070270743 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:11:58 INFO - MultiFileLogger online at 20160721 15:11:58 in /builds/slave/test 15:11:58 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 15:11:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:11:58 INFO - {'append_to_log': False, 15:11:58 INFO - 'base_work_dir': '/builds/slave/test', 15:11:58 INFO - 'blob_upload_branch': 'Mozilla-Beta', 15:11:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:11:58 INFO - 'branch': 'Mozilla-Beta', 15:11:58 INFO - 'buildbot_json_path': 'buildprops.json', 15:11:58 INFO - 'config_files': ('talos/linux_config.py',), 15:11:58 INFO - 'default_actions': ('clobber', 15:11:58 INFO - 'read-buildbot-config', 15:11:58 INFO - 'download-and-extract', 15:11:58 INFO - 'populate-webroot', 15:11:58 INFO - 'create-virtualenv', 15:11:58 INFO - 'install', 15:11:58 INFO - 'run-tests'), 15:11:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:11:58 INFO - 'download_minidump_stackwalk': True, 15:11:58 INFO - 'download_symbols': 'ondemand', 15:11:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:11:58 INFO - 'tooltool.py': '/tools/tooltool.py', 15:11:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:11:58 INFO - '/tools/misc-python/virtualenv.py')}, 15:11:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:11:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:11:58 INFO - 'installer_path': 'installer.exe', 15:11:58 INFO - 'log_level': 'info', 15:11:58 INFO - 'log_name': 'talos', 15:11:58 INFO - 'log_to_console': True, 15:11:58 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:11:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:11:58 INFO - 'opt_config_files': (), 15:11:58 INFO - 'pip_index': False, 15:11:58 INFO - 'sps_profile': False, 15:11:58 INFO - 'sps_profile_interval': 0, 15:11:58 INFO - 'suite': 'dromaeojs-e10s', 15:11:58 INFO - 'system_bits': '32', 15:11:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:11:58 INFO - 'title': 'talos-linux64-ix-017', 15:11:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:11:58 INFO - 'use_talos_json': True, 15:11:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:11:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:11:58 INFO - 'work_dir': 'build'} 15:11:58 INFO - ##### 15:11:58 INFO - ##### Running clobber step. 15:11:58 INFO - ##### 15:11:58 INFO - Running pre-action listener: _resource_record_pre_action 15:11:58 INFO - Running main action method: clobber 15:11:58 INFO - rmtree: /builds/slave/test/build 15:11:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:11:59 INFO - Running post-action listener: _resource_record_post_action 15:11:59 INFO - ##### 15:11:59 INFO - ##### Running read-buildbot-config step. 15:11:59 INFO - ##### 15:11:59 INFO - Running pre-action listener: _resource_record_pre_action 15:11:59 INFO - Running main action method: read_buildbot_config 15:11:59 INFO - Using buildbot properties: 15:11:59 INFO - { 15:11:59 INFO - "project": "", 15:11:59 INFO - "product": "firefox", 15:11:59 INFO - "script_repo_revision": "production", 15:11:59 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 15:11:59 INFO - "repository": "", 15:11:59 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 15:11:59 INFO - "buildid": "20160721122919", 15:11:59 INFO - "pgo_build": "True", 15:11:59 INFO - "basedir": "/builds/slave/test", 15:11:59 INFO - "buildnumber": 183, 15:11:59 INFO - "slavename": "talos-linux64-ix-017", 15:11:59 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 15:11:59 INFO - "platform": "ubuntu64_hw", 15:11:59 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 15:11:59 INFO - "branch": "mozilla-beta", 15:11:59 INFO - "repo_path": "releases/mozilla-beta", 15:11:59 INFO - "revision": "ccf0f9620bdcd4378568c385b9d936f38ce1fb97", 15:11:59 INFO - "stage_platform": "linux64-pgo", 15:11:59 INFO - "builduid": "e8a2fa54ac4f4284b19c92c533ed26aa", 15:11:59 INFO - "slavebuilddir": "test" 15:11:59 INFO - } 15:11:59 INFO - Found installer url https://queue.taskcluster.net/v1/task/FeI_Bo_6RJStGWc9KBpq0Q/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2. 15:11:59 INFO - Running post-action listener: _resource_record_post_action 15:11:59 INFO - ##### 15:11:59 INFO - ##### Running download-and-extract step. 15:11:59 INFO - ##### 15:11:59 INFO - Running pre-action listener: _resource_record_pre_action 15:11:59 INFO - Running main action method: download_and_extract 15:11:59 INFO - mkdir: /builds/slave/test/build/tests 15:11:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:11:59 INFO - https://queue.taskcluster.net/v1/task/FeI_Bo_6RJStGWc9KBpq0Q/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 15:11:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FeI_Bo_6RJStGWc9KBpq0Q/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 15:11:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FeI_Bo_6RJStGWc9KBpq0Q/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 15:11:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FeI_Bo_6RJStGWc9KBpq0Q/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 15:11:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FeI_Bo_6RJStGWc9KBpq0Q/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 15:12:01 INFO - Downloaded 1327 bytes. 15:12:01 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 15:12:01 INFO - Using the following test package requirements: 15:12:01 INFO - {u'common': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 15:12:01 INFO - u'cppunittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 15:12:01 INFO - u'firefox-48.0.en-US.linux-x86_64.cppunittest.tests.zip'], 15:12:01 INFO - u'gtest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 15:12:01 INFO - u'firefox-48.0.en-US.linux-x86_64.gtest.tests.zip'], 15:12:01 INFO - u'jittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 15:12:01 INFO - u'jsshell-linux-x86_64.zip'], 15:12:01 INFO - u'mochitest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 15:12:01 INFO - u'firefox-48.0.en-US.linux-x86_64.mochitest.tests.zip'], 15:12:01 INFO - u'mozbase': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 15:12:01 INFO - u'reftest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 15:12:01 INFO - u'firefox-48.0.en-US.linux-x86_64.reftest.tests.zip'], 15:12:01 INFO - u'talos': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 15:12:01 INFO - u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'], 15:12:01 INFO - u'web-platform': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 15:12:01 INFO - u'firefox-48.0.en-US.linux-x86_64.web-platform.tests.zip'], 15:12:01 INFO - u'xpcshell': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 15:12:01 INFO - u'firefox-48.0.en-US.linux-x86_64.xpcshell.tests.zip']} 15:12:01 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:12:01 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')]} 15:12:01 INFO - https://queue.taskcluster.net/v1/task/FeI_Bo_6RJStGWc9KBpq0Q/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:12:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FeI_Bo_6RJStGWc9KBpq0Q/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 15:12:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FeI_Bo_6RJStGWc9KBpq0Q/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 15:12:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FeI_Bo_6RJStGWc9KBpq0Q/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 15:12:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FeI_Bo_6RJStGWc9KBpq0Q/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:12:03 INFO - Downloaded 24199861 bytes. 15:12:03 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:12:03 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 15:12:04 INFO - Return code: 0 15:12:04 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 15:12:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:12:04 INFO - https://queue.taskcluster.net/v1/task/FeI_Bo_6RJStGWc9KBpq0Q/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:12:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FeI_Bo_6RJStGWc9KBpq0Q/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 15:12:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FeI_Bo_6RJStGWc9KBpq0Q/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 15:12:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FeI_Bo_6RJStGWc9KBpq0Q/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 15:12:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FeI_Bo_6RJStGWc9KBpq0Q/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:12:22 INFO - Downloaded 24199861 bytes. 15:12:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:12:22 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 15:12:24 INFO - Return code: 0 15:12:24 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')]} 15:12:24 INFO - https://queue.taskcluster.net/v1/task/FeI_Bo_6RJStGWc9KBpq0Q/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:12:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FeI_Bo_6RJStGWc9KBpq0Q/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 15:12:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FeI_Bo_6RJStGWc9KBpq0Q/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 15:12:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FeI_Bo_6RJStGWc9KBpq0Q/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 15:12:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FeI_Bo_6RJStGWc9KBpq0Q/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:12:24 INFO - Downloaded 10840145 bytes. 15:12:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:12:24 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 15:12:25 INFO - Return code: 0 15:12: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')]} 15:12:25 INFO - https://queue.taskcluster.net/v1/task/FeI_Bo_6RJStGWc9KBpq0Q/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:12:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FeI_Bo_6RJStGWc9KBpq0Q/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 15:12:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FeI_Bo_6RJStGWc9KBpq0Q/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 15:12:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FeI_Bo_6RJStGWc9KBpq0Q/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 15:12:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FeI_Bo_6RJStGWc9KBpq0Q/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 15:12:26 INFO - Downloaded 56031470 bytes. 15:12:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FeI_Bo_6RJStGWc9KBpq0Q/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 15:12:26 INFO - mkdir: /builds/slave/test/properties 15:12:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:12:26 INFO - Writing to file /builds/slave/test/properties/build_url 15:12:26 INFO - Contents: 15:12:26 INFO - build_url:https://queue.taskcluster.net/v1/task/FeI_Bo_6RJStGWc9KBpq0Q/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 15:12:27 INFO - Running post-action listener: _resource_record_post_action 15:12:27 INFO - Running post-action listener: set_extra_try_arguments 15:12:27 INFO - ##### 15:12:27 INFO - ##### Running populate-webroot step. 15:12:27 INFO - ##### 15:12:27 INFO - Running pre-action listener: _resource_record_pre_action 15:12:27 INFO - Running main action method: populate_webroot 15:12:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:12:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:12:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:12:27 INFO - '--tppagecycles', 15:12:27 INFO - '7'], 15:12:27 INFO - 'tests': ['tsvgm']}}, 15:12:27 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:12:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:12:27 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:12:27 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:12:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:12:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:12:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:12:27 INFO - 'talos_options': ['--disable-e10s'], 15:12:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:12:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:12:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:12:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:12:27 INFO - 'talos_options': ['--disable-e10s'], 15:12:27 INFO - 'tests': ['damp', 'tps']}, 15:12:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:12:27 INFO - 'tests': ['damp', 'tps']}, 15:12:27 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:12:27 INFO - 'tests': ['dromaeo_dom']}, 15:12:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:12:27 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:12:27 INFO - 'tests': ['a11yr', 15:12:27 INFO - 'ts_paint', 15:12:27 INFO - 'tpaint', 15:12:27 INFO - 'sessionrestore', 15:12:27 INFO - 'sessionrestore_no_auto_restore', 15:12:27 INFO - 'tabpaint']}, 15:12:27 INFO - 'other-e10s': {'tests': ['a11yr', 15:12:27 INFO - 'ts_paint', 15:12:27 INFO - 'tpaint', 15:12:27 INFO - 'sessionrestore', 15:12:27 INFO - 'sessionrestore_no_auto_restore', 15:12:27 INFO - 'tabpaint']}, 15:12:27 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:12:27 INFO - 'ts_paint', 15:12:27 INFO - 'tpaint', 15:12:27 INFO - 'sessionrestore', 15:12:27 INFO - 'sessionrestore_no_auto_restore', 15:12:27 INFO - 'tabpaint']}, 15:12:27 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:12:27 INFO - 'ts_paint', 15:12:27 INFO - 'tpaint', 15:12:27 INFO - 'sessionrestore', 15:12:27 INFO - 'sessionrestore_no_auto_restore', 15:12:27 INFO - 'tabpaint']}, 15:12:27 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:12:27 INFO - 'tests': ['a11yr', 15:12:27 INFO - 'ts_paint', 15:12:27 INFO - 'tpaint', 15:12:27 INFO - 'sessionrestore', 15:12:27 INFO - 'sessionrestore_no_auto_restore', 15:12:27 INFO - 'tabpaint']}, 15:12:27 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:12:27 INFO - 'tests': ['a11yr', 15:12:27 INFO - 'ts_paint', 15:12:27 INFO - 'tpaint', 15:12:27 INFO - 'sessionrestore', 15:12:27 INFO - 'sessionrestore_no_auto_restore', 15:12:27 INFO - 'tabpaint']}, 15:12:27 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:12:27 INFO - 'tests': ['tsvgx', 15:12:27 INFO - 'tsvgr_opacity', 15:12:27 INFO - 'tart', 15:12:27 INFO - 'tscrollx', 15:12:27 INFO - 'cart']}, 15:12:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:12:27 INFO - 'tsvgr_opacity', 15:12:27 INFO - 'tart', 15:12:27 INFO - 'tscrollx', 15:12:27 INFO - 'cart']}, 15:12:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:12:27 INFO - 'talos_options': ['--disable-e10s'], 15:12:27 INFO - 'tests': ['tp5o']}, 15:12:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:12:27 INFO - 'tests': ['tp5o']}, 15:12:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:12:27 INFO - 'talos_options': ['--disable-e10s', 15:12:27 INFO - '--xperf_path', 15:12:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:12:27 INFO - 'tests': ['tp5n']}, 15:12:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:12:27 INFO - 'talos_options': ['--xperf_path', 15:12:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:12:27 INFO - 'tests': ['tp5n']}}, 15:12:27 INFO - 'talos.zip': {'path': '', 15:12:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:12:27 INFO - Running post-action listener: _resource_record_post_action 15:12:27 INFO - ##### 15:12:27 INFO - ##### Running create-virtualenv step. 15:12:27 INFO - ##### 15:12:27 INFO - Running pre-action listener: _resource_record_pre_action 15:12:27 INFO - Running main action method: create_virtualenv 15:12:27 INFO - Creating virtualenv /builds/slave/test/build/venv 15:12:27 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 15:12:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:12:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:12:27 INFO - Using real prefix '/usr' 15:12:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:12:27 INFO - Installing distribute.............................................................................................................................................................................................done. 15:12:29 INFO - Installing pip.................done. 15:12:29 INFO - Return code: 0 15:12:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:12: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')]} 15:12:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:12:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:12: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')]} 15:12:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:12:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:12: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc2e323af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21cb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22965a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2325410>, '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 0x2326310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23267a0>, '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': '0333a256a5e4f052382dd180000001b1-1469133520.357670-2070270743', '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 15:12: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', 'pip>=1.5'] in /builds/slave/test/build 15:12: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 pip>=1.5 15:12:29 INFO - Using env: {'DISPLAY': ':0', 15:12:29 INFO - 'HOME': '/home/cltbld', 15:12:29 INFO - 'LANG': 'en_US.UTF-8', 15:12:29 INFO - 'LANGUAGE': 'en_US:en', 15:12:29 INFO - 'LOGNAME': 'cltbld', 15:12:29 INFO - 'MAIL': '/var/mail/cltbld', 15:12:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:12:29 INFO - 'MOZ_NO_REMOTE': '1', 15:12:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:12:29 INFO - 'NO_EM_RESTART': '1', 15:12:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:12:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:12:29 INFO - 'PWD': '/builds/slave/test', 15:12:29 INFO - 'SHELL': '/bin/bash', 15:12:29 INFO - 'SHLVL': '1', 15:12:29 INFO - 'TERM': 'linux', 15:12:29 INFO - 'TMOUT': '86400', 15:12:29 INFO - 'USER': 'cltbld', 15:12:29 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1469133520.357670-2070270743', 15:12:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:12:29 INFO - '_': '/tools/buildbot/bin/python'} 15:12:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:12:29 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 15:12:29 INFO - Cleaning up... 15:12:29 INFO - Return code: 0 15:12:29 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 15:12: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')]} 15:12:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:12:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:12: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')]} 15:12:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:12:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:12: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', '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 0x7fc2e323af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21cb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22965a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2325410>, '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 0x2326310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23267a0>, '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': '0333a256a5e4f052382dd180000001b1-1469133520.357670-2070270743', '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 15:12: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', 'psutil>=0.7.1'] in /builds/slave/test/build 15:12: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 psutil>=0.7.1 15:12:29 INFO - Using env: {'DISPLAY': ':0', 15:12:29 INFO - 'HOME': '/home/cltbld', 15:12:29 INFO - 'LANG': 'en_US.UTF-8', 15:12:29 INFO - 'LANGUAGE': 'en_US:en', 15:12:29 INFO - 'LOGNAME': 'cltbld', 15:12:29 INFO - 'MAIL': '/var/mail/cltbld', 15:12:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:12:29 INFO - 'MOZ_NO_REMOTE': '1', 15:12:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:12:29 INFO - 'NO_EM_RESTART': '1', 15:12:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:12:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:12:29 INFO - 'PWD': '/builds/slave/test', 15:12:29 INFO - 'SHELL': '/bin/bash', 15:12:29 INFO - 'SHLVL': '1', 15:12:29 INFO - 'TERM': 'linux', 15:12:29 INFO - 'TMOUT': '86400', 15:12:29 INFO - 'USER': 'cltbld', 15:12:29 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1469133520.357670-2070270743', 15:12:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:12:29 INFO - '_': '/tools/buildbot/bin/python'} 15:12:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:12:30 INFO - Downloading/unpacking psutil>=0.7.1 15:12:30 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 15:12:30 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 15:12:30 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 15:12:30 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 15:12:30 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 15:12:30 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 15:12:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:12:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:12:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:12:32 INFO - Installing collected packages: psutil 15:12:32 INFO - Running setup.py install for psutil 15:12:32 INFO - building 'psutil._psutil_linux' extension 15:12:32 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 15:12:32 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 15:12:32 INFO - building 'psutil._psutil_posix' extension 15:12:32 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 15:12:32 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 15:12:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:12:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:12:32 INFO - Successfully installed psutil 15:12:32 INFO - Cleaning up... 15:12:32 INFO - Return code: 0 15:12:32 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 15:12: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')]} 15:12:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:12:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:12: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')]} 15:12:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:12:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:12: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', '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 0x7fc2e323af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21cb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22965a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2325410>, '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 0x2326310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23267a0>, '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': '0333a256a5e4f052382dd180000001b1-1469133520.357670-2070270743', '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 15:12: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 15:12: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 mozsystemmonitor==0.0.0 15:12:32 INFO - Using env: {'DISPLAY': ':0', 15:12:32 INFO - 'HOME': '/home/cltbld', 15:12:32 INFO - 'LANG': 'en_US.UTF-8', 15:12:32 INFO - 'LANGUAGE': 'en_US:en', 15:12:32 INFO - 'LOGNAME': 'cltbld', 15:12:32 INFO - 'MAIL': '/var/mail/cltbld', 15:12:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:12:32 INFO - 'MOZ_NO_REMOTE': '1', 15:12:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:12:32 INFO - 'NO_EM_RESTART': '1', 15:12:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:12:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:12:32 INFO - 'PWD': '/builds/slave/test', 15:12:32 INFO - 'SHELL': '/bin/bash', 15:12:32 INFO - 'SHLVL': '1', 15:12:32 INFO - 'TERM': 'linux', 15:12:32 INFO - 'TMOUT': '86400', 15:12:32 INFO - 'USER': 'cltbld', 15:12:32 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1469133520.357670-2070270743', 15:12:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:12:32 INFO - '_': '/tools/buildbot/bin/python'} 15:12:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:12:32 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:12: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 15:12: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 15:12: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 15:12: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 15:12: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 15:12: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 15:12:34 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:12:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:12:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:12:34 INFO - Installing collected packages: mozsystemmonitor 15:12:34 INFO - Running setup.py install for mozsystemmonitor 15:12:35 INFO - Successfully installed mozsystemmonitor 15:12:35 INFO - Cleaning up... 15:12:35 INFO - Return code: 0 15:12:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:12:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:12:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:12:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:12:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:12:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:12:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:12:35 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 0x7fc2e323af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21cb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22965a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2325410>, '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 0x2326310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23267a0>, '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': '0333a256a5e4f052382dd180000001b1-1469133520.357670-2070270743', '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 15:12:35 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 15:12:35 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 15:12:35 INFO - Using env: {'DISPLAY': ':0', 15:12:35 INFO - 'HOME': '/home/cltbld', 15:12:35 INFO - 'LANG': 'en_US.UTF-8', 15:12:35 INFO - 'LANGUAGE': 'en_US:en', 15:12:35 INFO - 'LOGNAME': 'cltbld', 15:12:35 INFO - 'MAIL': '/var/mail/cltbld', 15:12:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:12:35 INFO - 'MOZ_NO_REMOTE': '1', 15:12:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:12:35 INFO - 'NO_EM_RESTART': '1', 15:12:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:12:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:12:35 INFO - 'PWD': '/builds/slave/test', 15:12:35 INFO - 'SHELL': '/bin/bash', 15:12:35 INFO - 'SHLVL': '1', 15:12:35 INFO - 'TERM': 'linux', 15:12:35 INFO - 'TMOUT': '86400', 15:12:35 INFO - 'USER': 'cltbld', 15:12:35 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1469133520.357670-2070270743', 15:12:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:12:35 INFO - '_': '/tools/buildbot/bin/python'} 15:12:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:12:35 INFO - Downloading/unpacking blobuploader==1.2.4 15:12:35 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 15:12:35 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 15:12:35 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 15:12:35 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 15:12:35 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 15:12:35 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 15:12:37 INFO - Downloading blobuploader-1.2.4.tar.gz 15:12:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:12:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:12:37 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 15:12:37 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 15:12:37 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 15:12:37 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 15:12:37 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 15:12:37 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 15:12:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:12:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:12:37 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 15:12:37 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 15:12:37 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 15:12:37 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 15:12:37 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 15:12:37 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 15:12:37 INFO - Downloading docopt-0.6.1.tar.gz 15:12:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:12:38 INFO - Installing collected packages: blobuploader, requests, docopt 15:12:38 INFO - Running setup.py install for blobuploader 15:12:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:12:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:12:38 INFO - Running setup.py install for requests 15:12:38 INFO - Running setup.py install for docopt 15:12:38 INFO - Successfully installed blobuploader requests docopt 15:12:38 INFO - Cleaning up... 15:12:38 INFO - Return code: 0 15:12:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:12:38 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')]} 15:12:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:12:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:12:38 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')]} 15:12:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:12:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:12:38 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 0x7fc2e323af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21cb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22965a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2325410>, '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 0x2326310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23267a0>, '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': '0333a256a5e4f052382dd180000001b1-1469133520.357670-2070270743', '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 15:12:38 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 15:12:38 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 15:12:38 INFO - Using env: {'DISPLAY': ':0', 15:12:38 INFO - 'HOME': '/home/cltbld', 15:12:38 INFO - 'LANG': 'en_US.UTF-8', 15:12:38 INFO - 'LANGUAGE': 'en_US:en', 15:12:38 INFO - 'LOGNAME': 'cltbld', 15:12:38 INFO - 'MAIL': '/var/mail/cltbld', 15:12:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:12:38 INFO - 'MOZ_NO_REMOTE': '1', 15:12:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:12:38 INFO - 'NO_EM_RESTART': '1', 15:12:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:12:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:12:38 INFO - 'PWD': '/builds/slave/test', 15:12:38 INFO - 'SHELL': '/bin/bash', 15:12:38 INFO - 'SHLVL': '1', 15:12:38 INFO - 'TERM': 'linux', 15:12:38 INFO - 'TMOUT': '86400', 15:12:38 INFO - 'USER': 'cltbld', 15:12:38 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1469133520.357670-2070270743', 15:12:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:12:38 INFO - '_': '/tools/buildbot/bin/python'} 15:12:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:12:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:12:38 INFO - Running setup.py (path:/tmp/pip-BvSKGS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:12:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:12:38 INFO - Running setup.py (path:/tmp/pip-zBwP9K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:12:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:12:38 INFO - Running setup.py (path:/tmp/pip-pbHijg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:12:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:12:39 INFO - Running setup.py (path:/tmp/pip-SctRr3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:12:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:12:39 INFO - Running setup.py (path:/tmp/pip-0N3ETJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:12:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:12:39 INFO - Running setup.py (path:/tmp/pip-UGErXS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:12:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:12:39 INFO - Running setup.py (path:/tmp/pip-UsN3Y3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:12:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:12:39 INFO - Running setup.py (path:/tmp/pip-liQ1X1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:12:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:12:39 INFO - Running setup.py (path:/tmp/pip-0kmYdg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:12:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:12:39 INFO - Running setup.py (path:/tmp/pip-2xuVSs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:12:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:12:39 INFO - Running setup.py (path:/tmp/pip-Uw3hAG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:12:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:12:39 INFO - Running setup.py (path:/tmp/pip-GT7ROR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:12:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:12:39 INFO - Running setup.py (path:/tmp/pip-ypJ2gr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:12:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:12:39 INFO - Running setup.py (path:/tmp/pip-4IjWpA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:12:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:12:39 INFO - Running setup.py (path:/tmp/pip-jL6W3D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:12:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:12:39 INFO - Running setup.py (path:/tmp/pip-Vv1HAk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:12:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:12:39 INFO - Running setup.py (path:/tmp/pip-ZvNARY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:12:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:12:40 INFO - Running setup.py install for manifestparser 15:12:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:12:40 INFO - Running setup.py install for mozcrash 15:12:40 INFO - Running setup.py install for mozdebug 15:12:40 INFO - Running setup.py install for mozdevice 15:12:40 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:12:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:12:40 INFO - Running setup.py install for mozfile 15:12:40 INFO - Running setup.py install for mozhttpd 15:12:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:12:40 INFO - Running setup.py install for mozinfo 15:12:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:12:40 INFO - Running setup.py install for mozInstall 15:12:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:12:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:12:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:12:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:12:40 INFO - Running setup.py install for mozleak 15:12:40 INFO - Running setup.py install for mozlog 15:12:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:12:41 INFO - Running setup.py install for moznetwork 15:12:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:12:41 INFO - Running setup.py install for mozprocess 15:12:41 INFO - Running setup.py install for mozprofile 15:12:41 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:12:41 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:12:41 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:12:41 INFO - Running setup.py install for mozrunner 15:12:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:12:41 INFO - Running setup.py install for mozscreenshot 15:12:41 INFO - Running setup.py install for moztest 15:12:41 INFO - Running setup.py install for mozversion 15:12:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:12:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:12:41 INFO - Cleaning up... 15:12:41 INFO - Return code: 0 15:12:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:12:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:12:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:12:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:12:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:12:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:12:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:12:41 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 0x7fc2e323af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21cb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22965a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2325410>, '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 0x2326310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23267a0>, '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': '0333a256a5e4f052382dd180000001b1-1469133520.357670-2070270743', '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 15:12:41 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 15:12:41 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 15:12:41 INFO - Using env: {'DISPLAY': ':0', 15:12:41 INFO - 'HOME': '/home/cltbld', 15:12:41 INFO - 'LANG': 'en_US.UTF-8', 15:12:41 INFO - 'LANGUAGE': 'en_US:en', 15:12:41 INFO - 'LOGNAME': 'cltbld', 15:12:41 INFO - 'MAIL': '/var/mail/cltbld', 15:12:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:12:41 INFO - 'MOZ_NO_REMOTE': '1', 15:12:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:12:41 INFO - 'NO_EM_RESTART': '1', 15:12:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:12:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:12:41 INFO - 'PWD': '/builds/slave/test', 15:12:41 INFO - 'SHELL': '/bin/bash', 15:12:41 INFO - 'SHLVL': '1', 15:12:41 INFO - 'TERM': 'linux', 15:12:41 INFO - 'TMOUT': '86400', 15:12:41 INFO - 'USER': 'cltbld', 15:12:41 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1469133520.357670-2070270743', 15:12:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:12:41 INFO - '_': '/tools/buildbot/bin/python'} 15:12:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:12:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:12:42 INFO - Running setup.py (path:/tmp/pip-LHO_IP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:12:42 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)) 15:12:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:12:42 INFO - Running setup.py (path:/tmp/pip-Jjoqoh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:12:42 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)) 15:12:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:12:42 INFO - Running setup.py (path:/tmp/pip-TV9a2e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:12:42 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)) 15:12:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:12:42 INFO - Running setup.py (path:/tmp/pip-SW_GKP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:12:42 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)) 15:12:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:12:42 INFO - Running setup.py (path:/tmp/pip-woTA1J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:12:42 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)) 15:12:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:12:42 INFO - Running setup.py (path:/tmp/pip-EcDZZJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:12:42 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)) 15:12:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:12:42 INFO - Running setup.py (path:/tmp/pip-qmiOsk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:12:42 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)) 15:12:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:12:42 INFO - Running setup.py (path:/tmp/pip-yHq2VT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:12:42 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)) 15:12:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:12:42 INFO - Running setup.py (path:/tmp/pip-XvXSDx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:12:42 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)) 15:12:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:12:42 INFO - Running setup.py (path:/tmp/pip-S878sv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:12:42 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)) 15:12:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:12:42 INFO - Running setup.py (path:/tmp/pip-GlLRlM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:12:42 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)) 15:12:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:12:42 INFO - Running setup.py (path:/tmp/pip-NMZHl7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:12:42 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)) 15:12:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:12:42 INFO - Running setup.py (path:/tmp/pip-b2zpSt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:12:43 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)) 15:12:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:12:43 INFO - Running setup.py (path:/tmp/pip-D_Eh9j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:12:43 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)) 15:12:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:12:43 INFO - Running setup.py (path:/tmp/pip-N7r79S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:12:43 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)) 15:12:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:12:43 INFO - Running setup.py (path:/tmp/pip-XEcf2D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:12:43 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)) 15:12:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:12:43 INFO - Running setup.py (path:/tmp/pip-aVO97x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:12:43 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)) 15:12:43 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)) 15:12:43 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)) 15:12:43 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)) 15:12:43 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)) 15:12:43 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)) 15:12:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:12:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:12:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:12:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:12:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:12:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:12:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:12:45 INFO - Downloading blessings-1.6.tar.gz 15:12:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:12:45 INFO - Installing collected packages: blessings 15:12:45 INFO - Running setup.py install for blessings 15:12:45 INFO - Successfully installed blessings 15:12:45 INFO - Cleaning up... 15:12:45 INFO - Return code: 0 15:12:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:12:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:12:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:12:45 INFO - Reading from file tmpfile_stdout 15:12:45 INFO - Current package versions: 15:12:45 INFO - argparse == 1.2.1 15:12:45 INFO - blessings == 1.6 15:12:45 INFO - blobuploader == 1.2.4 15:12:45 INFO - docopt == 0.6.1 15:12:45 INFO - manifestparser == 1.1 15:12:45 INFO - mozInstall == 1.12 15:12:45 INFO - mozcrash == 0.17 15:12:45 INFO - mozdebug == 0.1 15:12:45 INFO - mozdevice == 0.48 15:12:45 INFO - mozfile == 1.2 15:12:45 INFO - mozhttpd == 0.7 15:12:45 INFO - mozinfo == 0.9 15:12:45 INFO - mozleak == 0.1 15:12:45 INFO - mozlog == 3.1 15:12:45 INFO - moznetwork == 0.27 15:12:45 INFO - mozprocess == 0.22 15:12:45 INFO - mozprofile == 0.28 15:12:45 INFO - mozrunner == 6.11 15:12:45 INFO - mozscreenshot == 0.1 15:12:45 INFO - mozsystemmonitor == 0.0 15:12:45 INFO - moztest == 0.7 15:12:45 INFO - mozversion == 1.4 15:12:45 INFO - psutil == 3.1.1 15:12:45 INFO - requests == 1.2.3 15:12:45 INFO - wsgiref == 0.1.2 15:12:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:12:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:12:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:12:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:12:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:12:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:12:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:12:45 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 0x7fc2e323af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21cb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22965a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2325410>, '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 0x2326310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23267a0>, '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': '0333a256a5e4f052382dd180000001b1-1469133520.357670-2070270743', '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 15:12:45 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 15:12:45 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 15:12:45 INFO - Using env: {'DISPLAY': ':0', 15:12:45 INFO - 'HOME': '/home/cltbld', 15:12:45 INFO - 'LANG': 'en_US.UTF-8', 15:12:45 INFO - 'LANGUAGE': 'en_US:en', 15:12:45 INFO - 'LOGNAME': 'cltbld', 15:12:45 INFO - 'MAIL': '/var/mail/cltbld', 15:12:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:12:45 INFO - 'MOZ_NO_REMOTE': '1', 15:12:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:12:45 INFO - 'NO_EM_RESTART': '1', 15:12:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:12:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:12:45 INFO - 'PWD': '/builds/slave/test', 15:12:45 INFO - 'SHELL': '/bin/bash', 15:12:45 INFO - 'SHLVL': '1', 15:12:45 INFO - 'TERM': 'linux', 15:12:45 INFO - 'TMOUT': '86400', 15:12:45 INFO - 'USER': 'cltbld', 15:12:45 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1469133520.357670-2070270743', 15:12:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:12:45 INFO - '_': '/tools/buildbot/bin/python'} 15:12:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:12:45 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)) 15:12:45 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)) 15:12:45 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)) 15:12:45 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)) 15:12:45 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)) 15:12:45 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)) 15:12:45 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)) 15:12:45 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)) 15:12:45 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)) 15:12:45 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)) 15:12:45 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)) 15:12:45 INFO - Cleaning up... 15:12:45 INFO - Return code: 0 15:12:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:12:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:12:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:12:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:12:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:12:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:12:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:12:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc2e323af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21cb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22965a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2325410>, '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 0x2326310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23267a0>, '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': '0333a256a5e4f052382dd180000001b1-1469133520.357670-2070270743', '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 15:12:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:12:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:12:45 INFO - Using env: {'DISPLAY': ':0', 15:12:45 INFO - 'HOME': '/home/cltbld', 15:12:45 INFO - 'LANG': 'en_US.UTF-8', 15:12:45 INFO - 'LANGUAGE': 'en_US:en', 15:12:45 INFO - 'LOGNAME': 'cltbld', 15:12:45 INFO - 'MAIL': '/var/mail/cltbld', 15:12:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:12:45 INFO - 'MOZ_NO_REMOTE': '1', 15:12:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:12:45 INFO - 'NO_EM_RESTART': '1', 15:12:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:12:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:12:45 INFO - 'PWD': '/builds/slave/test', 15:12:45 INFO - 'SHELL': '/bin/bash', 15:12:45 INFO - 'SHLVL': '1', 15:12:45 INFO - 'TERM': 'linux', 15:12:45 INFO - 'TMOUT': '86400', 15:12:45 INFO - 'USER': 'cltbld', 15:12:45 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1469133520.357670-2070270743', 15:12:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:12:45 INFO - '_': '/tools/buildbot/bin/python'} 15:12:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:12:46 INFO - Downloading/unpacking jsonschema 15:12:46 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 15:12:46 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 15:12:46 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 15:12:46 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 15:12:46 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 15:12:46 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 15:12:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:12:48 INFO - Downloading/unpacking functools32 (from jsonschema) 15:12:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:12:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:12:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:12:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:12:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:12:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:12:48 INFO - Downloading functools32-3.2.3-2.tar.gz 15:12:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:12:48 INFO - warning: no files found matching '*.txt' 15:12:48 INFO - no previously-included directories found matching 'build' 15:12:48 INFO - no previously-included directories found matching 'dist' 15:12:48 INFO - no previously-included directories found matching '.git*' 15:12:48 INFO - Installing collected packages: jsonschema, functools32 15:12:48 INFO - Running setup.py install for functools32 15:12:48 INFO - warning: no files found matching '*.txt' 15:12:48 INFO - no previously-included directories found matching 'build' 15:12:48 INFO - no previously-included directories found matching 'dist' 15:12:48 INFO - no previously-included directories found matching '.git*' 15:12:48 INFO - Successfully installed jsonschema functools32 15:12:48 INFO - Cleaning up... 15:12:48 INFO - Return code: 0 15:12:48 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 15:12:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:12:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:12:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:12:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:12:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:12:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:12:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc2e323af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21cb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22965a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2325410>, '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 0x2326310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23267a0>, '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': '0333a256a5e4f052382dd180000001b1-1469133520.357670-2070270743', '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 15:12:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 15:12:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 15:12:48 INFO - Using env: {'DISPLAY': ':0', 15:12:48 INFO - 'HOME': '/home/cltbld', 15:12:48 INFO - 'LANG': 'en_US.UTF-8', 15:12:48 INFO - 'LANGUAGE': 'en_US:en', 15:12:48 INFO - 'LOGNAME': 'cltbld', 15:12:48 INFO - 'MAIL': '/var/mail/cltbld', 15:12:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:12:48 INFO - 'MOZ_NO_REMOTE': '1', 15:12:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:12:48 INFO - 'NO_EM_RESTART': '1', 15:12:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:12:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:12:48 INFO - 'PWD': '/builds/slave/test', 15:12:48 INFO - 'SHELL': '/bin/bash', 15:12:48 INFO - 'SHLVL': '1', 15:12:48 INFO - 'TERM': 'linux', 15:12:48 INFO - 'TMOUT': '86400', 15:12:48 INFO - 'USER': 'cltbld', 15:12:48 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1469133520.357670-2070270743', 15:12:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:12:48 INFO - '_': '/tools/buildbot/bin/python'} 15:12:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:12:48 INFO - Downloading/unpacking flake8 15:12:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:12:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:12:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:12:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:12:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:12:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:12:50 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:12:50 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:12:50 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 15:12:50 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 15:12:50 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 15:12:50 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 15:12:50 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 15:12:50 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 15:12:50 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:12:50 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:12:50 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 15:12:50 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 15:12:50 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 15:12:50 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 15:12:50 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 15:12:50 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 15:12:51 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:12:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:12:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:12:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:12:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:12:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:12:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:12:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 15:12:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:12:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:12:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:12:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:12:51 INFO - no previously-included directories found matching 'docs/_build' 15:12:51 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:12:51 INFO - Running setup.py install for pep8 15:12:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:12:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:12:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:12:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:12:51 INFO - no previously-included directories found matching 'docs/_build' 15:12:51 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 15:12:51 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:12:51 INFO - Cleaning up... 15:12:51 INFO - Return code: 0 15:12:51 INFO - Running post-action listener: _resource_record_post_action 15:12:51 INFO - Running post-action listener: _start_resource_monitoring 15:12:51 INFO - Starting resource monitoring. 15:12:51 INFO - ##### 15:12:51 INFO - ##### Running install step. 15:12:51 INFO - ##### 15:12:51 INFO - Running pre-action listener: _resource_record_pre_action 15:12:51 INFO - Running main action method: install 15:12:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:12:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:12:51 INFO - Reading from file tmpfile_stdout 15:12:51 INFO - Detecting whether we're running mozinstall >=1.0... 15:12:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:12:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:12:51 INFO - Reading from file tmpfile_stdout 15:12:51 INFO - Output received: 15:12:51 INFO - Usage: mozinstall [options] installer 15:12:51 INFO - Options: 15:12:51 INFO - -h, --help show this help message and exit 15:12:51 INFO - -d DEST, --destination=DEST 15:12:51 INFO - Directory to install application into. [default: 15:12:51 INFO - "/builds/slave/test"] 15:12:51 INFO - --app=APP Application being installed. [default: firefox] 15:12:51 INFO - mkdir: /builds/slave/test/build/application 15:12:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 15:12:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 15:13:05 INFO - Reading from file tmpfile_stdout 15:13:05 INFO - Output received: 15:13:05 INFO - /builds/slave/test/build/application/firefox/firefox 15:13:05 INFO - Running post-action listener: _resource_record_post_action 15:13:05 INFO - ##### 15:13:05 INFO - ##### Running run-tests step. 15:13:05 INFO - ##### 15:13:05 INFO - Running pre-action listener: _resource_record_pre_action 15:13:05 INFO - Running main action method: run_tests 15:13:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:13:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:13:05 INFO - Python 2.7.3 15:13:05 INFO - Return code: 0 15:13:05 INFO - grabbing minidump binary from tooltool 15:13:05 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')]} 15:13:05 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 0x2325410>, '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 0x2326310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23267a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:13:05 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 15:13:05 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 15:13:05 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:13:05 INFO - Return code: 0 15:13:05 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:13:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:13:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:13:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:13:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:13:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 15:13:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 15:13:06 INFO - Return code: 0 15:13:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FeI_Bo_6RJStGWc9KBpq0Q/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--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 15:13:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/FeI_Bo_6RJStGWc9KBpq0Q/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-017 --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 15:13:06 INFO - Using env: {'DISPLAY': ':0', 15:13:06 INFO - 'HOME': '/home/cltbld', 15:13:06 INFO - 'LANG': 'en_US.UTF-8', 15:13:06 INFO - 'LANGUAGE': 'en_US:en', 15:13:06 INFO - 'LOGNAME': 'cltbld', 15:13:06 INFO - 'MAIL': '/var/mail/cltbld', 15:13:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:13:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:13:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:13:06 INFO - 'MOZ_NO_REMOTE': '1', 15:13:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:13:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:13:06 INFO - 'NO_EM_RESTART': '1', 15:13:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:13:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:13:06 INFO - 'PWD': '/builds/slave/test', 15:13:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:13:06 INFO - 'SHELL': '/bin/bash', 15:13:06 INFO - 'SHLVL': '1', 15:13:06 INFO - 'TERM': 'linux', 15:13:06 INFO - 'TMOUT': '86400', 15:13:06 INFO - 'USER': 'cltbld', 15:13:06 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1469133520.357670-2070270743', 15:13:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:13:06 INFO - '_': '/tools/buildbot/bin/python'} 15:13:06 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FeI_Bo_6RJStGWc9KBpq0Q/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--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 15:13:06 INFO - mozversion application_buildid: 20160721122919 15:13:06 INFO - mozversion application_changeset: ccf0f9620bdcd4378568c385b9d936f38ce1fb97 15:13:06 INFO - mozversion application_display_name: Firefox 15:13:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:13:06 INFO - mozversion application_name: Firefox 15:13:06 INFO - mozversion application_remotingname: firefox 15:13:06 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 15:13:06 INFO - mozversion application_vendor: Mozilla 15:13:06 INFO - mozversion application_version: 48.0 15:13:06 INFO - mozversion platform_buildid: 20160721122919 15:13:06 INFO - mozversion platform_changeset: ccf0f9620bdcd4378568c385b9d936f38ce1fb97 15:13:06 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 15:13:06 INFO - mozversion platform_version: 48.0 15:13:06 INFO - using testdate: 1469139186 15:13:06 INFO - actual date: 1469139186 15:13:06 INFO - starting webserver on 'localhost:41376' 15:13:06 INFO - SUITE-START | Running 2 tests 15:13:06 INFO - TEST-START | dromaeo_css 15:13:06 INFO - operating with platform_type : linux_ 15:13:06 INFO - Initialising browser for dromaeo_css test... 15:13:06 INFO - TEST-INFO | started process 13962 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBs0HVr/profile http://localhost:41376/getInfo.html) 15:13:09 INFO - PROCESS | 13962 | 15:13:09 INFO - PROCESS | 13962 | (process:14038): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 15:13:10 INFO - PROCESS | 13962 | __metrics Screen width/height:1600/1200 15:13:10 INFO - PROCESS | 13962 | colorDepth:24 15:13:10 INFO - PROCESS | 13962 | Browser inner width/height: 1024/697 15:13:10 INFO - PROCESS | 13962 | __metrics 15:13:10 ERROR - PROCESS | 13962 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 15:13:11 INFO - TEST-INFO | 13962: exit 0 15:13:11 INFO - Browser initialized. 15:13:11 INFO - Running cycle 1/1 for dromaeo_css test... 15:13:11 INFO - TEST-INFO | started process 14089 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBs0HVr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:13:13 INFO - PROCESS | 14089 | 15:13:13 INFO - PROCESS | 14089 | (process:14159): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 15:13:23 INFO - PROCESS | 14089 | RSS: Main: 150519808 15:13:23 INFO - PROCESS | 14089 | 15:14:12 INFO - PROCESS | 14089 | 1469139252880 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] 15:16:20 INFO - PROCESS | 14089 | Cycle 1(1): loaded http://localhost:41376/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41376/tests/dromaeo/cssquery-ext.html) 15:16:21 INFO - PROCESS | 14089 | RSS: Main: 155746304 15:16:21 INFO - PROCESS | 14089 | 15:19:23 INFO - PROCESS | 14089 | Cycle 1(1): loaded http://localhost:41376/tests/dromaeo/cssquery-ext.html (next: http://localhost:41376/tests/dromaeo/cssquery-jquery.html) 15:19:23 INFO - PROCESS | 14089 | RSS: Main: 152391680 15:19:23 INFO - PROCESS | 14089 | 15:22:25 INFO - PROCESS | 14089 | Cycle 1(1): loaded http://localhost:41376/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41376/tests/dromaeo/cssquery-mootools.html) 15:22:25 INFO - PROCESS | 14089 | RSS: Main: 152625152 15:22:25 INFO - PROCESS | 14089 | 15:25:27 INFO - PROCESS | 14089 | Cycle 1(1): loaded http://localhost:41376/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41376/tests/dromaeo/cssquery-prototype.html) 15:25:28 INFO - PROCESS | 14089 | RSS: Main: 153563136 15:25:28 INFO - PROCESS | 14089 | 15:28:30 INFO - PROCESS | 14089 | Cycle 1(1): loaded http://localhost:41376/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41376/tests/dromaeo/cssquery-yui.html) 15:28:31 INFO - PROCESS | 14089 | RSS: Main: 151912448 15:28:31 INFO - PROCESS | 14089 | 15:31:33 INFO - PROCESS | 14089 | Cycle 1(1): loaded http://localhost:41376/tests/dromaeo/cssquery-yui.html (next: http://localhost:41376/tests/dromaeo/cssquery-dojo.html) 15:31:33 INFO - PROCESS | 14089 | RSS: Main: 155983872 15:31:33 INFO - PROCESS | 14089 | 15:31:33 INFO - PROCESS | 14089 | __start_tp_report 15:31:33 INFO - PROCESS | 14089 | _x_x_mozilla_page_load 15:31:33 INFO - PROCESS | 14089 | _x_x_mozilla_page_load_details 15:31:33 INFO - PROCESS | 14089 | |i|pagename|runs| 15:31:33 INFO - PROCESS | 14089 | |0;dojo.html;3316.253842885351;3398.422268214403;3427.091820667522;3462.2036931505754;3474.114100904269;5629;5647.887042259153;5671.659700417978;5672.149177623359;5681.119426488895;5635.887282254363;5668.356176708749;5674.914876276859;5676.971615141929;5688.772449102031;5102.948970510303;5124.308218390525;5152.613553983448;5201.609879259052;5207.973960130213;5057.721825299607;5121.180611102224;5254.81608143715;5276.604254680895;5280.339957505312;5132.332796736419;5159.974200128994;5252.107141785887;5266.5523430508265;5308.5487733542695;5197.844064678085;5200.08998425276;5218.112920803473;5220.791168353261;5248.239005344242;5015.27278544609;5067.695938243717;5137;5164.2253661950635;5193.065248255312;5442.074847275972;5514.889702205934;5547.916781248285;5555;5588.524975377098;6016.278046634388;6054.848628784272;6062.818115456544;6065.696715164268;6073.605215661012;5922.082077278029;5991.101334799771;6107.4808641265545;6112.847178820521;6128.938710612926;5682.346530149044;5690.772369105231;5696.401877802854;5706.77172913083;5735.684537350444;6177.733564619242;6201.472874805692;6204.100405441186;6208;6217.720202590895;5836.503897168788;5936.317323507766;5954.196183515257;5960.970195149083;6085;6107.603005804697;6111.54163437744;6112.205413296243;6121.204243448323;6126.08108783686;6012.939870601238;6029.638221706711;6032.336442991267;6063;6074.179985701874;5805.912911306334;5890.2342695449315;6013.067974463965;6055.909161362583;6064.787732429432;4569.725816451024;4596.908061838812;4598.149342371605;4608.124456353349;4616.838410655611;4096.856610018635;4104.261232978092;4133.772642504691;4147.398627199039;4172.061286210578;5657.066584013592;5687.090065589486;5768.394318596571;5796.362400135981;5814.156947242626;5946.375630558816;6084.087386891913;6124.350421260821;6137.355577664281;6141.6007959482495;5649.971750141305;5809.2738407699035;5840.912386314209;5845.590808643354;5847.766089356463;5152.639315247971;5226.764795584208;5236.214567814858;5249;5274.077036518594;6297.622142671455;6297.968510157511;6329.841753956188;6338.176037115146;6351.142595749607;5937;6033.87932241344;6084.482818960438;6103.7253323601435;6106.419890110433;6343.5876668016435;6400.23197216337;6412.647304398116;6417.326180750954;6419.711112999833;6032.245969253843;6034.939650603614;6045.425684559959;6047.485963693135;6048.516118710405;5992.67040312787;6007.54943379257;6113.263474096151;6154.046122850787;6164.075388691732;5908.291005079418;5921.407859214044;5938.881222375615;5940;5947.702614869326;5841.094630332305;5852.590318677651;5891.440313170242;5899.587028907935;5923.170756094237;5724;5796.246487956539;5834.38738932406;5857.560682948882;5945.10823376497;6004.189434426296;6041.2750469943885;6050.757969681339;6062.393760623902;6062.7271772769445;5888.234529511136;5891.1752354669525;5893.381194974638;5918.496927761188;5920.615160014585 15:31:33 INFO - PROCESS | 14089 | |1;ext.html;665.740361259109;676.8274090107022;696.3663066609387;723.2694978072149;744.9830980711329;38696.61303386969;39731.404028939556;39784.2043159137;40084.79957600215;40234.79882600583;42583.574164258345;43331;43440.13119737611;43442.34836477455;43450.56549434505;8721.084286149942;8924.062973387798;8934.061923498004;8943.686970956018;8955.776105597348;8740.038595754462;8833.33749968755;8840.734777956672;9027.548622568878;9037.95481022594;9076.909230907673;9077.183053525181;9140.040295768948;9151.03914089021;9176.587053582605;9013.278937684969;9062.365634405594;9089.818203635956;9108.681196158102;9146.725598232031;8932.330075244317;8985.46087234768;8985.505797181153;9013;9122.270218382513;43152.78423607893;43559.564404355864;43613;43677;43698.12603747907;3762.322781899257;3896.0649444133487;3920.2159568086495;4066.877993660195;4482.238019536687;33852;34079.31841363159;34153.487697684555;34260.14349641254;34408.82795586031;4516.18708632446;4533.569310915491;4590.173768721629;4659.953400465985;4692.648051396125;304504;306957;307048;307300;309092;64729.67635161794;64843.67578162079;64946.35053649403;65056;65079.34920650733;70860.64569677119;71671.64164179146;71904;72005;72369.46706865235;18838.623227535372;19110.90444547796;19150.04249787533;19259;19263.4220973371;14947.925260373846;15006.249687515581;15020.774688379683;15034.17312047848;15063.397464101532;20185.899070504554;20309.49226269355;20438.79561204369;20567.588648226953;21180.894095529733;7853.921460785434;7876.251756083163;7974.322182614426;8034.437589368688;8085.272325490734;1137.4426530999751;1166.836642869999;1184.3308530680138;1201.7536405036947;1251.7246205834701;33613.49579756305;33683.831580841936;33696.32607347839;33909.32181356359;34108;1231.384307846077;1236.0470456678427;1263.620913725897;1292.3021568353172;1332.5336132353793;17610.47168584919;17683.95501415131;17749.290028398977;17901;18054.368097116538;438918;584011;596773;896225;910507;58095.2571422858;58919.41080589225;59128;59416.10875836866;59463.70268148718;1565.3738504598252;1567.9216039197995;1568.874490040817;1595.718123084001;1694.5594145522252;30150;32406.83796581002;34035.14912127217;34350;34494.65505344915;57463.1380529284;58236.41763582479;58250.70874645769;58297.417025830895;58316.4168358311;457402;458475;458682;460228;462043;32101.518477222395;32515.18712032218;32524;32562.348753025282;32854.671453286115;52533.737331313096;52629;52691.47308527019;52802.22001507227;54300;43341;43979;44394;44634.3304850421;44833.98247078824;42381.576184239;43330;43420.782896085315;44159.55840441555;44347.556524434345;45241.737913103556;45407.54592454166;45447.54552454433;45568.54431455643;45653.77173114113;37583.812080940515;37704.245915082094;37762.622373775914;37929;38810.22379552449;28541.429171416872;29430.70569294365;29846.403071938876;30293.394132117675;30315.242118947204 15:31:33 INFO - PROCESS | 14089 | |2;jquery.html;435.2600579015674;437.14974374840926;437.53402626203103;443.2088721631888;447.1771939631078;18482.35311764087;18604.62790744184;19204;19957.301494447696;19990.30033948812;20104.89947550264;20115;20334.28829990947;20449.488762780937;20572.588548229065;5391;5540.9168862467095;5632.746526406301;5638.097904335307;5644.8306550803545;5447.645903016291;5583.274174357328;5586.581006424514;5720.227769251161;5770.4518070783415;5713.742881570319;5723.141528770676;5729.28383952006;5749.993751093562;5945.910811337833;6379.202599675041;6400.551961362707;6423.967880160592;6435.68068545947;6439.613623182624;5588.133839254881;5799.855003624901;5800.4489573490455;5819.854503637401;5820.883582328372;14320.35558399864;14432.783508247385;14440.783388249185;14524.854751452456;18231.63536729271;2285.919992800244;2405.6632071510003;2423.1397853762014;2771.2517620242625;2905.8111222770453;10055.648052318207;10196.439195844225;10258.640947566799;10487.685369438928;10771.784564308748;1978.4262563856607;2032.400441869652;2040.9081591328427;2078.6570215914508;2120.4380839077658;81060.59469702673;83009;83860.58069709674;84759;84947.5752621233;11593.594224202112;11769.470373833026;11784.646460606196;11821.468033938494;11870.88129118715;16323.918380408022;16458.09480478585;16470.83529164717;16503.83496165047;16599.087050212354;8942;8952.68665596714;9012.369134160677;9144.268458523302;9352.625894964262;9145.405548639317;9162.175404213653;9198.540072996324;9291.72124836256;9321.207697345802;5054.873628159326;5072.594192464594;5113.948860511422;5134.2298655201275;5154.557358835;2061.2693867573953;2069.1102825785056;2121.11973530986;2169.620316444616;2194.6707993800737;1033.679559336608;1040.8282633365409;1047.8847326794046;1100.2023532938556;1132.020802006275;16582;17656.470305890845;19084.04579771006;19199.32802351911;19735;1036.1814166808138;1040.5005597313182;1087.9456027198607;1143.5997400909782;1144.6508814811395;10468.68593942183;10728.356298622108;10750.78498430027;10755.892441075646;10870.836937445945;500149;506394;509425;516439;519749;90782.54608727046;97508;99268.50365748125;99309;100202;1078.309881675728;1086.7935092332432;1088.4666513408372;1092.6285063078592;1095.611058074388;16835.494935151964;16868.915655421646;16936;17029.91485042567;17131.314747409964;37966.24067518579;38331.616683832806;38974.4153837687;39206.80396597999;39339.409908851965;55561.166582502105;56977.71511142418;57092;57492;57652.71173644105;8598.699045533376;8664.78338041554;8688.464181497453;8691.391602587759;8923.41997770143;9734.971942310003;13127.540536081191;13493.39279732434;13626.250556219504;13636.318184090558;11855.466504007169;12138.817917731065;12144.028477721584;12146.635600931986;12377.195482293622;11596.130290228099;11843.993260572603;11894.226875253082;12045.81931271014;12380.938095309466;11929.82105268439;12200.267983920992;12232.816507752214;12360.505579776709;12400.875991239973;8604.48373097616;8662.566871656518;8685.826283474169;8802.119788021148;9006.054364291655;11088;11957.402129893644;12026.338551379758;12115.212511186744;12198.268103913793 15:31:33 INFO - PROCESS | 14089 | |3;mootools.html;1563.8279789223186;1570.9214539273037;1809.6833054215508;1883.642107999479;1920.923163073477;7757.922420775791;8530.91469085309;8559.358048146383;8726.869096963543;8739.825203495926;8587.313014958803;8615.396922215448;8672.219500244977;8702.086280940504;8748.212660860521;2421.0436877433403;2433.914812981546;2449.8530088194766;2452.104981681682;2453.018792483012;2435.403326185078;2454.717707463638;2478.1450399612104;2478.603423452248;2487.8507289562685;2424.260600516842;2456.4227406559444;2483.5777917753935;2496.7877730392847;2501.374656335916;2439.5974664180476;2441.2066078524463;2451.6445115458246;2483.67712197415;2483.9379015524755;2392.2823153054187;2443.035001174544;2457.913973010954;2464.4331803685072;2491.2899823550383;8776.341774366949;8846.203841654282;8847.46915185091;8879.51162686052;8924.910750892474;5421.403645598981;5489.670619762827;5504.119340905436;5512.6968016759065;5529.834104976857;3404.557407537029;3453;3492.703120234783;3543.202779374646;3544.8404821783083;1089.0906093412011;1105.8175401058816;1130.3556972525664;1132.0377678972889;1141.680329507731;12558.68603284916;12600.054995875254;12629.368531573477;12692;12704.301263430507;4725.432948046257;4734.4081989751285;4812.951870481321;4835.588974937099;4924.482929292372;10617;10636.734081648021;10646.095081917969;10659.733506662396;10674.946625266824;5497.065498865202;5519;5523.475269849358;5536.889262214733;5563.082091454946;4845.41854977405;5014.448410674823;5044.974775126101;5060.746962651852;5085.0338435697095;3941.3496773032703;3984.1234928315725;4013.678905687538;4016.819243134066;4065.776382299002;1191.9106067045007;1207.5350989868964;1216.6046035038648;1221.065884598283;1235.3329202230696;954.7994921066654;1017.308230403318;1023.1354505442889;1026.7689769801734;1039.4231201682987;5851.678157701367;5881.852953676107;5892.322382925932;5916.556258280646;6029.246344206974;453.6302913125792;456.6050366433078;456.8766433063054;1075.3171735947574;1076.101455284846;3861.7296789225047;3867.767933923917;3897.8635747748694;3901.8634347797692;3916.667083297895;10487.632932847466;10766.246362754531;10769.03078722903;10847.132229421784;10864.891351086546;10511.894881051245;10536.315139515908;10593;10601.363918164934;10603.469826508644;7967.48211366271;8210.220029097227;8432.957835210907;8434.114417986146;8526.232639062515;5764.913526297193;5771.94228057714;5774.855628609318;5893.292804863444;5934.614250073904;9692.75768105803;9693.079157480028;9809.313348065853;9925.751856203653;9940.950295248478;9413.905860941577;9601.231901448007;9805.313628045968;9830.459324737209;9885.308028437941;6725.764598239038;7463.552186868806;7535.472516923763;7921.2870841622225;8162.347012238888;8049.315808156372;8089.555074470961;8118.9188108120525;8135.349172066102;8148.959255203686;7326.010988516482;7355.190928997699;7395.260473952561;7474.439417043852;7595.126560445619;7434.553926764412;7598.658060387185;7611.2769286917655;7710.306072453506;7791.0650721913735;7011.544249623758;7052.682629281797;7116.359527642537;7124.430045596237;7138.928610713826;4676.134915040729;4742.217534106834;4750.239961606127;4872.90254194907;4927.556519913225;4797.664163508521;4806.110869489155;4813.422389313305;4817.590504807131;4938.728369939688 15:31:33 INFO - PROCESS | 14089 | |4;prototype.html;344.9879254226102;347.846947343169;351.90146758907497;361.78112242093533;362.77145398399006;6573.1783527059115;6585.670716464181;6593.373629505195;6604.603723776565;6670.999999999994;6535.967320163404;6536.575122617027;6542.214934207902;6551.312112228219;6554.082428460019;4647.907041859169;4805.20714082176;4881.633877459187;4907.337509436216;4929.186684197121;4914.434839993393;4936.851894443154;4946.08497427977;4947.975260123694;4956.083124621939;4891.266310053485;4905.018996200756;4906.288588154715;4909.140900342443;4922.729249891255;4903.068417000776;4909.091818013679;4909.116359055369;4912.705237685733;4925.014997000614;4315.942594064443;4326.394304797331;4337.934930976038;4343.565643435662;4345.109252603241;6203.937960620381;6288.371162883721;6296.842578935518;6328.905066424008;6333.55665103443;5752.856178595527;5784.566157538202;5788.652680839163;5790.36306006339;5797.275340582427;6870.419803445236;6873.553219040747;6878.69045892936;6886.311368863124;6888.758893438706;4819.855404337841;4819.95180048202;4821.842757738117;4827.710337379734;4828;7229.024081748949;7252.3835473984245;7253.057102576631;7253.528520646141;7266.164391095039;4848.442429120696;4943.752812359367;4947.208446648519;4955.207166853286;4967.850964471072;4991.176455884811;5018.4730603286125;5018.698878067327;5021.72380519075;5022.94518151185;5761.683107429131;5765.221695071195;5772.6536407815665;5775.624584402084;5776.191333213354;6960.129983752031;6969.303069693092;6971.024056632075;6971.268016858258;6975.51171418006;1750.4748575427575;1779.4839496545856;1780.5548612846787;1783.5006198264507;1786.5355007698092;1128.5937062657438;1141.0871302957767;1162.4594563528;1181.787278289916;1183.260462211118;6701.463882889358;6728.6635668216395;6731.326867313327;6744.966275168691;6749.42629876466;7060.117485314336;7185.6047917364;7190.280971902873;7191.496595238388;7193.568385896863;6744.898826517606;6783.796486105425;6784.660766961731;6787.5588086774205;6796.864062718718;3881.0491429599365;3919.941200881989;3921.7254792164276;3925.391564307537;3926.9410958835642;7544.6227688616445;7582.772516824504;7600.087989441192;7605.049368828896;7606.923930760732;7231.5299505531975;7311.780646580611;7376.114866216089;7385.593792341366;7396.778096657109;7562.508436951581;7573.886391704129;7574.091109066837;7574.886376704354;7579.54522728638;7151.713931442684;7179.964100179465;7203.243659415686;7224.89162662571;7231.132264128339;7089.361957423856;7134.714611415485;7137.10786151731;7143.428525718034;7152.105986751656;7437.070366204224;7558.9244107558225;7559.979402780555;7589.772306830804;7599.316061554487;4786.880327991828;4789.808407663654;4828.927566086441;4833.879153021203;4841.370621819141;7146.071010768567;7212.603306818175;7219.6751146199595;7224.963875180591;7237;6987.336203060701;6991.965040174767;6992.3357281058215;7009.018737376669;7009.878419452863;6881.93118068833;6960.512764106464;6996.160460744743;7001;7004.124484439445;6849.4177994869;6849.863002740017;6881.208661004049;6890.035395044798;6891.517593768388;6993.580385176906;7019.964900175466;7036.718531258693;7039.472039596948;7061.470389720895;6852.246252912076;6873.828154296182;6881.621510816954;6882.8623427530165;6886.655667216719 15:31:33 INFO - PROCESS | 14089 | |5;yui.html;911.7766147293913;927.258193445244;931.7484279244604;932.5570354081812;935.8830146231721;14915.925420372896;15199.544013679593;15202.847971520296;15302.770458443132;15318;13044.478220871153;13573.660658483543;13970.860291397083;14009.649758756037;14124.29378531072;903.0743487924881;918.6187732091174;926.5182105305237;926.647873807952;930.2929773372218;908.8863892013499;911.5487833522416;917.3486824354716;918.76112210825;918.8024574716435;931.8229536388064;937.3438592984904;938.7887725261795;941.9199368053723;942.6700654770809;928.0904713380856;930.6230976454547;931.7810314576103;934.2572654739498;936.1434287626881;690.4683393786806;691.0601581848682;693.4521727835004;694.3924066441863;695.8712638161957;13200.867991320156;13233.272170030645;13275.137116087424;13345.399457024458;13381.464741410331;12156;12419;12467.812982805266;12669.493220271179;12686.365681715877;10321.690349289533;10615.256932014761;10657.946710266398;10738.624148154777;10764.407957562331;3872.67082298005;3891.922161556753;3924.1759230561615;3969.186316805048;4038.717289789716;51124.48875511235;53700;55015;55662;55776.72111639456;11289.379084150287;11365.886341136647;11631.59289424866;11683.707907302385;11841.28952262867;20016.199352025757;20042.198312067645;20123.295684650966;20157.19371225164;20179.697304540445;8554.871676924851;8617.224449799423;8816.647334106563;8885.600147993357;9045.140711632384;4827.806887724522;4885.193942999436;4969.701817890938;4979.925301120486;5071.239314102914;3768.171002379472;3797.1456422305314;3798.164403831153;3820.2168555446065;3822.9235415291537;685.8114018644912;696.5646470955653;699.2937133495207;704.383664293743;706.1773034414849;823.5017814222309;828.668532586958;837.3092198935902;839.6935118681637;852.0669866496177;9053;9086.36395452312;9187.402818816889;9215.53922303882;9253.814923701622;750.7822731407831;795.5163619849055;805.8871757953891;814.3973459639824;822.2928281677753;4259.659227261812;4395.868123956287;4498.190325741332;4509.188346097669;4646.558576935186;60623;61798;61882.38117618856;62062.689686551275;62797.68601156965;48538.27192592114;49097.75451122793;51860;54377.72811135919;55139.17291240635;52287.47712522902;52389.476105239984;52423.73788131035;52451.21323180155;52604.21093683598;10171.898281017391;10223.737736300336;10234.590616375262;10330.845037324596;10357.63748268807;36733.63266367302;37147.25705485929;38235.23529529338;38318.23363532769;39138.80430597829;43129;45909.77045114753;46567.767161163974;47232.7638361806;47473;11878.346690932081;12250.693732656755;12315.93842030784;12424.56514022005;12535.122541422377;13589.864101359255;14069.085509441853;14087.929560352133;14150.966974412655;14386.712265754835;12736.490540378281;12781.61655150347;13057.934710326388;13216.405261763051;13310.134841235289;12928.547500837802;12943.482260709467;12949.611511654666;13238.801417978932;13252.337383130998;13195.736085278433;13301;13313.667158320732;13377.53178638743;13380.464781409024;11180.496877640364;11319.490622922152;11391.145664075393;11479;11546.0763138947;10937.234393592373;11220.824071133771;11419.0864730823;11526.481308340977;11580.594679186524 15:31:33 INFO - PROCESS | 14089 | __end_tp_report 15:31:33 INFO - PROCESS | 14089 | __start_cc_report 15:31:33 INFO - PROCESS | 14089 | _x_x_mozilla_cycle_collect,322 15:31:33 INFO - PROCESS | 14089 | __end_cc_report 15:31:33 INFO - PROCESS | 14089 | __startTimestamp1469140293485__endTimestamp 15:31:33 INFO - PROCESS | 14089 | 15:31:33 INFO - PROCESS | 14089 | ------- Summary: start ------- 15:31:33 INFO - PROCESS | 14089 | Number of tests: 6 15:31:33 INFO - PROCESS | 14089 | 15:31:33 INFO - PROCESS | 14089 | [#0] dojo.html Cycles:165 Average:5647.20 Median:5857.56 stddev:632.20 (10.8%) stddev-sans-first:607.12 15:31:33 INFO - PROCESS | 14089 | Values: 3316.3 3398.4 3427.1 3462.2 3474.1 5629.0 5647.9 5671.7 5672.1 5681.1 5635.9 5668.4 5674.9 5677.0 5688.8 5102.9 5124.3 5152.6 5201.6 5208.0 5057.7 5121.2 5254.8 5276.6 5280.3 5132.3 5160.0 5252.1 5266.6 5308.5 5197.8 5200.1 5218.1 5220.8 5248.2 5015.3 5067.7 5137.0 5164.2 5193.1 5442.1 5514.9 5547.9 5555.0 5588.5 6016.3 6054.8 6062.8 6065.7 6073.6 5922.1 5991.1 6107.5 6112.8 6128.9 5682.3 5690.8 5696.4 5706.8 5735.7 6177.7 6201.5 6204.1 6208.0 6217.7 5836.5 5936.3 5954.2 5961.0 6085.0 6107.6 6111.5 6112.2 6121.2 6126.1 6012.9 6029.6 6032.3 6063.0 6074.2 5805.9 5890.2 6013.1 6055.9 6064.8 4569.7 4596.9 4598.1 4608.1 4616.8 4096.9 4104.3 4133.8 4147.4 4172.1 5657.1 5687.1 5768.4 5796.4 5814.2 5946.4 6084.1 6124.4 6137.4 6141.6 5650.0 5809.3 5840.9 5845.6 5847.8 5152.6 5226.8 5236.2 5249.0 5274.1 6297.6 6298.0 6329.8 6338.2 6351.1 5937.0 6033.9 6084.5 6103.7 6106.4 6343.6 6400.2 6412.6 6417.3 6419.7 6032.2 6034.9 6045.4 6047.5 6048.5 5992.7 6007.5 6113.3 6154.0 6164.1 5908.3 5921.4 5938.9 5940.0 5947.7 5841.1 5852.6 5891.4 5899.6 5923.2 5724.0 5796.2 5834.4 5857.6 5945.1 6004.2 6041.3 6050.8 6062.4 6062.7 5888.2 5891.2 5893.4 5918.5 5920.6 15:31:33 INFO - PROCESS | 14089 | 15:31:33 INFO - PROCESS | 14089 | [#1] ext.html Cycles:180 Average:65505.16 Median:43645.00 stddev:139244.71 (319.0%) stddev-sans-first:139550.23 15:31:33 INFO - PROCESS | 14089 | Values: 665.7 676.8 696.4 723.3 745.0 38696.6 39731.4 39784.2 40084.8 40234.8 42583.6 43331.0 43440.1 43442.3 43450.6 8721.1 8924.1 8934.1 8943.7 8955.8 8740.0 8833.3 8840.7 9027.5 9038.0 9076.9 9077.2 9140.0 9151.0 9176.6 9013.3 9062.4 9089.8 9108.7 9146.7 8932.3 8985.5 8985.5 9013.0 9122.3 43152.8 43559.6 43613.0 43677.0 43698.1 3762.3 3896.1 3920.2 4066.9 4482.2 33852.0 34079.3 34153.5 34260.1 34408.8 4516.2 4533.6 4590.2 4660.0 4692.6 304504.0 306957.0 307048.0 307300.0 309092.0 64729.7 64843.7 64946.4 65056.0 65079.3 70860.6 71671.6 71904.0 72005.0 72369.5 18838.6 19110.9 19150.0 19259.0 19263.4 14947.9 15006.2 15020.8 15034.2 15063.4 20185.9 20309.5 20438.8 20567.6 21180.9 7853.9 7876.3 7974.3 8034.4 8085.3 1137.4 1166.8 1184.3 1201.8 1251.7 33613.5 33683.8 33696.3 33909.3 34108.0 1231.4 1236.0 1263.6 1292.3 1332.5 17610.5 17684.0 17749.3 17901.0 18054.4 438918.0 584011.0 596773.0 896225.0 910507.0 58095.3 58919.4 59128.0 59416.1 59463.7 1565.4 1567.9 1568.9 1595.7 1694.6 30150.0 32406.8 34035.1 34350.0 34494.7 57463.1 58236.4 58250.7 58297.4 58316.4 457402.0 458475.0 458682.0 460228.0 462043.0 32101.5 32515.2 32524.0 32562.3 32854.7 52533.7 52629.0 52691.5 52802.2 54300.0 43341.0 43979.0 44394.0 44634.3 44834.0 42381.6 43330.0 43420.8 44159.6 44347.6 45241.7 45407.5 45447.5 45568.5 45653.8 37583.8 37704.2 37762.6 37929.0 38810.2 28541.4 29430.7 29846.4 30293.4 30315.2 15:31:33 INFO - PROCESS | 14089 | 15:31:33 INFO - PROCESS | 14089 | [#2] jquery.html Cycles:180 Average:29664.38 Median:2099.55 stddev:84181.26 (4009.5%) stddev-sans-first:84388.81 15:31:33 INFO - PROCESS | 14089 | Values: 435.3 437.1 437.5 443.2 447.2 18482.4 18604.6 19204.0 19957.3 19990.3 20104.9 20115.0 20334.3 20449.5 20572.6 5391.0 5540.9 5632.7 5638.1 5644.8 5447.6 5583.3 5586.6 5720.2 5770.5 5713.7 5723.1 5729.3 5750.0 5945.9 6379.2 6400.6 6424.0 6435.7 6439.6 5588.1 5799.9 5800.4 5819.9 5820.9 14320.4 14432.8 14440.8 14524.9 18231.6 2285.9 2405.7 2423.1 2771.3 2905.8 10055.6 10196.4 10258.6 10487.7 10771.8 1978.4 2032.4 2040.9 2078.7 2120.4 81060.6 83009.0 83860.6 84759.0 84947.6 11593.6 11769.5 11784.6 11821.5 11870.9 16323.9 16458.1 16470.8 16503.8 16599.1 8942.0 8952.7 9012.4 9144.3 9352.6 9145.4 9162.2 9198.5 9291.7 9321.2 5054.9 5072.6 5113.9 5134.2 5154.6 2061.3 2069.1 2121.1 2169.6 2194.7 1033.7 1040.8 1047.9 1100.2 1132.0 16582.0 17656.5 19084.0 19199.3 19735.0 1036.2 1040.5 1087.9 1143.6 1144.7 10468.7 10728.4 10750.8 10755.9 10870.8 500149.0 506394.0 509425.0 516439.0 519749.0 90782.5 97508.0 99268.5 99309.0 100202.0 1078.3 1086.8 1088.5 1092.6 1095.6 16835.5 16868.9 16936.0 17029.9 17131.3 37966.2 38331.6 38974.4 39206.8 39339.4 55561.2 56977.7 57092.0 57492.0 57652.7 8598.7 8664.8 8688.5 8691.4 8923.4 9735.0 13127.5 13493.4 13626.3 13636.3 11855.5 12138.8 12144.0 12146.6 12377.2 11596.1 11844.0 11894.2 12045.8 12380.9 11929.8 12200.3 12232.8 12360.5 12400.9 8604.5 8662.6 8685.8 8802.1 9006.1 11088.0 11957.4 12026.3 12115.2 12198.3 15:31:33 INFO - PROCESS | 14089 | 15:31:33 INFO - PROCESS | 14089 | [#3] mootools.html Cycles:180 Average:5775.37 Median:4809.53 stddev:3243.14 (67.4%) stddev-sans-first:3236.79 15:31:33 INFO - PROCESS | 14089 | Values: 1563.8 1570.9 1809.7 1883.6 1920.9 7757.9 8530.9 8559.4 8726.9 8739.8 8587.3 8615.4 8672.2 8702.1 8748.2 2421.0 2433.9 2449.9 2452.1 2453.0 2435.4 2454.7 2478.1 2478.6 2487.9 2424.3 2456.4 2483.6 2496.8 2501.4 2439.6 2441.2 2451.6 2483.7 2483.9 2392.3 2443.0 2457.9 2464.4 2491.3 8776.3 8846.2 8847.5 8879.5 8924.9 5421.4 5489.7 5504.1 5512.7 5529.8 3404.6 3453.0 3492.7 3543.2 3544.8 1089.1 1105.8 1130.4 1132.0 1141.7 12558.7 12600.1 12629.4 12692.0 12704.3 4725.4 4734.4 4813.0 4835.6 4924.5 10617.0 10636.7 10646.1 10659.7 10674.9 5497.1 5519.0 5523.5 5536.9 5563.1 4845.4 5014.4 5045.0 5060.7 5085.0 3941.3 3984.1 4013.7 4016.8 4065.8 1191.9 1207.5 1216.6 1221.1 1235.3 954.8 1017.3 1023.1 1026.8 1039.4 5851.7 5881.9 5892.3 5916.6 6029.2 453.6 456.6 456.9 1075.3 1076.1 3861.7 3867.8 3897.9 3901.9 3916.7 10487.6 10766.2 10769.0 10847.1 10864.9 10511.9 10536.3 10593.0 10601.4 10603.5 7967.5 8210.2 8433.0 8434.1 8526.2 5764.9 5771.9 5774.9 5893.3 5934.6 9692.8 9693.1 9809.3 9925.8 9941.0 9413.9 9601.2 9805.3 9830.5 9885.3 6725.8 7463.6 7535.5 7921.3 8162.3 8049.3 8089.6 8118.9 8135.3 8149.0 7326.0 7355.2 7395.3 7474.4 7595.1 7434.6 7598.7 7611.3 7710.3 7791.1 7011.5 7052.7 7116.4 7124.4 7138.9 4676.1 4742.2 4750.2 4872.9 4927.6 4797.7 4806.1 4813.4 4817.6 4938.7 15:31:33 INFO - PROCESS | 14089 | 15:31:33 INFO - PROCESS | 14089 | [#4] prototype.html Cycles:180 Average:5828.30 Median:6715.06 stddev:1780.70 (26.5%) stddev-sans-first:1737.49 15:31:33 INFO - PROCESS | 14089 | Values: 345.0 347.8 351.9 361.8 362.8 6573.2 6585.7 6593.4 6604.6 6671.0 6536.0 6536.6 6542.2 6551.3 6554.1 4647.9 4805.2 4881.6 4907.3 4929.2 4914.4 4936.9 4946.1 4948.0 4956.1 4891.3 4905.0 4906.3 4909.1 4922.7 4903.1 4909.1 4909.1 4912.7 4925.0 4315.9 4326.4 4337.9 4343.6 4345.1 6203.9 6288.4 6296.8 6328.9 6333.6 5752.9 5784.6 5788.7 5790.4 5797.3 6870.4 6873.6 6878.7 6886.3 6888.8 4819.9 4820.0 4821.8 4827.7 4828.0 7229.0 7252.4 7253.1 7253.5 7266.2 4848.4 4943.8 4947.2 4955.2 4967.9 4991.2 5018.5 5018.7 5021.7 5022.9 5761.7 5765.2 5772.7 5775.6 5776.2 6960.1 6969.3 6971.0 6971.3 6975.5 1750.5 1779.5 1780.6 1783.5 1786.5 1128.6 1141.1 1162.5 1181.8 1183.3 6701.5 6728.7 6731.3 6745.0 6749.4 7060.1 7185.6 7190.3 7191.5 7193.6 6744.9 6783.8 6784.7 6787.6 6796.9 3881.0 3919.9 3921.7 3925.4 3926.9 7544.6 7582.8 7600.1 7605.0 7606.9 7231.5 7311.8 7376.1 7385.6 7396.8 7562.5 7573.9 7574.1 7574.9 7579.5 7151.7 7180.0 7203.2 7224.9 7231.1 7089.4 7134.7 7137.1 7143.4 7152.1 7437.1 7558.9 7560.0 7589.8 7599.3 4786.9 4789.8 4828.9 4833.9 4841.4 7146.1 7212.6 7219.7 7225.0 7237.0 6987.3 6992.0 6992.3 7009.0 7009.9 6881.9 6960.5 6996.2 7001.0 7004.1 6849.4 6849.9 6881.2 6890.0 6891.5 6993.6 7020.0 7036.7 7039.5 7061.5 6852.2 6873.8 6881.6 6882.9 6886.7 15:31:33 INFO - PROCESS | 14089 | 15:31:33 INFO - PROCESS | 14089 | [#5] yui.html Cycles:180 Average:15076.54 Median:23694.33 stddev:17096.63 (72.2%) stddev-sans-first:17111.50 15:31:33 INFO - PROCESS | 14089 | Values: 911.8 927.3 931.7 932.6 935.9 14915.9 15199.5 15202.8 15302.8 15318.0 13044.5 13573.7 13970.9 14009.6 14124.3 903.1 918.6 926.5 926.6 930.3 908.9 911.5 917.3 918.8 918.8 931.8 937.3 938.8 941.9 942.7 928.1 930.6 931.8 934.3 936.1 690.5 691.1 693.5 694.4 695.9 13200.9 13233.3 13275.1 13345.4 13381.5 12156.0 12419.0 12467.8 12669.5 12686.4 10321.7 10615.3 10657.9 10738.6 10764.4 3872.7 3891.9 3924.2 3969.2 4038.7 51124.5 53700.0 55015.0 55662.0 55776.7 11289.4 11365.9 11631.6 11683.7 11841.3 20016.2 20042.2 20123.3 20157.2 20179.7 8554.9 8617.2 8816.6 8885.6 9045.1 4827.8 4885.2 4969.7 4979.9 5071.2 3768.2 3797.1 3798.2 3820.2 3822.9 685.8 696.6 699.3 704.4 706.2 823.5 828.7 837.3 839.7 852.1 9053.0 9086.4 9187.4 9215.5 9253.8 750.8 795.5 805.9 814.4 822.3 4259.7 4395.9 4498.2 4509.2 4646.6 60623.0 61798.0 61882.4 62062.7 62797.7 48538.3 49097.8 51860.0 54377.7 55139.2 52287.5 52389.5 52423.7 52451.2 52604.2 10171.9 10223.7 10234.6 10330.8 10357.6 36733.6 37147.3 38235.2 38318.2 39138.8 43129.0 45909.8 46567.8 47232.8 47473.0 11878.3 12250.7 12315.9 12424.6 12535.1 13589.9 14069.1 14087.9 14151.0 14386.7 12736.5 12781.6 13057.9 13216.4 13310.1 12928.5 12943.5 12949.6 13238.8 13252.3 13195.7 13301.0 13313.7 13377.5 13380.5 11180.5 11319.5 11391.1 11479.0 11546.1 10937.2 11220.8 11419.1 11526.5 11580.6 15:31:33 INFO - PROCESS | 14089 | -------- Summary: end -------- 15:31:33 INFO - PROCESS | 14089 | 15:31:34 INFO - TEST-INFO | 14089: exit 0 15:31:34 INFO - TEST-OK | dromaeo_css | took 1107832ms 15:31:34 INFO - TEST-START | kraken 15:31:34 INFO - operating with platform_type : linux_ 15:31:34 INFO - Initialising browser for kraken test... 15:31:34 INFO - TEST-INFO | started process 14332 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprgdadV/profile http://localhost:41376/getInfo.html) 15:31:37 INFO - PROCESS | 14332 | 15:31:37 INFO - PROCESS | 14332 | (process:14410): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 15:31:38 INFO - PROCESS | 14332 | __metrics Screen width/height:1600/1200 15:31:38 INFO - PROCESS | 14332 | colorDepth:24 15:31:38 INFO - PROCESS | 14332 | Browser inner width/height: 1024/697 15:31:38 INFO - PROCESS | 14332 | __metrics 15:31:38 ERROR - PROCESS | 14332 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 15:31:39 INFO - TEST-INFO | 14332: exit 0 15:31:39 INFO - Browser initialized. 15:31:39 INFO - Running cycle 1/1 for kraken test... 15:31:39 INFO - TEST-INFO | started process 14460 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprgdadV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:31:41 INFO - PROCESS | 14460 | 15:31:41 INFO - PROCESS | 14460 | (process:14529): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 15:31:51 INFO - PROCESS | 14460 | RSS: Main: 150781952 15:31:51 INFO - PROCESS | 14460 | 15:31:53 INFO - PROCESS | 14460 | Cycle 1(1): loaded http://localhost:41376/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41376/tests/kraken/driver.html?testName=audio-beat-detection) 15:31:54 INFO - PROCESS | 14460 | RSS: Main: 156467200 15:31:54 INFO - PROCESS | 14460 | 15:31:57 INFO - PROCESS | 14460 | Cycle 1(1): loaded http://localhost:41376/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41376/tests/kraken/driver.html?testName=audio-dft) 15:31:57 INFO - PROCESS | 14460 | RSS: Main: 156397568 15:31:57 INFO - PROCESS | 14460 | 15:32:00 INFO - PROCESS | 14460 | Cycle 1(1): loaded http://localhost:41376/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41376/tests/kraken/driver.html?testName=audio-fft) 15:32:01 INFO - PROCESS | 14460 | RSS: Main: 156540928 15:32:01 INFO - PROCESS | 14460 | 15:32:03 INFO - PROCESS | 14460 | Cycle 1(1): loaded http://localhost:41376/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41376/tests/kraken/driver.html?testName=audio-oscillator) 15:32:04 INFO - PROCESS | 14460 | RSS: Main: 156377088 15:32:04 INFO - PROCESS | 14460 | 15:32:06 INFO - PROCESS | 14460 | Cycle 1(1): loaded http://localhost:41376/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41376/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:32:06 INFO - PROCESS | 14460 | RSS: Main: 156094464 15:32:06 INFO - PROCESS | 14460 | 15:32:09 INFO - PROCESS | 14460 | Cycle 1(1): loaded http://localhost:41376/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41376/tests/kraken/driver.html?testName=imaging-darkroom) 15:32:10 INFO - PROCESS | 14460 | RSS: Main: 156459008 15:32:10 INFO - PROCESS | 14460 | 15:32:13 INFO - PROCESS | 14460 | Cycle 1(1): loaded http://localhost:41376/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41376/tests/kraken/driver.html?testName=imaging-desaturate) 15:32:14 INFO - PROCESS | 14460 | RSS: Main: 156614656 15:32:14 INFO - PROCESS | 14460 | 15:32:17 INFO - PROCESS | 14460 | Cycle 1(1): loaded http://localhost:41376/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41376/tests/kraken/driver.html?testName=json-parse-financial) 15:32:17 INFO - PROCESS | 14460 | RSS: Main: 156246016 15:32:17 INFO - PROCESS | 14460 | 15:32:19 INFO - PROCESS | 14460 | Cycle 1(1): loaded http://localhost:41376/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41376/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:32:20 INFO - PROCESS | 14460 | RSS: Main: 155779072 15:32:20 INFO - PROCESS | 14460 | 15:32:21 INFO - PROCESS | 14460 | Cycle 1(1): loaded http://localhost:41376/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41376/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:32:22 INFO - PROCESS | 14460 | RSS: Main: 156037120 15:32:22 INFO - PROCESS | 14460 | 15:32:24 INFO - PROCESS | 14460 | Cycle 1(1): loaded http://localhost:41376/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41376/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:32:25 INFO - PROCESS | 14460 | RSS: Main: 156459008 15:32:25 INFO - PROCESS | 14460 | 15:32:27 INFO - PROCESS | 14460 | Cycle 1(1): loaded http://localhost:41376/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41376/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:32:28 INFO - PROCESS | 14460 | RSS: Main: 157007872 15:32:28 INFO - PROCESS | 14460 | 15:32:30 INFO - PROCESS | 14460 | Cycle 1(1): loaded http://localhost:41376/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41376/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:32:31 INFO - PROCESS | 14460 | RSS: Main: 156807168 15:32:31 INFO - PROCESS | 14460 | 15:32:33 INFO - PROCESS | 14460 | Cycle 1(1): loaded http://localhost:41376/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41376/tests/kraken/driver.html?testName=ai-astar) 15:32:33 INFO - PROCESS | 14460 | RSS: Main: 158081024 15:32:33 INFO - PROCESS | 14460 | 15:32:33 INFO - PROCESS | 14460 | __start_tp_report 15:32:33 INFO - PROCESS | 14460 | _x_x_mozilla_page_load 15:32:33 INFO - PROCESS | 14460 | _x_x_mozilla_page_load_details 15:32:33 INFO - PROCESS | 14460 | |i|pagename|runs| 15:32:33 INFO - PROCESS | 14460 | |0;ai-astar;110;111;104;109;111;111;102;109;113;111 15:32:33 INFO - PROCESS | 14460 | |1;audio-beat-detection;157;128;161;185;127;160;157;139;181;127 15:32:33 INFO - PROCESS | 14460 | |2;audio-dft;162;162;163;162;163;164;166;163;161;163 15:32:33 INFO - PROCESS | 14460 | |3;audio-fft;76;77;76;192;77;78;76;76;183;76 15:32:33 INFO - PROCESS | 14460 | |4;audio-oscillator;93;93;158;92;91;93;158;94;93;152 15:32:33 INFO - PROCESS | 14460 | |5;imaging-gaussian-blur;117;117;118;120;118;118;118;118;118;117 15:32:33 INFO - PROCESS | 14460 | |6;imaging-darkroom;146;147;146;147;147;146;146;147;148;147 15:32:33 INFO - PROCESS | 14460 | |7;imaging-desaturate;96;96;95;96;95;95;95;94;96;95 15:32:33 INFO - PROCESS | 14460 | |8;json-parse-financial;56;60;57;56;55;58;67;74;56;54 15:32:33 INFO - PROCESS | 14460 | |9;json-stringify-tinderbox;60;60;60;60;60;60;60;61;60;59 15:32:33 INFO - PROCESS | 14460 | |10;stanford-crypto-aes;74;74;73;83;73;75;77;77;78;81 15:32:33 INFO - PROCESS | 14460 | |11;stanford-crypto-ccm;121;119;124;119;123;114;114;112;134;140 15:32:33 INFO - PROCESS | 14460 | |12;stanford-crypto-pbkdf2;163;160;162;159;161;164;175;161;163;163 15:32:33 INFO - PROCESS | 14460 | |13;stanford-crypto-sha256-iterative;68;68;68;68;68;72;68;68;67;69 15:32:33 INFO - PROCESS | 14460 | __end_tp_report 15:32:33 INFO - PROCESS | 14460 | __start_cc_report 15:32:33 INFO - PROCESS | 14460 | _x_x_mozilla_cycle_collect,865 15:32:33 INFO - PROCESS | 14460 | __end_cc_report 15:32:33 INFO - PROCESS | 14460 | __startTimestamp1469140353420__endTimestamp 15:32:33 INFO - PROCESS | 14460 | 15:32:33 INFO - PROCESS | 14460 | ------- Summary: start ------- 15:32:33 INFO - PROCESS | 14460 | Number of tests: 14 15:32:33 INFO - PROCESS | 14460 | 15:32:33 INFO - PROCESS | 14460 | [#0] ai-astar Cycles:10 Average:109.10 Median:111.00 stddev:3.45 (3.1%) stddev-sans-first:3.64 15:32:33 INFO - PROCESS | 14460 | Values: 110.0 111.0 104.0 109.0 111.0 111.0 102.0 109.0 113.0 111.0 15:32:33 INFO - PROCESS | 14460 | 15:32:33 INFO - PROCESS | 14460 | [#1] audio-beat-detection Cycles:10 Average:152.20 Median:158.50 stddev:21.39 (13.5%) stddev-sans-first:22.62 15:32:33 INFO - PROCESS | 14460 | Values: 157.0 128.0 161.0 185.0 127.0 160.0 157.0 139.0 181.0 127.0 15:32:33 INFO - PROCESS | 14460 | 15:32:33 INFO - PROCESS | 14460 | [#2] audio-dft Cycles:10 Average:162.90 Median:163.00 stddev:1.37 (0.8%) stddev-sans-first:1.41 15:32:33 INFO - PROCESS | 14460 | Values: 162.0 162.0 163.0 162.0 163.0 164.0 166.0 163.0 161.0 163.0 15:32:33 INFO - PROCESS | 14460 | 15:32:33 INFO - PROCESS | 14460 | [#3] audio-fft Cycles:10 Average:98.70 Median:76.00 stddev:46.85 (61.7%) stddev-sans-first:48.97 15:32:33 INFO - PROCESS | 14460 | Values: 76.0 77.0 76.0 192.0 77.0 78.0 76.0 76.0 183.0 76.0 15:32:33 INFO - PROCESS | 14460 | 15:32:33 INFO - PROCESS | 14460 | [#4] audio-oscillator Cycles:10 Average:111.70 Median:93.00 stddev:30.62 (32.9%) stddev-sans-first:31.72 15:32:33 INFO - PROCESS | 14460 | Values: 93.0 93.0 158.0 92.0 91.0 93.0 158.0 94.0 93.0 152.0 15:32:33 INFO - PROCESS | 14460 | 15:32:33 INFO - PROCESS | 14460 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:0.88 (0.7%) stddev-sans-first:0.87 15:32:33 INFO - PROCESS | 14460 | Values: 117.0 117.0 118.0 120.0 118.0 118.0 118.0 118.0 118.0 117.0 15:32:33 INFO - PROCESS | 14460 | 15:32:33 INFO - PROCESS | 14460 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.67 (0.5%) stddev-sans-first:0.67 15:32:33 INFO - PROCESS | 14460 | Values: 146.0 147.0 146.0 147.0 147.0 146.0 146.0 147.0 148.0 147.0 15:32:33 INFO - PROCESS | 14460 | 15:32:33 INFO - PROCESS | 14460 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.50 stddev:0.67 (0.7%) stddev-sans-first:0.67 15:32:33 INFO - PROCESS | 14460 | Values: 96.0 96.0 95.0 96.0 95.0 95.0 95.0 94.0 96.0 95.0 15:32:33 INFO - PROCESS | 14460 | 15:32:33 INFO - PROCESS | 14460 | [#8] json-parse-financial Cycles:10 Average:59.30 Median:57.50 stddev:6.34 (11.0%) stddev-sans-first:6.61 15:32:33 INFO - PROCESS | 14460 | Values: 56.0 60.0 57.0 56.0 55.0 58.0 67.0 74.0 56.0 54.0 15:32:33 INFO - PROCESS | 14460 | 15:32:33 INFO - PROCESS | 14460 | [#9] json-stringify-tinderbox Cycles:10 Average:60.00 Median:60.00 stddev:0.47 (0.8%) stddev-sans-first:0.50 15:32:33 INFO - PROCESS | 14460 | Values: 60.0 60.0 60.0 60.0 60.0 60.0 60.0 61.0 60.0 59.0 15:32:33 INFO - PROCESS | 14460 | 15:32:33 INFO - PROCESS | 14460 | [#10] stanford-crypto-aes Cycles:10 Average:76.50 Median:77.00 stddev:3.41 (4.4%) stddev-sans-first:3.49 15:32:33 INFO - PROCESS | 14460 | Values: 74.0 74.0 73.0 83.0 73.0 75.0 77.0 77.0 78.0 81.0 15:32:33 INFO - PROCESS | 14460 | 15:32:33 INFO - PROCESS | 14460 | [#11] stanford-crypto-ccm Cycles:10 Average:122.00 Median:122.00 stddev:8.94 (7.3%) stddev-sans-first:9.48 15:32:33 INFO - PROCESS | 14460 | Values: 121.0 119.0 124.0 119.0 123.0 114.0 114.0 112.0 134.0 140.0 15:32:33 INFO - PROCESS | 14460 | 15:32:33 INFO - PROCESS | 14460 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.10 Median:163.00 stddev:4.46 (2.7%) stddev-sans-first:4.73 15:32:33 INFO - PROCESS | 14460 | Values: 163.0 160.0 162.0 159.0 161.0 164.0 175.0 161.0 163.0 163.0 15:32:33 INFO - PROCESS | 14460 | 15:32:33 INFO - PROCESS | 14460 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.40 Median:68.00 stddev:1.35 (2.0%) stddev-sans-first:1.42 15:32:33 INFO - PROCESS | 14460 | Values: 68.0 68.0 68.0 68.0 68.0 72.0 68.0 68.0 67.0 69.0 15:32:33 INFO - PROCESS | 14460 | -------- Summary: end -------- 15:32:33 INFO - PROCESS | 14460 | 15:32:34 INFO - TEST-INFO | 14460: exit 0 15:32:34 INFO - TEST-OK | kraken | took 60153ms 15:32:34 INFO - SUITE-END | took 1167s 15:32:34 INFO - Completed test suite (00:19:28) 15:32:34 INFO - javascript benchmark 15:32:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3316.253842885351, 3398.422268214403, 3427.091820667522, 3462.2036931505754, 3474.114100904269, 5629.0, 5647.887042259153, 5671.659700417978, 5672.149177623359, 5681.119426488895, 5635.887282254363, 5668.356176708749, 5674.914876276859, 5676.971615141929, 5688.772449102031, 5102.948970510303, 5124.308218390525, 5152.613553983448, 5201.609879259052, 5207.973960130213, 5057.721825299607, 5121.180611102224, 5254.81608143715, 5276.604254680895, 5280.339957505312, 5132.332796736419, 5159.974200128994, 5252.107141785887, 5266.5523430508265, 5308.5487733542695, 5197.844064678085, 5200.08998425276, 5218.112920803473, 5220.791168353261, 5248.239005344242, 5015.27278544609, 5067.695938243717, 5137.0, 5164.2253661950635, 5193.065248255312, 5442.074847275972, 5514.889702205934, 5547.916781248285, 5555.0, 5588.524975377098, 6016.278046634388, 6054.848628784272, 6062.818115456544, 6065.696715164268, 6073.605215661012, 5922.082077278029, 5991.101334799771, 6107.4808641265545, 6112.847178820521, 6128.938710612926, 5682.346530149044, 5690.772369105231, 5696.401877802854, 5706.77172913083, 5735.684537350444, 6177.733564619242, 6201.472874805692, 6204.100405441186, 6208.0, 6217.720202590895, 5836.503897168788, 5936.317323507766, 5954.196183515257, 5960.970195149083, 6085.0, 6107.603005804697, 6111.54163437744, 6112.205413296243, 6121.204243448323, 6126.08108783686, 6012.939870601238, 6029.638221706711, 6032.336442991267, 6063.0, 6074.179985701874, 5805.912911306334, 5890.2342695449315, 6013.067974463965, 6055.909161362583, 6064.787732429432, 4569.725816451024, 4596.908061838812, 4598.149342371605, 4608.124456353349, 4616.838410655611, 4096.856610018635, 4104.261232978092, 4133.772642504691, 4147.398627199039, 4172.061286210578, 5657.066584013592, 5687.090065589486, 5768.394318596571, 5796.362400135981, 5814.156947242626, 5946.375630558816, 6084.087386891913, 6124.350421260821, 6137.355577664281, 6141.6007959482495, 5649.971750141305, 5809.2738407699035, 5840.912386314209, 5845.590808643354, 5847.766089356463, 5152.639315247971, 5226.764795584208, 5236.214567814858, 5249.0, 5274.077036518594, 6297.622142671455, 6297.968510157511, 6329.841753956188, 6338.176037115146, 6351.142595749607, 5937.0, 6033.87932241344, 6084.482818960438, 6103.7253323601435, 6106.419890110433, 6343.5876668016435, 6400.23197216337, 6412.647304398116, 6417.326180750954, 6419.711112999833, 6032.245969253843, 6034.939650603614, 6045.425684559959, 6047.485963693135, 6048.516118710405, 5992.67040312787, 6007.54943379257, 6113.263474096151, 6154.046122850787, 6164.075388691732, 5908.291005079418, 5921.407859214044, 5938.881222375615, 5940.0, 5947.702614869326, 5841.094630332305, 5852.590318677651, 5891.440313170242, 5899.587028907935, 5923.170756094237, 5724.0, 5796.246487956539, 5834.38738932406, 5857.560682948882, 5945.10823376497, 6004.189434426296, 6041.2750469943885, 6050.757969681339, 6062.393760623902, 6062.7271772769445, 5888.234529511136, 5891.1752354669525, 5893.381194974638, 5918.496927761188, 5920.615160014585], "value": 5605.840738139337, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [665.740361259109, 676.8274090107022, 696.3663066609387, 723.2694978072149, 744.9830980711329, 38696.61303386969, 39731.404028939556, 39784.2043159137, 40084.79957600215, 40234.79882600583, 42583.574164258345, 43331.0, 43440.13119737611, 43442.34836477455, 43450.56549434505, 8721.084286149942, 8924.062973387798, 8934.061923498004, 8943.686970956018, 8955.776105597348, 8740.038595754462, 8833.33749968755, 8840.734777956672, 9027.548622568878, 9037.95481022594, 9076.909230907673, 9077.183053525181, 9140.040295768948, 9151.03914089021, 9176.587053582605, 9013.278937684969, 9062.365634405594, 9089.818203635956, 9108.681196158102, 9146.725598232031, 8932.330075244317, 8985.46087234768, 8985.505797181153, 9013.0, 9122.270218382513, 43152.78423607893, 43559.564404355864, 43613.0, 43677.0, 43698.12603747907, 3762.322781899257, 3896.0649444133487, 3920.2159568086495, 4066.877993660195, 4482.238019536687, 33852.0, 34079.31841363159, 34153.487697684555, 34260.14349641254, 34408.82795586031, 4516.18708632446, 4533.569310915491, 4590.173768721629, 4659.953400465985, 4692.648051396125, 304504.0, 306957.0, 307048.0, 307300.0, 309092.0, 64729.67635161794, 64843.67578162079, 64946.35053649403, 65056.0, 65079.34920650733, 70860.64569677119, 71671.64164179146, 71904.0, 72005.0, 72369.46706865235, 18838.623227535372, 19110.90444547796, 19150.04249787533, 19259.0, 19263.4220973371, 14947.925260373846, 15006.249687515581, 15020.774688379683, 15034.17312047848, 15063.397464101532, 20185.899070504554, 20309.49226269355, 20438.79561204369, 20567.588648226953, 21180.894095529733, 7853.921460785434, 7876.251756083163, 7974.322182614426, 8034.437589368688, 8085.272325490734, 1137.4426530999751, 1166.836642869999, 1184.3308530680138, 1201.7536405036947, 1251.7246205834701, 33613.49579756305, 33683.831580841936, 33696.32607347839, 33909.32181356359, 34108.0, 1231.384307846077, 1236.0470456678427, 1263.620913725897, 1292.3021568353172, 1332.5336132353793, 17610.47168584919, 17683.95501415131, 17749.290028398977, 17901.0, 18054.368097116538, 438918.0, 584011.0, 596773.0, 896225.0, 910507.0, 58095.2571422858, 58919.41080589225, 59128.0, 59416.10875836866, 59463.70268148718, 1565.3738504598252, 1567.9216039197995, 1568.874490040817, 1595.718123084001, 1694.5594145522252, 30150.0, 32406.83796581002, 34035.14912127217, 34350.0, 34494.65505344915, 57463.1380529284, 58236.41763582479, 58250.70874645769, 58297.417025830895, 58316.4168358311, 457402.0, 458475.0, 458682.0, 460228.0, 462043.0, 32101.518477222395, 32515.18712032218, 32524.0, 32562.348753025282, 32854.671453286115, 52533.737331313096, 52629.0, 52691.47308527019, 52802.22001507227, 54300.0, 43341.0, 43979.0, 44394.0, 44634.3304850421, 44833.98247078824, 42381.576184239, 43330.0, 43420.782896085315, 44159.55840441555, 44347.556524434345, 45241.737913103556, 45407.54592454166, 45447.54552454433, 45568.54431455643, 45653.77173114113, 37583.812080940515, 37704.245915082094, 37762.622373775914, 37929.0, 38810.22379552449, 28541.429171416872, 29430.70569294365, 29846.403071938876, 30293.394132117675, 30315.242118947204], "value": 21635.960322157498, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [435.2600579015674, 437.14974374840926, 437.53402626203103, 443.2088721631888, 447.1771939631078, 18482.35311764087, 18604.62790744184, 19204.0, 19957.301494447696, 19990.30033948812, 20104.89947550264, 20115.0, 20334.28829990947, 20449.488762780937, 20572.588548229065, 5391.0, 5540.9168862467095, 5632.746526406301, 5638.097904335307, 5644.8306550803545, 5447.645903016291, 5583.274174357328, 5586.581006424514, 5720.227769251161, 5770.4518070783415, 5713.742881570319, 5723.141528770676, 5729.28383952006, 5749.993751093562, 5945.910811337833, 6379.202599675041, 6400.551961362707, 6423.967880160592, 6435.68068545947, 6439.613623182624, 5588.133839254881, 5799.855003624901, 5800.4489573490455, 5819.854503637401, 5820.883582328372, 14320.35558399864, 14432.783508247385, 14440.783388249185, 14524.854751452456, 18231.63536729271, 2285.919992800244, 2405.6632071510003, 2423.1397853762014, 2771.2517620242625, 2905.8111222770453, 10055.648052318207, 10196.439195844225, 10258.640947566799, 10487.685369438928, 10771.784564308748, 1978.4262563856607, 2032.400441869652, 2040.9081591328427, 2078.6570215914508, 2120.4380839077658, 81060.59469702673, 83009.0, 83860.58069709674, 84759.0, 84947.5752621233, 11593.594224202112, 11769.470373833026, 11784.646460606196, 11821.468033938494, 11870.88129118715, 16323.918380408022, 16458.09480478585, 16470.83529164717, 16503.83496165047, 16599.087050212354, 8942.0, 8952.68665596714, 9012.369134160677, 9144.268458523302, 9352.625894964262, 9145.405548639317, 9162.175404213653, 9198.540072996324, 9291.72124836256, 9321.207697345802, 5054.873628159326, 5072.594192464594, 5113.948860511422, 5134.2298655201275, 5154.557358835, 2061.2693867573953, 2069.1102825785056, 2121.11973530986, 2169.620316444616, 2194.6707993800737, 1033.679559336608, 1040.8282633365409, 1047.8847326794046, 1100.2023532938556, 1132.020802006275, 16582.0, 17656.470305890845, 19084.04579771006, 19199.32802351911, 19735.0, 1036.1814166808138, 1040.5005597313182, 1087.9456027198607, 1143.5997400909782, 1144.6508814811395, 10468.68593942183, 10728.356298622108, 10750.78498430027, 10755.892441075646, 10870.836937445945, 500149.0, 506394.0, 509425.0, 516439.0, 519749.0, 90782.54608727046, 97508.0, 99268.50365748125, 99309.0, 100202.0, 1078.309881675728, 1086.7935092332432, 1088.4666513408372, 1092.6285063078592, 1095.611058074388, 16835.494935151964, 16868.915655421646, 16936.0, 17029.91485042567, 17131.314747409964, 37966.24067518579, 38331.616683832806, 38974.4153837687, 39206.80396597999, 39339.409908851965, 55561.166582502105, 56977.71511142418, 57092.0, 57492.0, 57652.71173644105, 8598.699045533376, 8664.78338041554, 8688.464181497453, 8691.391602587759, 8923.41997770143, 9734.971942310003, 13127.540536081191, 13493.39279732434, 13626.250556219504, 13636.318184090558, 11855.466504007169, 12138.817917731065, 12144.028477721584, 12146.635600931986, 12377.195482293622, 11596.130290228099, 11843.993260572603, 11894.226875253082, 12045.81931271014, 12380.938095309466, 11929.82105268439, 12200.267983920992, 12232.816507752214, 12360.505579776709, 12400.875991239973, 8604.48373097616, 8662.566871656518, 8685.826283474169, 8802.119788021148, 9006.054364291655, 11088.0, 11957.402129893644, 12026.338551379758, 12115.212511186744, 12198.268103913793], "value": 9457.117386485967, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1563.8279789223186, 1570.9214539273037, 1809.6833054215508, 1883.642107999479, 1920.923163073477, 7757.922420775791, 8530.91469085309, 8559.358048146383, 8726.869096963543, 8739.825203495926, 8587.313014958803, 8615.396922215448, 8672.219500244977, 8702.086280940504, 8748.212660860521, 2421.0436877433403, 2433.914812981546, 2449.8530088194766, 2452.104981681682, 2453.018792483012, 2435.403326185078, 2454.717707463638, 2478.1450399612104, 2478.603423452248, 2487.8507289562685, 2424.260600516842, 2456.4227406559444, 2483.5777917753935, 2496.7877730392847, 2501.374656335916, 2439.5974664180476, 2441.2066078524463, 2451.6445115458246, 2483.67712197415, 2483.9379015524755, 2392.2823153054187, 2443.035001174544, 2457.913973010954, 2464.4331803685072, 2491.2899823550383, 8776.341774366949, 8846.203841654282, 8847.46915185091, 8879.51162686052, 8924.910750892474, 5421.403645598981, 5489.670619762827, 5504.119340905436, 5512.6968016759065, 5529.834104976857, 3404.557407537029, 3453.0, 3492.703120234783, 3543.202779374646, 3544.8404821783083, 1089.0906093412011, 1105.8175401058816, 1130.3556972525664, 1132.0377678972889, 1141.680329507731, 12558.68603284916, 12600.054995875254, 12629.368531573477, 12692.0, 12704.301263430507, 4725.432948046257, 4734.4081989751285, 4812.951870481321, 4835.588974937099, 4924.482929292372, 10617.0, 10636.734081648021, 10646.095081917969, 10659.733506662396, 10674.946625266824, 5497.065498865202, 5519.0, 5523.475269849358, 5536.889262214733, 5563.082091454946, 4845.41854977405, 5014.448410674823, 5044.974775126101, 5060.746962651852, 5085.0338435697095, 3941.3496773032703, 3984.1234928315725, 4013.678905687538, 4016.819243134066, 4065.776382299002, 1191.9106067045007, 1207.5350989868964, 1216.6046035038648, 1221.065884598283, 1235.3329202230696, 954.7994921066654, 1017.308230403318, 1023.1354505442889, 1026.7689769801734, 1039.4231201682987, 5851.678157701367, 5881.852953676107, 5892.322382925932, 5916.556258280646, 6029.246344206974, 453.6302913125792, 456.6050366433078, 456.8766433063054, 1075.3171735947574, 1076.101455284846, 3861.7296789225047, 3867.767933923917, 3897.8635747748694, 3901.8634347797692, 3916.667083297895, 10487.632932847466, 10766.246362754531, 10769.03078722903, 10847.132229421784, 10864.891351086546, 10511.894881051245, 10536.315139515908, 10593.0, 10601.363918164934, 10603.469826508644, 7967.48211366271, 8210.220029097227, 8432.957835210907, 8434.114417986146, 8526.232639062515, 5764.913526297193, 5771.94228057714, 5774.855628609318, 5893.292804863444, 5934.614250073904, 9692.75768105803, 9693.079157480028, 9809.313348065853, 9925.751856203653, 9940.950295248478, 9413.905860941577, 9601.231901448007, 9805.313628045968, 9830.459324737209, 9885.308028437941, 6725.764598239038, 7463.552186868806, 7535.472516923763, 7921.2870841622225, 8162.347012238888, 8049.315808156372, 8089.555074470961, 8118.9188108120525, 8135.349172066102, 8148.959255203686, 7326.010988516482, 7355.190928997699, 7395.260473952561, 7474.439417043852, 7595.126560445619, 7434.553926764412, 7598.658060387185, 7611.2769286917655, 7710.306072453506, 7791.0650721913735, 7011.544249623758, 7052.682629281797, 7116.359527642537, 7124.430045596237, 7138.928610713826, 4676.134915040729, 4742.217534106834, 4750.239961606127, 4872.90254194907, 4927.556519913225, 4797.664163508521, 4806.110869489155, 4813.422389313305, 4817.590504807131, 4938.728369939688], "value": 4633.239220309161, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [344.9879254226102, 347.846947343169, 351.90146758907497, 361.78112242093533, 362.77145398399006, 6573.1783527059115, 6585.670716464181, 6593.373629505195, 6604.603723776565, 6670.999999999994, 6535.967320163404, 6536.575122617027, 6542.214934207902, 6551.312112228219, 6554.082428460019, 4647.907041859169, 4805.20714082176, 4881.633877459187, 4907.337509436216, 4929.186684197121, 4914.434839993393, 4936.851894443154, 4946.08497427977, 4947.975260123694, 4956.083124621939, 4891.266310053485, 4905.018996200756, 4906.288588154715, 4909.140900342443, 4922.729249891255, 4903.068417000776, 4909.091818013679, 4909.116359055369, 4912.705237685733, 4925.014997000614, 4315.942594064443, 4326.394304797331, 4337.934930976038, 4343.565643435662, 4345.109252603241, 6203.937960620381, 6288.371162883721, 6296.842578935518, 6328.905066424008, 6333.55665103443, 5752.856178595527, 5784.566157538202, 5788.652680839163, 5790.36306006339, 5797.275340582427, 6870.419803445236, 6873.553219040747, 6878.69045892936, 6886.311368863124, 6888.758893438706, 4819.855404337841, 4819.95180048202, 4821.842757738117, 4827.710337379734, 4828.0, 7229.024081748949, 7252.3835473984245, 7253.057102576631, 7253.528520646141, 7266.164391095039, 4848.442429120696, 4943.752812359367, 4947.208446648519, 4955.207166853286, 4967.850964471072, 4991.176455884811, 5018.4730603286125, 5018.698878067327, 5021.72380519075, 5022.94518151185, 5761.683107429131, 5765.221695071195, 5772.6536407815665, 5775.624584402084, 5776.191333213354, 6960.129983752031, 6969.303069693092, 6971.024056632075, 6971.268016858258, 6975.51171418006, 1750.4748575427575, 1779.4839496545856, 1780.5548612846787, 1783.5006198264507, 1786.5355007698092, 1128.5937062657438, 1141.0871302957767, 1162.4594563528, 1181.787278289916, 1183.260462211118, 6701.463882889358, 6728.6635668216395, 6731.326867313327, 6744.966275168691, 6749.42629876466, 7060.117485314336, 7185.6047917364, 7190.280971902873, 7191.496595238388, 7193.568385896863, 6744.898826517606, 6783.796486105425, 6784.660766961731, 6787.5588086774205, 6796.864062718718, 3881.0491429599365, 3919.941200881989, 3921.7254792164276, 3925.391564307537, 3926.9410958835642, 7544.6227688616445, 7582.772516824504, 7600.087989441192, 7605.049368828896, 7606.923930760732, 7231.5299505531975, 7311.780646580611, 7376.114866216089, 7385.593792341366, 7396.778096657109, 7562.508436951581, 7573.886391704129, 7574.091109066837, 7574.886376704354, 7579.54522728638, 7151.713931442684, 7179.964100179465, 7203.243659415686, 7224.89162662571, 7231.132264128339, 7089.361957423856, 7134.714611415485, 7137.10786151731, 7143.428525718034, 7152.105986751656, 7437.070366204224, 7558.9244107558225, 7559.979402780555, 7589.772306830804, 7599.316061554487, 4786.880327991828, 4789.808407663654, 4828.927566086441, 4833.879153021203, 4841.370621819141, 7146.071010768567, 7212.603306818175, 7219.6751146199595, 7224.963875180591, 7237.0, 6987.336203060701, 6991.965040174767, 6992.3357281058215, 7009.018737376669, 7009.878419452863, 6881.93118068833, 6960.512764106464, 6996.160460744743, 7001.0, 7004.124484439445, 6849.4177994869, 6849.863002740017, 6881.208661004049, 6890.035395044798, 6891.517593768388, 6993.580385176906, 7019.964900175466, 7036.718531258693, 7039.472039596948, 7061.470389720895, 6852.246252912076, 6873.828154296182, 6881.621510816954, 6882.8623427530165, 6886.655667216719], "value": 5243.700480182928, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [911.7766147293913, 927.258193445244, 931.7484279244604, 932.5570354081812, 935.8830146231721, 14915.925420372896, 15199.544013679593, 15202.847971520296, 15302.770458443132, 15318.0, 13044.478220871153, 13573.660658483543, 13970.860291397083, 14009.649758756037, 14124.29378531072, 903.0743487924881, 918.6187732091174, 926.5182105305237, 926.647873807952, 930.2929773372218, 908.8863892013499, 911.5487833522416, 917.3486824354716, 918.76112210825, 918.8024574716435, 931.8229536388064, 937.3438592984904, 938.7887725261795, 941.9199368053723, 942.6700654770809, 928.0904713380856, 930.6230976454547, 931.7810314576103, 934.2572654739498, 936.1434287626881, 690.4683393786806, 691.0601581848682, 693.4521727835004, 694.3924066441863, 695.8712638161957, 13200.867991320156, 13233.272170030645, 13275.137116087424, 13345.399457024458, 13381.464741410331, 12156.0, 12419.0, 12467.812982805266, 12669.493220271179, 12686.365681715877, 10321.690349289533, 10615.256932014761, 10657.946710266398, 10738.624148154777, 10764.407957562331, 3872.67082298005, 3891.922161556753, 3924.1759230561615, 3969.186316805048, 4038.717289789716, 51124.48875511235, 53700.0, 55015.0, 55662.0, 55776.72111639456, 11289.379084150287, 11365.886341136647, 11631.59289424866, 11683.707907302385, 11841.28952262867, 20016.199352025757, 20042.198312067645, 20123.295684650966, 20157.19371225164, 20179.697304540445, 8554.871676924851, 8617.224449799423, 8816.647334106563, 8885.600147993357, 9045.140711632384, 4827.806887724522, 4885.193942999436, 4969.701817890938, 4979.925301120486, 5071.239314102914, 3768.171002379472, 3797.1456422305314, 3798.164403831153, 3820.2168555446065, 3822.9235415291537, 685.8114018644912, 696.5646470955653, 699.2937133495207, 704.383664293743, 706.1773034414849, 823.5017814222309, 828.668532586958, 837.3092198935902, 839.6935118681637, 852.0669866496177, 9053.0, 9086.36395452312, 9187.402818816889, 9215.53922303882, 9253.814923701622, 750.7822731407831, 795.5163619849055, 805.8871757953891, 814.3973459639824, 822.2928281677753, 4259.659227261812, 4395.868123956287, 4498.190325741332, 4509.188346097669, 4646.558576935186, 60623.0, 61798.0, 61882.38117618856, 62062.689686551275, 62797.68601156965, 48538.27192592114, 49097.75451122793, 51860.0, 54377.72811135919, 55139.17291240635, 52287.47712522902, 52389.476105239984, 52423.73788131035, 52451.21323180155, 52604.21093683598, 10171.898281017391, 10223.737736300336, 10234.590616375262, 10330.845037324596, 10357.63748268807, 36733.63266367302, 37147.25705485929, 38235.23529529338, 38318.23363532769, 39138.80430597829, 43129.0, 45909.77045114753, 46567.767161163974, 47232.7638361806, 47473.0, 11878.346690932081, 12250.693732656755, 12315.93842030784, 12424.56514022005, 12535.122541422377, 13589.864101359255, 14069.085509441853, 14087.929560352133, 14150.966974412655, 14386.712265754835, 12736.490540378281, 12781.61655150347, 13057.934710326388, 13216.405261763051, 13310.134841235289, 12928.547500837802, 12943.482260709467, 12949.611511654666, 13238.801417978932, 13252.337383130998, 13195.736085278433, 13301.0, 13313.667158320732, 13377.53178638743, 13380.464781409024, 11180.496877640364, 11319.490622922152, 11391.145664075393, 11479.0, 11546.0763138947, 10937.234393592373, 11220.824071133771, 11419.0864730823, 11526.481308340977, 11580.594679186524], "value": 7088.570719573407, "unit": "score"}], "name": "dromaeo_css", "value": 7631.609458633876, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 111.0, 104.0, 109.0, 111.0, 111.0, 102.0, 109.0, 113.0, 111.0], "value": 109.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 128.0, 161.0, 185.0, 127.0, 160.0, 157.0, 139.0, 181.0, 127.0], "value": 152.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 163.0, 162.0, 163.0, 164.0, 166.0, 163.0, 161.0, 163.0], "value": 162.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 76.0, 192.0, 77.0, 78.0, 76.0, 76.0, 183.0, 76.0], "value": 98.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 158.0, 92.0, 91.0, 93.0, 158.0, 94.0, 93.0, 152.0], "value": 111.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 120.0, 118.0, 118.0, 118.0, 118.0, 118.0, 117.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 147.0, 147.0, 146.0, 146.0, 147.0, 148.0, 147.0], "value": 146.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 95.0, 96.0, 95.0, 95.0, 95.0, 94.0, 96.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 60.0, 57.0, 56.0, 55.0, 58.0, 67.0, 74.0, 56.0, 54.0], "value": 59.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 60.0, 60.0, 60.0, 60.0, 60.0, 61.0, 60.0, 59.0], "value": 60.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 73.0, 83.0, 73.0, 75.0, 77.0, 77.0, 78.0, 81.0], "value": 76.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 119.0, 124.0, 119.0, 123.0, 114.0, 114.0, 112.0, 134.0, 140.0], "value": 122.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 160.0, 162.0, 159.0, 161.0, 164.0, 175.0, 161.0, 163.0, 163.0], "value": 163.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 68.0, 68.0, 68.0, 72.0, 68.0, 68.0, 67.0, 69.0], "value": 68.4, "unit": "score"}], "name": "kraken", "value": 1543.8, "alertThreshold": 2.0}]} 15:32:34 INFO - Return code: 0 15:32:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 15:32:34 ERROR - # TBPL SUCCESS # 15:32:34 INFO - Running post-action listener: _resource_record_post_action 15:32:34 INFO - Running post-run listener: _resource_record_post_run 15:32:35 INFO - Total resource usage - Wall time: 1183s; CPU: 13.0%; Read bytes: 4096; Write bytes: 466087936; Read time: 12; Write time: 365836 15:32:35 INFO - install - Wall time: 14s; CPU: 14.0%; Read bytes: 0; Write bytes: 242548736; Read time: 0; Write time: 251984 15:32:35 INFO - run-tests - Wall time: 1170s; CPU: 13.0%; Read bytes: 4096; Write bytes: 223539200; Read time: 12; Write time: 113852 15:32:35 INFO - Running post-run listener: _upload_blobber_files 15:32:35 INFO - Blob upload gear active. 15:32:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:32:35 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 15:32:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:32:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:32:36 INFO - (blobuploader) - INFO - Open directory for files ... 15:32:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:32:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:32:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:32:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:32:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:32:37 INFO - (blobuploader) - INFO - Done attempting. 15:32:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:32:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:32:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:32:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:32:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:32:37 INFO - (blobuploader) - INFO - Done attempting. 15:32:37 INFO - (blobuploader) - INFO - Iteration through files over. 15:32:37 INFO - Return code: 0 15:32:37 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:32:37 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:32:37 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1a03f8d89bf6418db761ffb32baa619e6f6c9860f66109202391d59961dba82160097ef2b0eab6ad6ef2e4ecda87409ac7da76be1561535bfffbb1b14611aebf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4609a03cc3b958ff67493101d624ea0d615139a2e7e9122f42d1a9fe46b5389b45330670bcd1bee94a148b8aa6d6d3913b71130a7e7d714a14ba4ce3dd61623b"} 15:32:37 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:32:37 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:32:37 INFO - Contents: 15:32:37 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1a03f8d89bf6418db761ffb32baa619e6f6c9860f66109202391d59961dba82160097ef2b0eab6ad6ef2e4ecda87409ac7da76be1561535bfffbb1b14611aebf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4609a03cc3b958ff67493101d624ea0d615139a2e7e9122f42d1a9fe46b5389b45330670bcd1bee94a148b8aa6d6d3913b71130a7e7d714a14ba4ce3dd61623b"} 15:32:37 INFO - Running post-run listener: copy_logs_to_upload_dir 15:32:37 INFO - Copying logs to upload dir... 15:32:37 INFO - mkdir: /builds/slave/test/build/upload/logs 15:32:37 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.289366 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-07-21 15:32:37.838542) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-21 15:32:37.841777) ========= 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=0333a256a5e4f052382dd180000001b1-1469133520.357670-2070270743 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1a03f8d89bf6418db761ffb32baa619e6f6c9860f66109202391d59961dba82160097ef2b0eab6ad6ef2e4ecda87409ac7da76be1561535bfffbb1b14611aebf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4609a03cc3b958ff67493101d624ea0d615139a2e7e9122f42d1a9fe46b5389b45330670bcd1bee94a148b8aa6d6d3913b71130a7e7d714a14ba4ce3dd61623b"} build_url:https://queue.taskcluster.net/v1/task/FeI_Bo_6RJStGWc9KBpq0Q/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011154 build_url: 'https://queue.taskcluster.net/v1/task/FeI_Bo_6RJStGWc9KBpq0Q/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1a03f8d89bf6418db761ffb32baa619e6f6c9860f66109202391d59961dba82160097ef2b0eab6ad6ef2e4ecda87409ac7da76be1561535bfffbb1b14611aebf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4609a03cc3b958ff67493101d624ea0d615139a2e7e9122f42d1a9fe46b5389b45330670bcd1bee94a148b8aa6d6d3913b71130a7e7d714a14ba4ce3dd61623b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-21 15:32:37.867129) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 15:32:37.867477) ========= 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=0333a256a5e4f052382dd180000001b1-1469133520.357670-2070270743 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004400 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 15:32:37.949235) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-21 15:32:37.949571) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-21 15:32:37.949901) ========= ========= Total master_lag: 0.17 =========