builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-012 starttime: 1464056749.61 results: success (0) buildid: 20160523164246 builduid: a700a399d11c4827ae9262abaf6f03b7 revision: c40d4d7f4bb2b10c82348b900978fd2c0c3576a7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-23 19:25:49.607840) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-23 19:25:49.608276) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-23 19:25:49.608551) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-23 19:25:49.627828) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 19:25:49.628083) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1464056559.558668-1230769119 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-23 19:25:50-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 30.6M=0s 2016-05-23 19:25:50 (30.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.078239 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 19:25:49.719425) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 19:25:49.719749) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1464056559.558668-1230769119 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014761 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 19:25:49.769556) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 19:25:49.769921) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev c40d4d7f4bb2b10c82348b900978fd2c0c3576a7 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev c40d4d7f4bb2b10c82348b900978fd2c0c3576a7 --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=2c5dd2b0a310ecf02fd87158000001b4-1464056559.558668-1230769119 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-23 19:25:51,043 truncating revision to first 12 chars 2016-05-23 19:25:51,043 Setting DEBUG logging. 2016-05-23 19:25:51,043 attempt 1/10 2016-05-23 19:25:51,043 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/c40d4d7f4bb2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-23 19:25:51,286 unpacking tar archive at: mozilla-aurora-c40d4d7f4bb2/testing/mozharness/ program finished with exit code 0 elapsedTime=0.521597 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 19:25:50.303978) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-23 19:25:50.304251) ========= script_repo_revision: c40d4d7f4bb2b10c82348b900978fd2c0c3576a7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-23 19:25:50.304629) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-23 19:25:50.304912) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-23 19:25:50.316042) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-05-23 19:25:50.316339) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=2c5dd2b0a310ecf02fd87158000001b4-1464056559.558668-1230769119 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:25:51 INFO - MultiFileLogger online at 20160523 19:25:51 in /builds/slave/test 19:25:51 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 19:25:51 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:25:51 INFO - {'append_to_log': False, 19:25:51 INFO - 'base_work_dir': '/builds/slave/test', 19:25:51 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 19:25:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:25:51 INFO - 'branch': 'Mozilla-Aurora', 19:25:51 INFO - 'buildbot_json_path': 'buildprops.json', 19:25:51 INFO - 'config_files': ('talos/linux_config.py',), 19:25:51 INFO - 'default_actions': ('clobber', 19:25:51 INFO - 'read-buildbot-config', 19:25:51 INFO - 'download-and-extract', 19:25:51 INFO - 'populate-webroot', 19:25:51 INFO - 'create-virtualenv', 19:25:51 INFO - 'install', 19:25:51 INFO - 'run-tests'), 19:25:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:25:51 INFO - 'download_minidump_stackwalk': True, 19:25:51 INFO - 'download_symbols': 'ondemand', 19:25:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:25:51 INFO - 'tooltool.py': '/tools/tooltool.py', 19:25:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:25:51 INFO - '/tools/misc-python/virtualenv.py')}, 19:25:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:25:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:25:51 INFO - 'installer_path': 'installer.exe', 19:25:51 INFO - 'log_level': 'info', 19:25:51 INFO - 'log_name': 'talos', 19:25:51 INFO - 'log_to_console': True, 19:25:51 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:25:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:25:51 INFO - 'opt_config_files': (), 19:25:51 INFO - 'pip_index': False, 19:25:51 INFO - 'sps_profile': False, 19:25:51 INFO - 'sps_profile_interval': 0, 19:25:51 INFO - 'suite': 'dromaeojs-e10s', 19:25:51 INFO - 'system_bits': '32', 19:25:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:25:51 INFO - 'title': 'talos-linux64-ix-012', 19:25:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:25:51 INFO - 'use_talos_json': True, 19:25:51 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:25:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:25:51 INFO - 'work_dir': 'build'} 19:25:51 INFO - ##### 19:25:51 INFO - ##### Running clobber step. 19:25:51 INFO - ##### 19:25:51 INFO - Running pre-action listener: _resource_record_pre_action 19:25:51 INFO - Running main action method: clobber 19:25:51 INFO - rmtree: /builds/slave/test/build 19:25:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:25:52 INFO - Running post-action listener: _resource_record_post_action 19:25:52 INFO - ##### 19:25:52 INFO - ##### Running read-buildbot-config step. 19:25:52 INFO - ##### 19:25:52 INFO - Running pre-action listener: _resource_record_pre_action 19:25:52 INFO - Running main action method: read_buildbot_config 19:25:52 INFO - Using buildbot properties: 19:25:52 INFO - { 19:25:52 INFO - "project": "", 19:25:52 INFO - "product": "firefox", 19:25:52 INFO - "script_repo_revision": "production", 19:25:52 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 19:25:52 INFO - "repository": "", 19:25:52 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 19:25:52 INFO - "buildid": "20160523164246", 19:25:52 INFO - "pgo_build": "True", 19:25:52 INFO - "basedir": "/builds/slave/test", 19:25:52 INFO - "buildnumber": 365, 19:25:52 INFO - "slavename": "talos-linux64-ix-012", 19:25:52 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 19:25:52 INFO - "platform": "ubuntu64_hw", 19:25:52 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 19:25:52 INFO - "branch": "mozilla-aurora", 19:25:52 INFO - "repo_path": "releases/mozilla-aurora", 19:25:52 INFO - "revision": "c40d4d7f4bb2b10c82348b900978fd2c0c3576a7", 19:25:52 INFO - "stage_platform": "linux64-pgo", 19:25:52 INFO - "builduid": "a700a399d11c4827ae9262abaf6f03b7", 19:25:52 INFO - "slavebuilddir": "test" 19:25:52 INFO - } 19:25:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/SlT1HGtRS6Sh3pQGcr3yhA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 19:25:52 INFO - Running post-action listener: _resource_record_post_action 19:25:52 INFO - ##### 19:25:52 INFO - ##### Running download-and-extract step. 19:25:52 INFO - ##### 19:25:52 INFO - Running pre-action listener: _resource_record_pre_action 19:25:52 INFO - Running main action method: download_and_extract 19:25:52 INFO - mkdir: /builds/slave/test/build/tests 19:25:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:25:52 INFO - https://queue.taskcluster.net/v1/task/SlT1HGtRS6Sh3pQGcr3yhA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 19:25:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SlT1HGtRS6Sh3pQGcr3yhA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 19:25:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SlT1HGtRS6Sh3pQGcr3yhA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 19:25:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SlT1HGtRS6Sh3pQGcr3yhA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 19:25:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SlT1HGtRS6Sh3pQGcr3yhA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 19:25:55 INFO - Downloaded 1361 bytes. 19:25:55 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 19:25:55 INFO - Using the following test package requirements: 19:25:55 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 19:25:55 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 19:25:55 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 19:25:55 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 19:25:55 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 19:25:55 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 19:25:55 INFO - u'jsshell-linux-x86_64.zip'], 19:25:55 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 19:25:55 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 19:25:55 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 19:25:55 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 19:25:55 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 19:25:55 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 19:25:55 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 19:25:55 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 19:25:55 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 19:25:55 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 19:25:55 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 19:25:55 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:25:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:25:55 INFO - https://queue.taskcluster.net/v1/task/SlT1HGtRS6Sh3pQGcr3yhA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:25:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SlT1HGtRS6Sh3pQGcr3yhA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 19:25:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SlT1HGtRS6Sh3pQGcr3yhA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 19:25:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SlT1HGtRS6Sh3pQGcr3yhA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 19:25:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SlT1HGtRS6Sh3pQGcr3yhA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:26:00 INFO - Downloaded 23812978 bytes. 19:26:00 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:26:00 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 19:26:01 INFO - Return code: 0 19:26:01 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 19:26: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')]} 19:26:01 INFO - https://queue.taskcluster.net/v1/task/SlT1HGtRS6Sh3pQGcr3yhA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:26:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SlT1HGtRS6Sh3pQGcr3yhA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 19:26:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SlT1HGtRS6Sh3pQGcr3yhA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 19:26:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SlT1HGtRS6Sh3pQGcr3yhA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 19:26:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SlT1HGtRS6Sh3pQGcr3yhA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:26:04 INFO - Downloaded 23812978 bytes. 19:26:04 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:26:04 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 19:26:06 INFO - Return code: 0 19:26:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:26:06 INFO - https://queue.taskcluster.net/v1/task/SlT1HGtRS6Sh3pQGcr3yhA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:26:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SlT1HGtRS6Sh3pQGcr3yhA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 19:26:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SlT1HGtRS6Sh3pQGcr3yhA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 19:26:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SlT1HGtRS6Sh3pQGcr3yhA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 19:26:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SlT1HGtRS6Sh3pQGcr3yhA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 19:26:08 INFO - Downloaded 10840145 bytes. 19:26:08 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:26:08 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 19:26:09 INFO - Return code: 0 19:26:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:26:09 INFO - https://queue.taskcluster.net/v1/task/SlT1HGtRS6Sh3pQGcr3yhA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:26:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SlT1HGtRS6Sh3pQGcr3yhA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 19:26:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SlT1HGtRS6Sh3pQGcr3yhA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 19:26:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SlT1HGtRS6Sh3pQGcr3yhA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 19:26:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SlT1HGtRS6Sh3pQGcr3yhA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 19:26:11 INFO - Downloaded 62725482 bytes. 19:26:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SlT1HGtRS6Sh3pQGcr3yhA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 19:26:11 INFO - mkdir: /builds/slave/test/properties 19:26:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:26:11 INFO - Writing to file /builds/slave/test/properties/build_url 19:26:11 INFO - Contents: 19:26:11 INFO - build_url:https://queue.taskcluster.net/v1/task/SlT1HGtRS6Sh3pQGcr3yhA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 19:26:12 INFO - Running post-action listener: _resource_record_post_action 19:26:12 INFO - Running post-action listener: set_extra_try_arguments 19:26:12 INFO - ##### 19:26:12 INFO - ##### Running populate-webroot step. 19:26:12 INFO - ##### 19:26:12 INFO - Running pre-action listener: _resource_record_pre_action 19:26:12 INFO - Running main action method: populate_webroot 19:26:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:26:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:26:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:26:12 INFO - '--tppagecycles', 19:26:12 INFO - '7'], 19:26:12 INFO - 'tests': ['tsvgm']}}, 19:26:12 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:26:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:26:12 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:26:12 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:26:12 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:26:12 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:26:12 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:26:12 INFO - 'talos_options': ['--disable-e10s'], 19:26:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:26:12 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:26:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:26:12 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:26:12 INFO - 'talos_options': ['--disable-e10s'], 19:26:12 INFO - 'tests': ['damp', 'tps']}, 19:26:12 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:26:12 INFO - 'tests': ['damp', 'tps']}, 19:26:12 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:26:12 INFO - 'tests': ['dromaeo_dom']}, 19:26:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:26:12 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:26:12 INFO - 'tests': ['a11yr', 19:26:12 INFO - 'ts_paint', 19:26:12 INFO - 'tpaint', 19:26:12 INFO - 'sessionrestore', 19:26:12 INFO - 'sessionrestore_no_auto_restore', 19:26:12 INFO - 'tabpaint']}, 19:26:12 INFO - 'other-e10s': {'tests': ['a11yr', 19:26:12 INFO - 'ts_paint', 19:26:12 INFO - 'tpaint', 19:26:12 INFO - 'sessionrestore', 19:26:12 INFO - 'sessionrestore_no_auto_restore', 19:26:12 INFO - 'tabpaint']}, 19:26:12 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:26:12 INFO - 'ts_paint', 19:26:12 INFO - 'tpaint', 19:26:12 INFO - 'sessionrestore', 19:26:12 INFO - 'sessionrestore_no_auto_restore', 19:26:12 INFO - 'tabpaint']}, 19:26:12 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:26:12 INFO - 'ts_paint', 19:26:12 INFO - 'tpaint', 19:26:12 INFO - 'sessionrestore', 19:26:12 INFO - 'sessionrestore_no_auto_restore', 19:26:12 INFO - 'tabpaint']}, 19:26:12 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:26:12 INFO - 'tests': ['a11yr', 19:26:12 INFO - 'ts_paint', 19:26:12 INFO - 'tpaint', 19:26:12 INFO - 'sessionrestore', 19:26:12 INFO - 'sessionrestore_no_auto_restore', 19:26:12 INFO - 'tabpaint']}, 19:26:12 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:26:12 INFO - 'tests': ['a11yr', 19:26:12 INFO - 'ts_paint', 19:26:12 INFO - 'tpaint', 19:26:12 INFO - 'sessionrestore', 19:26:12 INFO - 'sessionrestore_no_auto_restore', 19:26:12 INFO - 'tabpaint']}, 19:26:12 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:26:12 INFO - 'tests': ['tsvgx', 19:26:12 INFO - 'tsvgr_opacity', 19:26:12 INFO - 'tart', 19:26:12 INFO - 'tscrollx', 19:26:12 INFO - 'cart']}, 19:26:12 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:26:12 INFO - 'tsvgr_opacity', 19:26:12 INFO - 'tart', 19:26:12 INFO - 'tscrollx', 19:26:12 INFO - 'cart']}, 19:26:12 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:26:12 INFO - 'talos_options': ['--disable-e10s'], 19:26:12 INFO - 'tests': ['tp5o']}, 19:26:12 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:26:12 INFO - 'tests': ['tp5o']}, 19:26:12 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:26:12 INFO - 'talos_options': ['--disable-e10s', 19:26:12 INFO - '--xperf_path', 19:26:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:26:12 INFO - 'tests': ['tp5n']}, 19:26:12 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:26:12 INFO - 'talos_options': ['--xperf_path', 19:26:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:26:12 INFO - 'tests': ['tp5n']}}, 19:26:12 INFO - 'talos.zip': {'path': '', 19:26:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:26:12 INFO - Running post-action listener: _resource_record_post_action 19:26:12 INFO - ##### 19:26:12 INFO - ##### Running create-virtualenv step. 19:26:12 INFO - ##### 19:26:12 INFO - Running pre-action listener: _resource_record_pre_action 19:26:12 INFO - Running main action method: create_virtualenv 19:26:12 INFO - Creating virtualenv /builds/slave/test/build/venv 19:26:12 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 19:26:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:26:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:26:12 INFO - Using real prefix '/usr' 19:26:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:26:13 INFO - Installing distribute.............................................................................................................................................................................................done. 19:26:15 INFO - Installing pip.................done. 19:26:15 INFO - Return code: 0 19:26:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:26:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:26:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:26:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:26:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:26:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:26:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:26:15 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 0x7f4751e42f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a1c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ae75a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b76410>, '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 0x1b77310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b777a0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1464056559.558668-1230769119', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:26:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 19:26:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 19:26:15 INFO - Using env: {'DISPLAY': ':0', 19:26:15 INFO - 'HOME': '/home/cltbld', 19:26:15 INFO - 'LANG': 'en_US.UTF-8', 19:26:15 INFO - 'LANGUAGE': 'en_US:en', 19:26:15 INFO - 'LOGNAME': 'cltbld', 19:26:15 INFO - 'MAIL': '/var/mail/cltbld', 19:26:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:26:15 INFO - 'MOZ_NO_REMOTE': '1', 19:26:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:26:15 INFO - 'NO_EM_RESTART': '1', 19:26:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:26:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:26:15 INFO - 'PWD': '/builds/slave/test', 19:26:15 INFO - 'SHELL': '/bin/bash', 19:26:15 INFO - 'SHLVL': '1', 19:26:15 INFO - 'TERM': 'linux', 19:26:15 INFO - 'TMOUT': '86400', 19:26:15 INFO - 'USER': 'cltbld', 19:26:15 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1464056559.558668-1230769119', 19:26:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:26:15 INFO - '_': '/tools/buildbot/bin/python'} 19:26:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:26:15 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 19:26:15 INFO - Cleaning up... 19:26:15 INFO - Return code: 0 19:26:15 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 19:26:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:26:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:26:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:26:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:26:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:26:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:26:15 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 0x7f4751e42f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a1c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ae75a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b76410>, '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 0x1b77310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b777a0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1464056559.558668-1230769119', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:26:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 19:26:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 19:26:15 INFO - Using env: {'DISPLAY': ':0', 19:26:15 INFO - 'HOME': '/home/cltbld', 19:26:15 INFO - 'LANG': 'en_US.UTF-8', 19:26:15 INFO - 'LANGUAGE': 'en_US:en', 19:26:15 INFO - 'LOGNAME': 'cltbld', 19:26:15 INFO - 'MAIL': '/var/mail/cltbld', 19:26:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:26:15 INFO - 'MOZ_NO_REMOTE': '1', 19:26:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:26:15 INFO - 'NO_EM_RESTART': '1', 19:26:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:26:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:26:15 INFO - 'PWD': '/builds/slave/test', 19:26:15 INFO - 'SHELL': '/bin/bash', 19:26:15 INFO - 'SHLVL': '1', 19:26:15 INFO - 'TERM': 'linux', 19:26:15 INFO - 'TMOUT': '86400', 19:26:15 INFO - 'USER': 'cltbld', 19:26:15 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1464056559.558668-1230769119', 19:26:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:26:15 INFO - '_': '/tools/buildbot/bin/python'} 19:26:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:26:15 INFO - Downloading/unpacking psutil>=0.7.1 19:26:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:26:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:26:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:26:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:26:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:26:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:26:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:26:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:26:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:26:17 INFO - Installing collected packages: psutil 19:26:17 INFO - Running setup.py install for psutil 19:26:17 INFO - building 'psutil._psutil_linux' extension 19:26:17 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 19:26:17 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 19:26:17 INFO - building 'psutil._psutil_posix' extension 19:26:17 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 19:26:17 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 19:26:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:26:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:26:17 INFO - Successfully installed psutil 19:26:17 INFO - Cleaning up... 19:26:18 INFO - Return code: 0 19:26:18 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 19:26:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:26:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:26:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:26:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:26:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:26:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:26:18 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 0x7f4751e42f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a1c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ae75a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b76410>, '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 0x1b77310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b777a0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1464056559.558668-1230769119', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:26:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 19:26:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 19:26:18 INFO - Using env: {'DISPLAY': ':0', 19:26:18 INFO - 'HOME': '/home/cltbld', 19:26:18 INFO - 'LANG': 'en_US.UTF-8', 19:26:18 INFO - 'LANGUAGE': 'en_US:en', 19:26:18 INFO - 'LOGNAME': 'cltbld', 19:26:18 INFO - 'MAIL': '/var/mail/cltbld', 19:26:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:26:18 INFO - 'MOZ_NO_REMOTE': '1', 19:26:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:26:18 INFO - 'NO_EM_RESTART': '1', 19:26:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:26:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:26:18 INFO - 'PWD': '/builds/slave/test', 19:26:18 INFO - 'SHELL': '/bin/bash', 19:26:18 INFO - 'SHLVL': '1', 19:26:18 INFO - 'TERM': 'linux', 19:26:18 INFO - 'TMOUT': '86400', 19:26:18 INFO - 'USER': 'cltbld', 19:26:18 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1464056559.558668-1230769119', 19:26:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:26:18 INFO - '_': '/tools/buildbot/bin/python'} 19:26:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:26:18 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 19:26:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:26:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:26:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:26:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:26:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:26:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:26:20 INFO - Downloading mozsystemmonitor-0.0.tar.gz 19:26:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:26:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 19:26:20 INFO - Installing collected packages: mozsystemmonitor 19:26:20 INFO - Running setup.py install for mozsystemmonitor 19:26:20 INFO - Successfully installed mozsystemmonitor 19:26:20 INFO - Cleaning up... 19:26:20 INFO - Return code: 0 19:26:20 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:26:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:26:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:26:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:26:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:26:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:26:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:26:20 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 0x7f4751e42f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a1c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ae75a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b76410>, '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 0x1b77310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b777a0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1464056559.558668-1230769119', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:26:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 19:26:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 19:26:20 INFO - Using env: {'DISPLAY': ':0', 19:26:20 INFO - 'HOME': '/home/cltbld', 19:26:20 INFO - 'LANG': 'en_US.UTF-8', 19:26:20 INFO - 'LANGUAGE': 'en_US:en', 19:26:20 INFO - 'LOGNAME': 'cltbld', 19:26:20 INFO - 'MAIL': '/var/mail/cltbld', 19:26:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:26:20 INFO - 'MOZ_NO_REMOTE': '1', 19:26:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:26:20 INFO - 'NO_EM_RESTART': '1', 19:26:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:26:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:26:20 INFO - 'PWD': '/builds/slave/test', 19:26:20 INFO - 'SHELL': '/bin/bash', 19:26:20 INFO - 'SHLVL': '1', 19:26:20 INFO - 'TERM': 'linux', 19:26:20 INFO - 'TMOUT': '86400', 19:26:20 INFO - 'USER': 'cltbld', 19:26:20 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1464056559.558668-1230769119', 19:26:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:26:20 INFO - '_': '/tools/buildbot/bin/python'} 19:26:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:26:20 INFO - Downloading/unpacking blobuploader==1.2.4 19:26:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:26:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:26:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:26:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:26:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:26:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:26:22 INFO - Downloading blobuploader-1.2.4.tar.gz 19:26:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:26:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:26:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:26:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:26:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:26:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:26:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:26:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:26:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:26:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:26:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:26:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:26:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:26:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:26:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:26:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:26:23 INFO - Downloading docopt-0.6.1.tar.gz 19:26:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:26:23 INFO - Installing collected packages: blobuploader, requests, docopt 19:26:23 INFO - Running setup.py install for blobuploader 19:26:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:26:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:26:23 INFO - Running setup.py install for requests 19:26:23 INFO - Running setup.py install for docopt 19:26:23 INFO - Successfully installed blobuploader requests docopt 19:26:23 INFO - Cleaning up... 19:26:23 INFO - Return code: 0 19:26:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:26:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:26:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:26:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:26:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:26:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:26:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:26:23 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 0x7f4751e42f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a1c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ae75a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b76410>, '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 0x1b77310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b777a0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1464056559.558668-1230769119', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:26:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 19:26:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:26:23 INFO - Using env: {'DISPLAY': ':0', 19:26:23 INFO - 'HOME': '/home/cltbld', 19:26:23 INFO - 'LANG': 'en_US.UTF-8', 19:26:23 INFO - 'LANGUAGE': 'en_US:en', 19:26:23 INFO - 'LOGNAME': 'cltbld', 19:26:23 INFO - 'MAIL': '/var/mail/cltbld', 19:26:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:26:23 INFO - 'MOZ_NO_REMOTE': '1', 19:26:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:26:23 INFO - 'NO_EM_RESTART': '1', 19:26:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:26:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:26:23 INFO - 'PWD': '/builds/slave/test', 19:26:23 INFO - 'SHELL': '/bin/bash', 19:26:23 INFO - 'SHLVL': '1', 19:26:23 INFO - 'TERM': 'linux', 19:26:23 INFO - 'TMOUT': '86400', 19:26:23 INFO - 'USER': 'cltbld', 19:26:23 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1464056559.558668-1230769119', 19:26:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:26:23 INFO - '_': '/tools/buildbot/bin/python'} 19:26:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:26:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:26:23 INFO - Running setup.py (path:/tmp/pip-CULMsq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:26:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:26:24 INFO - Running setup.py (path:/tmp/pip-ezZc3a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:26:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:26:24 INFO - Running setup.py (path:/tmp/pip-wKFkTv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:26:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:26:24 INFO - Running setup.py (path:/tmp/pip-cWy1XB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:26:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:26:24 INFO - Running setup.py (path:/tmp/pip-0Lo4a1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:26:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:26:24 INFO - Running setup.py (path:/tmp/pip-esXuYg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:26:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:26:24 INFO - Running setup.py (path:/tmp/pip-TwShFw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:26:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:26:24 INFO - Running setup.py (path:/tmp/pip-Z_Pkdg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:26:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:26:24 INFO - Running setup.py (path:/tmp/pip-DGFUhH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:26:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:26:24 INFO - Running setup.py (path:/tmp/pip-TZPQrU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:26:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:26:24 INFO - Running setup.py (path:/tmp/pip-mMh5X2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:26:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:26:24 INFO - Running setup.py (path:/tmp/pip-OYAVHD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:26:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:26:24 INFO - Running setup.py (path:/tmp/pip-tGb8lm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:26:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:26:24 INFO - Running setup.py (path:/tmp/pip-jqaW0n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:26:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:26:25 INFO - Running setup.py (path:/tmp/pip-S0W6sr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:26:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:26:25 INFO - Running setup.py (path:/tmp/pip-npt9ia-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:26:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:26:25 INFO - Running setup.py (path:/tmp/pip-pmNi3I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:26:25 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:26:25 INFO - Running setup.py install for manifestparser 19:26:25 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:26:25 INFO - Running setup.py install for mozcrash 19:26:25 INFO - Running setup.py install for mozdebug 19:26:25 INFO - Running setup.py install for mozdevice 19:26:25 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:26:25 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:26:25 INFO - Running setup.py install for mozfile 19:26:25 INFO - Running setup.py install for mozhttpd 19:26:25 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:26:25 INFO - Running setup.py install for mozinfo 19:26:25 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:26:25 INFO - Running setup.py install for mozInstall 19:26:26 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:26:26 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:26:26 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:26:26 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:26:26 INFO - Running setup.py install for mozleak 19:26:26 INFO - Running setup.py install for mozlog 19:26:26 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:26:26 INFO - Running setup.py install for moznetwork 19:26:26 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:26:26 INFO - Running setup.py install for mozprocess 19:26:26 INFO - Running setup.py install for mozprofile 19:26:26 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:26:26 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:26:26 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:26:26 INFO - Running setup.py install for mozrunner 19:26:26 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:26:26 INFO - Running setup.py install for mozscreenshot 19:26:26 INFO - Running setup.py install for moztest 19:26:26 INFO - Running setup.py install for mozversion 19:26:26 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:26:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:26:26 INFO - Cleaning up... 19:26:27 INFO - Return code: 0 19:26:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:26:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:26:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:26:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:26:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:26:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:26:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:26:27 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 0x7f4751e42f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a1c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ae75a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b76410>, '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 0x1b77310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b777a0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1464056559.558668-1230769119', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:26:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 19:26:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:26:27 INFO - Using env: {'DISPLAY': ':0', 19:26:27 INFO - 'HOME': '/home/cltbld', 19:26:27 INFO - 'LANG': 'en_US.UTF-8', 19:26:27 INFO - 'LANGUAGE': 'en_US:en', 19:26:27 INFO - 'LOGNAME': 'cltbld', 19:26:27 INFO - 'MAIL': '/var/mail/cltbld', 19:26:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:26:27 INFO - 'MOZ_NO_REMOTE': '1', 19:26:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:26:27 INFO - 'NO_EM_RESTART': '1', 19:26:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:26:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:26:27 INFO - 'PWD': '/builds/slave/test', 19:26:27 INFO - 'SHELL': '/bin/bash', 19:26:27 INFO - 'SHLVL': '1', 19:26:27 INFO - 'TERM': 'linux', 19:26:27 INFO - 'TMOUT': '86400', 19:26:27 INFO - 'USER': 'cltbld', 19:26:27 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1464056559.558668-1230769119', 19:26:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:26:27 INFO - '_': '/tools/buildbot/bin/python'} 19:26:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:26:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:26:27 INFO - Running setup.py (path:/tmp/pip-PuVkYw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:26:27 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 19:26:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:26:27 INFO - Running setup.py (path:/tmp/pip-gWFJRo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:26:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:26:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:26:27 INFO - Running setup.py (path:/tmp/pip-5kNigs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:26:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 19:26:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:26:27 INFO - Running setup.py (path:/tmp/pip-h4uOgy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:26:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:26:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:26:27 INFO - Running setup.py (path:/tmp/pip-jgH0Ya-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:26:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 19:26:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:26:27 INFO - Running setup.py (path:/tmp/pip-qkcXSY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:26:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 19:26:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:26:27 INFO - Running setup.py (path:/tmp/pip-I91hW2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:26:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 19:26:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:26:27 INFO - Running setup.py (path:/tmp/pip-rw0Jap-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:26:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 19:26:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:26:27 INFO - Running setup.py (path:/tmp/pip-HoEaOH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:26:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 19:26:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:26:27 INFO - Running setup.py (path:/tmp/pip-B9eFKZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:26:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:26:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:26:27 INFO - Running setup.py (path:/tmp/pip-DbUCZu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:26:28 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 19:26:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:26:28 INFO - Running setup.py (path:/tmp/pip-d4UWFF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:26:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 19:26:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:26:28 INFO - Running setup.py (path:/tmp/pip-IA0k_I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:26:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 19:26:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:26:28 INFO - Running setup.py (path:/tmp/pip-i6fI5G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:26:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 19:26:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:26:28 INFO - Running setup.py (path:/tmp/pip-sh55yx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:26:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 19:26:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:26:28 INFO - Running setup.py (path:/tmp/pip-rt30BE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:26:28 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 19:26:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:26:28 INFO - Running setup.py (path:/tmp/pip-eg1Jsz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:26:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 19:26:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:26:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:26:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 19:26:28 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:26:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:26:28 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:26:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:26:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:26:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:26:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:26:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:26:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:26:30 INFO - Downloading blessings-1.6.tar.gz 19:26:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:26:30 INFO - Installing collected packages: blessings 19:26:30 INFO - Running setup.py install for blessings 19:26:30 INFO - Successfully installed blessings 19:26:30 INFO - Cleaning up... 19:26:30 INFO - Return code: 0 19:26:30 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:26:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:26:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:26:30 INFO - Reading from file tmpfile_stdout 19:26:30 INFO - Current package versions: 19:26:30 INFO - argparse == 1.2.1 19:26:30 INFO - blessings == 1.6 19:26:30 INFO - blobuploader == 1.2.4 19:26:30 INFO - docopt == 0.6.1 19:26:30 INFO - manifestparser == 1.1 19:26:30 INFO - mozInstall == 1.12 19:26:30 INFO - mozcrash == 0.17 19:26:30 INFO - mozdebug == 0.1 19:26:30 INFO - mozdevice == 0.48 19:26:30 INFO - mozfile == 1.2 19:26:30 INFO - mozhttpd == 0.7 19:26:30 INFO - mozinfo == 0.9 19:26:30 INFO - mozleak == 0.1 19:26:30 INFO - mozlog == 3.1 19:26:30 INFO - moznetwork == 0.27 19:26:30 INFO - mozprocess == 0.22 19:26:30 INFO - mozprofile == 0.28 19:26:30 INFO - mozrunner == 6.11 19:26:30 INFO - mozscreenshot == 0.1 19:26:30 INFO - mozsystemmonitor == 0.0 19:26:30 INFO - moztest == 0.7 19:26:30 INFO - mozversion == 1.4 19:26:30 INFO - psutil == 3.1.1 19:26:30 INFO - requests == 1.2.3 19:26:30 INFO - wsgiref == 0.1.2 19:26:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:26:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:26:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:26:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:26:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:26:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:26:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:26:30 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 0x7f4751e42f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a1c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ae75a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b76410>, '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 0x1b77310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b777a0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1464056559.558668-1230769119', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:26:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 19:26:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:26:31 INFO - Using env: {'DISPLAY': ':0', 19:26:31 INFO - 'HOME': '/home/cltbld', 19:26:31 INFO - 'LANG': 'en_US.UTF-8', 19:26:31 INFO - 'LANGUAGE': 'en_US:en', 19:26:31 INFO - 'LOGNAME': 'cltbld', 19:26:31 INFO - 'MAIL': '/var/mail/cltbld', 19:26:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:26:31 INFO - 'MOZ_NO_REMOTE': '1', 19:26:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:26:31 INFO - 'NO_EM_RESTART': '1', 19:26:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:26:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:26:31 INFO - 'PWD': '/builds/slave/test', 19:26:31 INFO - 'SHELL': '/bin/bash', 19:26:31 INFO - 'SHLVL': '1', 19:26:31 INFO - 'TERM': 'linux', 19:26:31 INFO - 'TMOUT': '86400', 19:26:31 INFO - 'USER': 'cltbld', 19:26:31 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1464056559.558668-1230769119', 19:26:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:26:31 INFO - '_': '/tools/buildbot/bin/python'} 19:26:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:26:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 19:26:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 19:26:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 19:26:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 19:26:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 19:26:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 19:26:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 19:26:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 19:26:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 19:26:31 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 19:26:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 19:26:31 INFO - Cleaning up... 19:26:31 INFO - Return code: 0 19:26:31 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:26:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:26:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:26:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:26:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:26:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:26:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:26:31 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 0x7f4751e42f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a1c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ae75a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b76410>, '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 0x1b77310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b777a0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1464056559.558668-1230769119', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:26:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 19:26:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 19:26:31 INFO - Using env: {'DISPLAY': ':0', 19:26:31 INFO - 'HOME': '/home/cltbld', 19:26:31 INFO - 'LANG': 'en_US.UTF-8', 19:26:31 INFO - 'LANGUAGE': 'en_US:en', 19:26:31 INFO - 'LOGNAME': 'cltbld', 19:26:31 INFO - 'MAIL': '/var/mail/cltbld', 19:26:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:26:31 INFO - 'MOZ_NO_REMOTE': '1', 19:26:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:26:31 INFO - 'NO_EM_RESTART': '1', 19:26:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:26:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:26:31 INFO - 'PWD': '/builds/slave/test', 19:26:31 INFO - 'SHELL': '/bin/bash', 19:26:31 INFO - 'SHLVL': '1', 19:26:31 INFO - 'TERM': 'linux', 19:26:31 INFO - 'TMOUT': '86400', 19:26:31 INFO - 'USER': 'cltbld', 19:26:31 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1464056559.558668-1230769119', 19:26:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:26:31 INFO - '_': '/tools/buildbot/bin/python'} 19:26:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:26:31 INFO - Downloading/unpacking jsonschema 19:26:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:26:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:26:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:26:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:26:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:26:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:26:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:26:33 INFO - Downloading/unpacking functools32 (from jsonschema) 19:26:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:26:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:26:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:26:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:26:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:26:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:26:33 INFO - Downloading functools32-3.2.3-2.tar.gz 19:26:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:26:33 INFO - warning: no files found matching '*.txt' 19:26:33 INFO - no previously-included directories found matching 'build' 19:26:33 INFO - no previously-included directories found matching 'dist' 19:26:33 INFO - no previously-included directories found matching '.git*' 19:26:33 INFO - Installing collected packages: jsonschema, functools32 19:26:33 INFO - Running setup.py install for functools32 19:26:33 INFO - warning: no files found matching '*.txt' 19:26:33 INFO - no previously-included directories found matching 'build' 19:26:33 INFO - no previously-included directories found matching 'dist' 19:26:33 INFO - no previously-included directories found matching '.git*' 19:26:33 INFO - Successfully installed jsonschema functools32 19:26:33 INFO - Cleaning up... 19:26:33 INFO - Return code: 0 19:26:33 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 19:26:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:26:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:26:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:26:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:26:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:26:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:26:33 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 0x7f4751e42f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a1c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ae75a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b76410>, '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 0x1b77310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b777a0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1464056559.558668-1230769119', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:26:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 19:26:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 19:26:33 INFO - Using env: {'DISPLAY': ':0', 19:26:33 INFO - 'HOME': '/home/cltbld', 19:26:33 INFO - 'LANG': 'en_US.UTF-8', 19:26:33 INFO - 'LANGUAGE': 'en_US:en', 19:26:33 INFO - 'LOGNAME': 'cltbld', 19:26:33 INFO - 'MAIL': '/var/mail/cltbld', 19:26:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:26:33 INFO - 'MOZ_NO_REMOTE': '1', 19:26:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:26:33 INFO - 'NO_EM_RESTART': '1', 19:26:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:26:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:26:33 INFO - 'PWD': '/builds/slave/test', 19:26:33 INFO - 'SHELL': '/bin/bash', 19:26:33 INFO - 'SHLVL': '1', 19:26:33 INFO - 'TERM': 'linux', 19:26:33 INFO - 'TMOUT': '86400', 19:26:33 INFO - 'USER': 'cltbld', 19:26:33 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1464056559.558668-1230769119', 19:26:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:26:33 INFO - '_': '/tools/buildbot/bin/python'} 19:26:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:26:34 INFO - Downloading/unpacking flake8 19:26:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:26:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:26:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:26:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:26:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:26:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:26:35 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:26:35 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:26: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 19:26: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 19:26: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 19:26: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 19:26: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 19:26: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 19:26:36 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:26:36 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:26:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:26:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:26:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:26:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:26:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:26:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:26:36 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:26:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:26:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:26:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:26:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:26:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:26:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:26:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 19:26:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:26:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:26:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:26:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:26:36 INFO - no previously-included directories found matching 'docs/_build' 19:26:36 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:26:36 INFO - Running setup.py install for pep8 19:26:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:26:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:26:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:26:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:26:36 INFO - no previously-included directories found matching 'docs/_build' 19:26:36 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 19:26:36 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:26:36 INFO - Cleaning up... 19:26:36 INFO - Return code: 0 19:26:36 INFO - Running post-action listener: _resource_record_post_action 19:26:36 INFO - Running post-action listener: _start_resource_monitoring 19:26:37 INFO - Starting resource monitoring. 19:26:37 INFO - ##### 19:26:37 INFO - ##### Running install step. 19:26:37 INFO - ##### 19:26:37 INFO - Running pre-action listener: _resource_record_pre_action 19:26:37 INFO - Running main action method: install 19:26:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:26:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:26:37 INFO - Reading from file tmpfile_stdout 19:26:37 INFO - Detecting whether we're running mozinstall >=1.0... 19:26:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:26:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:26:37 INFO - Reading from file tmpfile_stdout 19:26:37 INFO - Output received: 19:26:37 INFO - Usage: mozinstall [options] installer 19:26:37 INFO - Options: 19:26:37 INFO - -h, --help show this help message and exit 19:26:37 INFO - -d DEST, --destination=DEST 19:26:37 INFO - Directory to install application into. [default: 19:26:37 INFO - "/builds/slave/test"] 19:26:37 INFO - --app=APP Application being installed. [default: firefox] 19:26:37 INFO - mkdir: /builds/slave/test/build/application 19:26:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 19:26:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 19:26:53 INFO - Reading from file tmpfile_stdout 19:26:53 INFO - Output received: 19:26:53 INFO - /builds/slave/test/build/application/firefox/firefox 19:26:53 INFO - Running post-action listener: _resource_record_post_action 19:26:53 INFO - ##### 19:26:53 INFO - ##### Running run-tests step. 19:26:53 INFO - ##### 19:26:53 INFO - Running pre-action listener: _resource_record_pre_action 19:26:53 INFO - Running main action method: run_tests 19:26:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:26:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:26:53 INFO - Python 2.7.3 19:26:53 INFO - Return code: 0 19:26:53 INFO - grabbing minidump binary from tooltool 19:26:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:26:53 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 0x1b76410>, '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 0x1b77310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b777a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:26:53 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 19:26:53 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 19:26:53 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:26:53 INFO - Return code: 0 19:26:53 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:26:53 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:26:53 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:26:53 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:26:53 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:26:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 19:26:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 19:26:53 INFO - Return code: 0 19:26:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SlT1HGtRS6Sh3pQGcr3yhA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 19:26:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/SlT1HGtRS6Sh3pQGcr3yhA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-012 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 19:26:53 INFO - Using env: {'DISPLAY': ':0', 19:26:53 INFO - 'HOME': '/home/cltbld', 19:26:53 INFO - 'LANG': 'en_US.UTF-8', 19:26:53 INFO - 'LANGUAGE': 'en_US:en', 19:26:53 INFO - 'LOGNAME': 'cltbld', 19:26:53 INFO - 'MAIL': '/var/mail/cltbld', 19:26:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:26:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:26:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:26:53 INFO - 'MOZ_NO_REMOTE': '1', 19:26:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:26:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:26:54 INFO - 'NO_EM_RESTART': '1', 19:26:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:26:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:26:54 INFO - 'PWD': '/builds/slave/test', 19:26:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:26:54 INFO - 'SHELL': '/bin/bash', 19:26:54 INFO - 'SHLVL': '1', 19:26:54 INFO - 'TERM': 'linux', 19:26:54 INFO - 'TMOUT': '86400', 19:26:54 INFO - 'USER': 'cltbld', 19:26:54 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1464056559.558668-1230769119', 19:26:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:26:54 INFO - '_': '/tools/buildbot/bin/python'} 19:26:54 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SlT1HGtRS6Sh3pQGcr3yhA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 19:26:54 INFO - mozversion application_buildid: 20160523164246 19:26:54 INFO - mozversion application_changeset: c40d4d7f4bb2b10c82348b900978fd2c0c3576a7 19:26:54 INFO - mozversion application_display_name: FirefoxDeveloperEdition 19:26:54 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:26:54 INFO - mozversion application_name: Firefox 19:26:54 INFO - mozversion application_remotingname: firefox-dev 19:26:54 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 19:26:54 INFO - mozversion application_vendor: Mozilla 19:26:54 INFO - mozversion application_version: 48.0a2 19:26:54 INFO - mozversion platform_buildid: 20160523164246 19:26:54 INFO - mozversion platform_changeset: c40d4d7f4bb2b10c82348b900978fd2c0c3576a7 19:26:54 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 19:26:54 INFO - mozversion platform_version: 48.0a2 19:26:54 INFO - using testdate: 1464056814 19:26:54 INFO - actual date: 1464056814 19:26:54 INFO - starting webserver on 'localhost:35382' 19:26:54 INFO - SUITE-START | Running 2 tests 19:26:54 INFO - TEST-START | dromaeo_css 19:26:54 INFO - operating with platform_type : linux_ 19:26:54 INFO - Initialising browser for dromaeo_css test... 19:26:54 INFO - TEST-INFO | started process 30439 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiYB4Um/profile http://localhost:35382/getInfo.html) 19:26:57 INFO - PROCESS | 30439 | 19:26:57 INFO - PROCESS | 30439 | (process:30518): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:26:58 INFO - PROCESS | 30439 | __metrics Screen width/height:1600/1200 19:26:58 INFO - PROCESS | 30439 | colorDepth:24 19:26:58 INFO - PROCESS | 30439 | Browser inner width/height: 1024/697 19:26:58 INFO - PROCESS | 30439 | __metrics 19:26:58 ERROR - PROCESS | 30439 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 19:26:59 INFO - TEST-INFO | 30439: exit 0 19:26:59 INFO - Browser initialized. 19:26:59 INFO - Running cycle 1/1 for dromaeo_css test... 19:26:59 INFO - TEST-INFO | started process 30569 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiYB4Um/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:27:01 INFO - PROCESS | 30569 | 19:27:01 INFO - PROCESS | 30569 | (process:30638): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:27:11 INFO - PROCESS | 30569 | RSS: Main: 151601152 19:27:11 INFO - PROCESS | 30569 | 19:28:00 INFO - PROCESS | 30569 | 1464056880896 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 19:30:08 INFO - PROCESS | 30569 | Cycle 1(1): loaded http://localhost:35382/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35382/tests/dromaeo/cssquery-ext.html) 19:30:09 INFO - PROCESS | 30569 | RSS: Main: 155803648 19:30:09 INFO - PROCESS | 30569 | 19:33:11 INFO - PROCESS | 30569 | Cycle 1(1): loaded http://localhost:35382/tests/dromaeo/cssquery-ext.html (next: http://localhost:35382/tests/dromaeo/cssquery-jquery.html) 19:33:11 INFO - PROCESS | 30569 | RSS: Main: 153403392 19:33:11 INFO - PROCESS | 30569 | 19:36:13 INFO - PROCESS | 30569 | Cycle 1(1): loaded http://localhost:35382/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35382/tests/dromaeo/cssquery-mootools.html) 19:36:14 INFO - PROCESS | 30569 | RSS: Main: 153075712 19:36:14 INFO - PROCESS | 30569 | 19:39:15 INFO - PROCESS | 30569 | Cycle 1(1): loaded http://localhost:35382/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35382/tests/dromaeo/cssquery-prototype.html) 19:39:16 INFO - PROCESS | 30569 | RSS: Main: 152600576 19:39:16 INFO - PROCESS | 30569 | 19:42:18 INFO - PROCESS | 30569 | Cycle 1(1): loaded http://localhost:35382/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35382/tests/dromaeo/cssquery-yui.html) 19:42:19 INFO - PROCESS | 30569 | RSS: Main: 154570752 19:42:19 INFO - PROCESS | 30569 | 19:45:21 INFO - PROCESS | 30569 | Cycle 1(1): loaded http://localhost:35382/tests/dromaeo/cssquery-yui.html (next: http://localhost:35382/tests/dromaeo/cssquery-dojo.html) 19:45:21 INFO - PROCESS | 30569 | RSS: Main: 155750400 19:45:21 INFO - PROCESS | 30569 | 19:45:21 INFO - PROCESS | 30569 | __start_tp_report 19:45:21 INFO - PROCESS | 30569 | _x_x_mozilla_page_load 19:45:21 INFO - PROCESS | 30569 | _x_x_mozilla_page_load_details 19:45:21 INFO - PROCESS | 30569 | |i|pagename|runs| 19:45:21 INFO - PROCESS | 30569 | |0;dojo.html;3301.9339613207735;3349.9832500837524;3366.4277072897603;3404.8808291709797;3404.880829170981;5534.723263836802;5554.1946417769395;5572;5595.664260144395;5629;5520.227168196456;5581.609287349887;5598.944010559893;5599.524040456556;5606.607537472379;5046.435604962455;5117.692938423706;5155.278261043457;5155.484451554833;5183.118869792144;5023.196288593826;5130.819911420375;5216.8174113906025;5256.763445644936;5294.788208471676;5051.166557518023;5075.264086707425;5118.4113826909825;5216.347956505437;5233.241180028913;5092.6180536459915;5101.642884998052;5109.770060347256;5111.463296353903;5149.124648809711;4985.90028199434;5045.798168073273;5075.670081444694;5089.872753181163;5096.770645320932;5334.786608535654;5375.11310633745;5472.972635136839;5497.587680923947;5524.66851988882;5909.054551271819;5947.940520594782;5951.821445356646;5952.672603006876;5953.672548009858;5849.85375365615;5939.9109013364405;5946.108083787423;6011.789587364465;6013.639181649115;5513.862153446155;5557.472040156179;5596.356419011784;5677.233573467612;5680.403557626431;5999.9100013498955;6016.548758843104;6068.969655151696;6075.605085669417;6078.878422431527;5777.45114214149;5839.328477225174;5844.386339434383;5844.444777746107;5852.4147585241135;5953.970230148821;6002.6698531580305;6002.909956350658;6017;6017.759289628366;5941.138534912414;5942.227510423703;5945.375735547792;5953.255843019622;5960.880782384328;5814.331351894586;5893.970530147408;5941.405859414111;5991.7603295867675;6001.729922153426;4546.272596384562;4569;4570.65720070996;4575.336576196433;4601.539846015438;4110.979445102756;4128.814203360856;4136.255474014706;4144.647704945053;4149.211649786531;5635.154726791015;5703.7148142592705;5715.942840571541;5734.483896449339;5749.9425005750245;5774.509166720792;5948.910766338508;6059.151718759377;6067.787627433018;6072.301685306246;5568;5692.288463942007;5704.11586204139;5704.71476426177;5706.686132262766;5079.74601269935;5155.9742201288755;5156.123459011902;5175.534201921845;5190.506901844319;6103.35914728956;6159.476444502178;6167.907481387782;6174.289956655042;6180.412860778219;5918.3489816121055;5965.075413310944;5972.074328479092;5980.192673988956;6022.5784195105925;6118.632882027093;6120.508083830972;6123.649268312112;6130.750073614967;6155.1382806406245;5840.737166827418;5846.883062338815;5849.766009359578;5862.677552734641;5874.060150375919;5802.970985145047;5901.675407852437;5940.405959404025;5952.285725712769;5968.865915476045;5856.970715146397;5858.209141765807;5908.970455147697;5910.497607703393;5918.674472904032;5823.679697616672;5844.3571207168025;5845.707714614167;5860.9450298946595;5873.060310350324;5506;5683.318001839806;5759.769609215752;5761.049426844524;5768.653880767168;5851.736671849862;5852.4147585241135;5882.5293976480925;5890.52875769946;5945.137954996588;5766.826995190151;5770.596058275881;5781.508571771278;5783.3638299787835;5784.161296612052 19:45:21 INFO - PROCESS | 30569 | |1;ext.html;648.672420427684;657.0800878769721;671.4359937652371;704.3027402871156;731.7073170731707;39964;40090.599094009085;40424;40707.59292407075;40728.59271407289;42249.36625950613;43194.784026079906;43307.78346108273;43345.78327108368;43433;8741.344399170055;8902.332325075613;8968.372213945026;8974.641014359418;8987.460752354848;8822.161894620032;8948.776280592972;8958.059403762609;8958.86561701575;8965.775855603597;9081.318901082444;9196.12636799503;9201.631934722604;9224.538773061353;9262.861057084148;9040.593173307185;9080.954595227015;9107.271418286555;9154.771130721785;9156.359054866096;9051.411658242194;9118.86321705175;9164.954175229148;9189.264858811279;9203.53982300889;43599.34600980988;43812.3428148578;44004.77997609991;44404.777976109915;44410.333844992354;3476.4263896457055;3598.712103031751;3684.410494320896;3701.370766969622;3838.405047217686;29751;29951.850240748874;29997.70002299993;30162.547561786592;30283.242918926982;4335.479742430897;4429.335599660045;4550.977245113786;4572.908541829145;4713.740744259065;327641;332114;334122;334157;334324.99999999756;40868;41351.379729304084;41449.171016580105;66135;67730.3226967734;40380.394294085614;40479.7976010124;40696.593034069876;40700.59299406968;40732.79633601813;17092.743608845878;17239.3966211182;17252.396166134375;17287.481375558753;17296.91351543234;13942.093763905517;13975.580732578039;13978.370973306226;14067.507637232648;14137.646558835906;9617.374870633386;9677.338856586757;9684.903150968541;9728.319017668695;9797.314188006914;3754.662080412776;3782.8108594570162;3806.733528652968;3830.3105441020325;3865.072382628149;1131.8641762988493;1207.3661327802974;1230.4585982167816;1234.962951111468;1287.016683364984;32388.83805580957;32920.341593168;33416.364809209255;33436.331273374395;34379.828100859835;1234.6172686467223;1251.2304932466468;1300.2523548959198;1309.9803502947464;1313.4352228541818;17012.404565840137;17059.573510662332;17528.386506472467;17597.560060998323;17759.467215983543;512743;575000;578903;579748;601264;55891.72054139703;56123;56362;56526.43473565212;56660.43339566634;1528.9068316154226;1544.1661502788593;1558.0397245234146;1572.9764053539207;1619.093307747665;29774.851125744233;30564;30697.53953690652;30890.382192355577;30959.535606966365;52996;53283.46716532785;53351.733241333546;53665;53714;469685;470433;473531;473896;475772;30371.39257214799;30577.847110764305;30666.386672266875;30949.381012379177;31247.687523125387;47727.28409073797;48030;48210.758946205046;48309;48814.267785983946;41379.379309309785;41601.583984160985;41606;42676.359854601586;42955.14089718251;40054.39918401168;40861;41080.794596026826;41430;42068.94827629334;42203.788981054895;42551.7872410636;42959.57040429681;43048;43173.3523997134;34653.306933861684;35424.645753542136;35578.8221058893;35936.28127437489;36457.81771091127;28116.85941570279;28621;28798;28906.855465722536;29029.41941161207 19:45:22 INFO - PROCESS | 30569 | |2;jquery.html;412.53795748761394;415.347903791048;417.45105186679496;423.6568379612514;431.2237971651027;14770.556883293491;18744.718829217574;19181.32865349713;19367.418977430665;19393.321233756822;18343.633127337478;18704.251829926787;18826.24695012198;19448.611027779436;19616.509587260327;5425.891482170354;5634.9718251408785;6030.608010479326;6042.335343112254;6052.9394706053035;5613.9157912631135;5643.181738647893;5660.235868157787;5664.150377443396;5666;5551.528120109796;5625.5218306444;5803.303603567578;5833.504152147073;5859.0625499920025;5815.47660710536;5818.883622327551;5822.272215973004;5842.5618078644275;5850.707464626752;5204.921926171072;5496.725163741797;5501.312335958005;5516.14499752539;5717.142428635696;12980.026498012687;13125.737485250336;14779.630509237248;22571.77428225713;22799.088036478523;2417.6857008588945;2541.4281786598053;2585.935351616206;2586.6646815057297;2605.3486628342916;10154.9492252539;10163.390196588229;10180.287379883412;10290.794184116276;11735.823962640481;1951.9024048797503;1993.7707163676073;1998.99000504998;2003.5291706448972;2014.4653652455352;46916;70752.646236769;78511.607441963;80710;83071.5846420764;10834.349939003685;11310.208285420105;11391.202615816814;11412.714682133013;11658.591949281734;15561.610959726097;15648.295826687827;15679.529614111594;15830.841691583168;15856.682866342608;8490.490570565786;8575.228229459253;8627.309815214894;8712.21590056898;8717.302615790848;8487.787805304793;8537.103604121601;8666.956665216634;8677.56612169389;8849.60176792046;4745.311929770233;4805.159097158054;4841.927371089437;4976.576990955737;5115.846524604268;2021.4542073640034;2097.1401725292862;2109.135254545629;2114.714513540683;2210.5026369067155;1014.9644762433279;1061.4957894999814;1089.727568107973;1102.8456016157745;1156.7455159864817;18985.90507047456;19113.044347782554;19488;19820.50448738793;20206.09072591737;1079.5735684404774;1087.7770057138268;1134.189054825787;1145.8796826333282;1176.923499972499;10558.472076396149;10952.959468850446;10960.013598776148;10989.546553147435;11147.996680298813;363335;366360;372747;372833;374832;57354;59437.70281148653;84331.5783421079;99672.5016374928;100388.49805750925;1126.983095253572;1136.3749937534487;1142.7485953090306;1150.7065698246893;1160.5821904114512;17425.651486970444;17540.82459175392;17828;18514;18898.055097245357;40048.1990360197;40245.195096097326;42088;42243;42493;53583.19625205703;57959;58063;58827.4117258839;58941.410585895304;8223.383246256435;8612.827743445221;8661.263792577449;8700.651973921225;8826.029136795076;10698.62554810578;12128.272303661808;12161.087918405978;12173.57392491294;12196.146269761031;10524.52639631203;10540.631077912236;10686.412247326472;10738.946305268424;10866.836997444887;10670.30643008202;10689.412082335546;10751.247412681038;10952.178586605876;11267.718307042061;11101.16741244426;11261.831072534082;11405.429728513707;11418.486168122288;11525.88474115248;8407.747767566983;8448.619812108593;8602.39783215169;8696.956515217384;8808.11918808114;9906;10565.63020294286;10609.9469502652;10642.574297028032;10833.02502774754 19:45:22 INFO - PROCESS | 30569 | |3;mootools.html;1502.496663617688;1520.0347779160234;1697.3889399816064;1856.33172058059;1867.0851282871388;7140.428765698732;7653.272939070794;7853.607319634017;8102;8125.187481251872;7840.607969601526;7876.094249161348;7978.601069946509;7980.960095199531;7990.92009079909;2282.6804247405375;2293.5068960173558;2299.4711216420233;2300.9769902301014;2303.5738388398117;2210.9447263818374;2234.0616940884865;2257.559775843711;2260.028187879211;2269.2851751698245;2355.9175428859994;2381.368937231635;2399.6520504526834;2400.0399840063938;2400.3999000249937;2303.838731288802;2316.293530473205;2320.1879342230254;2324.418895276181;2364.7398786133513;2322.15241436876;2328.557574060923;2331.3239160643393;2350.612148995414;2358.716953965518;8170.060443049066;8273.586320684002;8278.751637450887;8283.544405057719;8304.335653147733;5124.231365295198;5168.250603662448;5181.559567436735;5190.273361729361;5201.29782479368;3165.2878102427;3182.554442378069;3293.4730443128983;3326.234965957843;3327.617324007746;1122.691259903525;1135.250734515216;1141.081429449293;1165.6153469355093;1176.8587769467633;11064.446777661085;11125.610603628835;11138.610148644759;11168.497417616309;11234.943825280903;4385.9692972151515;4406.735595864258;4467.530909254547;4480.775961201927;4501.144782491317;9643.035696430301;9643.228541716646;9668.129868311886;9705.902940970642;9717.708468745948;5097.923531147036;5140.254663073833;5180.844574662766;5189.351331083614;5191.9480805192225;4164.125533637909;4601.079784043205;4672.252439609646;4778.331033655291;4780.928286075712;4085.080856807195;4136.607022332873;4149.190907773016;4200.348945913388;4201.747895126302;1339.4575197045017;1347.2455424961856;1359.4969861151437;1362.3256488038485;1362.6525236064938;1003.2826529031777;1017.1964148322742;1025.103034844511;1036.9325993810528;1047.8847326794046;5491.148871924858;5674.659520428788;5674.858128546737;5739.885202295931;5773.566982476331;448.38571157513763;452.5135479359636;453.4400015980262;454.3548161610521;463.2449107954081;3907.29668659644;4124.587541245912;4190;4196.769177695256;4214.220369231702;9700.75748106303;9714.708558743248;9780.315377923476;9797.167240784613;9804.313698041211;9345;9627;9684.854727179098;9710.6115755369;9713.271504637181;7403.629818509053;7581.090269167735;7622.313991740659;7638;7651.311381975649;5545.223668686306;5561.972190139023;5679;5781.768729250783;5849.795257165979;8843.425177363451;8938.553072346487;9021.864672029793;9082.863757043782;9097.909020909707;8785.428947118417;8891.377603567687;9208.907910920805;9213.631454741735;9248;6376.330485299162;7149.177844547736;7237.746678866214;7476.289752473506;7690.077190737147;7732.497387669783;7801;7808.336291415066;7822.295993360625;7879.881801773093;6994.33553812387;7164.355208031302;7208.27917208275;7222.458315626454;7309.707611695472;7123.7506687265695;7163.570185788869;7207.927920720936;7256.96371518139;7290.416766658761;6530.67346632657;6691.364320389555;6722.529422940347;6734.090897728744;6741.494387921024;4918.311436398979;4966.230234313687;5023.271625614192;5024.773885175103;5038.798448062036;5004.549590536869;5058.848234552969;5068.315777370155;5103.948960510347;5144.871378215575 19:45:22 INFO - PROCESS | 30569 | |4;prototype.html;333.56281938155126;339.9830008499574;340.5623773451116;343.68896148985175;345.8858576669699;6561.704723287446;6667.899981500282;6720.932790672092;6731.596104233738;6810.148731408574;6535.738570457176;6547.377999090078;6625.668716564177;6632.403083722464;6638.336166383359;4944.283078953549;4993.176125939225;5004.774785134659;5009.524095210967;5019.673721208128;4997.725125118117;4999;5013.899722005558;5020.698758074527;5023.2214006829;4930.781148483179;4932.901341973158;4953.257011448276;4972.8508144755715;4985.152524070917;4819.927701084486;4950.975245123769;4967.05625931072;4992.850214493571;4996.925046124311;4324.8486302979245;4330.350447432878;4338.631216346615;4342.348647702838;4343.087951530182;6289.559730818844;6294;6378;6382.553221274513;6419.743210271584;5845.801610669802;5859.648421094748;5884.146798714205;5898.14476900847;5919.1713160157615;7001.719931202746;7044.682989265495;7052.294770522906;7055.588882223525;7063.576185428839;4769.284607308897;4793.880152996168;4810.494898035726;4845.466998630148;4847.660663753539;7142.607156606385;7283.126024876996;7285.490015698851;7288.234735352765;7366.742164024287;4738.976305118521;4771.498992605796;4782.187028205213;4825.914169311947;4827.744786355573;4887.511248875084;4890.486498917634;4897.510248975074;4899.706017638953;4901.779419926112;5726.0838265877255;5743.8851222976145;5745.425457454221;5761.049426844607;5767.971160144256;7032.859342813217;7032.8945065824055;7054.576725396492;7071;7083;1709.3248166974224;1743.4246698589436;1746.6594014167115;1756.1394916490829;1770.4334612924;1135.6138912769698;1158.623447379605;1162.4071723421116;1168.5384273212035;1177.682025853015;6695;6712.664366781642;6724.630145342053;6728.865422691519;6736.8989465158065;7126.750563730245;7134.429245660334;7158.92841071593;7168.354848063699;7177.4258059355125;6689.832754181184;6692.297308782605;6693.799186024427;6698.732050718014;6700.463962882957;3841.2317536492815;3904.2386734586485;3912.0415498203124;3941.1329507508303;3953.2291203215673;7474.065741782278;7548.584827834522;7555.508891922117;7561.962190189124;7580.886286705704;7392.519486233377;7403.888941665879;7417.925820741723;7450.96274518624;7472.962635186789;7627.351675107567;7660.425468089916;7663.348615367756;7668.654910528928;7690.230976902265;7175.712971481291;7316;7348.1182258129365;7367.594782287026;7428.665710042953;7307.890381644173;7319.634018298957;7322.707091716272;7328.633568321456;7337.669804858688;7683.654235559525;7713.151553329017;7721.53670779755;7723.150453450228;7724.420668450001;4804.639652026042;4836.12949669063;4846.684965477232;4852.272159176152;4874.975625121851;7079.327463890922;7382.114146302478;7399.408047356306;7406.518576292524;7415.8146046349275;7159.284071592799;7172.246914073947;7174.246704096204;7192.280771922766;7194.460415468756;7107.857842843011;7108.537945033556;7147.64261786919;7152.213256541881;7154.320339567733;6950.339717726808;6960.79117626472;6999.440044796506;7025.473089518408;7039.401650859734;7050.788476345718;7176.102987126609;7193.964030179815;7216.855662886608;7226.494145409771;6932.44540436774;6960.651967401711;6999.47503937217;7022.789316320519;7023.438124950094 19:45:22 INFO - PROCESS | 30569 | |5;yui.html;671.2884342596844;698.6402002968472;784.9764507064788;838.8406202821463;852.5481494807752;15316.081035137886;15429;15512.84487155128;15516.612084697888;15546.689066218669;12654;12715.809262861065;12796;12888.226706397623;12982.22106673598;745.2100773180446;883.1433509495779;889.7864512516982;892.9508877011762;894.2622336572322;885.3758100539137;888.8844450221494;889.8665200219987;890.1054440287535;890.7060669978891;932.4778124250407;933.2207606648457;935.5836652689555;937.6108914800384;937.9202767764748;920.052346083535;923.1368670293264;926.5969303353063;930.0885132570052;931.0549791961165;690.2338404371144;691.9584824910521;692.7159864455599;693.0955103589813;694.0734119949873;14419.279036048156;14449.49426770058;14507.347169377297;14524.782128268085;14633.414663413558;12596.496140154382;12772.680682982907;12850.228986260854;12865.194272399553;13016.869831301756;10937.56249750009;11003.944980275128;11047.171462140292;11276.548938042468;11360.204785665006;3833.118382771978;3882.5729169791302;3890.4164375343926;3902.083010492532;4023.839046438139;55905.72047139779;56397;56434.71782641102;56869;56925.43074569243;10191.898081019095;10284.845727314096;10609.310394824312;10712.625987537403;10718.660167479065;21211.893940530197;21307.78692213058;21344.679829802564;21365.35903922885;21371.25200618002;8537.74386768398;8727.91272087271;8868.15752503511;8914.242289405343;8933.731988040368;4834.661573689878;4863.708177509361;4869;4937.23472861707;5019.824306149268;3574.267275208576;3586.103474131467;3586.28274345132;3606.549181352331;3614.493970844084;649.1139594453631;659.9274079851212;669.7622344067884;676.046774048599;685.0614657918584;702.5644100657523;711.0969069281983;714.0645754062091;726.9418446524265;736.9963150184215;9677.032296770267;9740.220782337537;9843.261755368376;9876.45679487635;10028.997100290058;639.1531221132019;685.6297599296424;688.9837489702649;720.1646090534954;738.092146659601;4205.201011807747;4471.977640111843;4485.641148708096;4547.545245475426;4597.95402045982;60442;62229;62431.37568624347;62836.68581657062;62931.05603415953;54888.72555637196;56565.15152272719;57023.71488142533;57278.427215728145;58281.70859145762;49869.501304987214;50001.74999124981;50003.749981249865;50997.23504147441;51258;8597.957010214908;8756.649734010569;8759.255463285692;8804.383693141419;8915.509646969478;36336.81831590931;37066.444003339435;37162.25675486421;37426.064348391505;37696.43455348227;42357.788211058745;44652.55347446484;48784;49408.25887611761;49718.50281497283;10762.19283553721;10806.583343645589;10861.578189105672;11114.05530529914;11254.718632034264;11446.599369022044;11458.77082458363;11522.827157592475;11701.122415818678;11977.281363117892;11445.885541144815;11509.194356394972;11724.58963936258;11739.354335511629;12390.752184956431;10614.027270296618;10707.839382409114;11073.667789966314;11231.045361144068;11473.598424055119;10438.321509101885;10714.089302409382;10809.297395669257;11044.834327484934;11457.828132578185;9246.214071803703;9350.812983740423;10506.632267870587;10689.9465502672;10966.506507207354;10316.813566439956;10773.461326933466;11029.944850276019;11049.558017679203;11100.833487497532 19:45:22 INFO - PROCESS | 30569 | __end_tp_report 19:45:22 INFO - PROCESS | 30569 | __start_cc_report 19:45:22 INFO - PROCESS | 30569 | _x_x_mozilla_cycle_collect,334 19:45:22 INFO - PROCESS | 30569 | __end_cc_report 19:45:22 INFO - PROCESS | 30569 | __startTimestamp1464057921995__endTimestamp 19:45:22 INFO - PROCESS | 30569 | 19:45:22 INFO - PROCESS | 30569 | ------- Summary: start ------- 19:45:22 INFO - PROCESS | 30569 | Number of tests: 6 19:45:22 INFO - PROCESS | 30569 | 19:45:22 INFO - PROCESS | 30569 | [#0] dojo.html Cycles:165 Average:5551.45 Median:5774.51 stddev:599.10 (10.4%) stddev-sans-first:574.36 19:45:22 INFO - PROCESS | 30569 | Values: 3301.9 3350.0 3366.4 3404.9 3404.9 5534.7 5554.2 5572.0 5595.7 5629.0 5520.2 5581.6 5598.9 5599.5 5606.6 5046.4 5117.7 5155.3 5155.5 5183.1 5023.2 5130.8 5216.8 5256.8 5294.8 5051.2 5075.3 5118.4 5216.3 5233.2 5092.6 5101.6 5109.8 5111.5 5149.1 4985.9 5045.8 5075.7 5089.9 5096.8 5334.8 5375.1 5473.0 5497.6 5524.7 5909.1 5947.9 5951.8 5952.7 5953.7 5849.9 5939.9 5946.1 6011.8 6013.6 5513.9 5557.5 5596.4 5677.2 5680.4 5999.9 6016.5 6069.0 6075.6 6078.9 5777.5 5839.3 5844.4 5844.4 5852.4 5954.0 6002.7 6002.9 6017.0 6017.8 5941.1 5942.2 5945.4 5953.3 5960.9 5814.3 5894.0 5941.4 5991.8 6001.7 4546.3 4569.0 4570.7 4575.3 4601.5 4111.0 4128.8 4136.3 4144.6 4149.2 5635.2 5703.7 5715.9 5734.5 5749.9 5774.5 5948.9 6059.2 6067.8 6072.3 5568.0 5692.3 5704.1 5704.7 5706.7 5079.7 5156.0 5156.1 5175.5 5190.5 6103.4 6159.5 6167.9 6174.3 6180.4 5918.3 5965.1 5972.1 5980.2 6022.6 6118.6 6120.5 6123.6 6130.8 6155.1 5840.7 5846.9 5849.8 5862.7 5874.1 5803.0 5901.7 5940.4 5952.3 5968.9 5857.0 5858.2 5909.0 5910.5 5918.7 5823.7 5844.4 5845.7 5860.9 5873.1 5506.0 5683.3 5759.8 5761.0 5768.7 5851.7 5852.4 5882.5 5890.5 5945.1 5766.8 5770.6 5781.5 5783.4 5784.2 19:45:22 INFO - PROCESS | 30569 | 19:45:22 INFO - PROCESS | 30569 | [#1] ext.html Cycles:180 Average:60764.64 Median:41404.69 stddev:124752.16 (301.3%) stddev-sans-first:125020.47 19:45:22 INFO - PROCESS | 30569 | Values: 648.7 657.1 671.4 704.3 731.7 39964.0 40090.6 40424.0 40707.6 40728.6 42249.4 43194.8 43307.8 43345.8 43433.0 8741.3 8902.3 8968.4 8974.6 8987.5 8822.2 8948.8 8958.1 8958.9 8965.8 9081.3 9196.1 9201.6 9224.5 9262.9 9040.6 9081.0 9107.3 9154.8 9156.4 9051.4 9118.9 9165.0 9189.3 9203.5 43599.3 43812.3 44004.8 44404.8 44410.3 3476.4 3598.7 3684.4 3701.4 3838.4 29751.0 29951.9 29997.7 30162.5 30283.2 4335.5 4429.3 4551.0 4572.9 4713.7 327641.0 332114.0 334122.0 334157.0 334325.0 40868.0 41351.4 41449.2 66135.0 67730.3 40380.4 40479.8 40696.6 40700.6 40732.8 17092.7 17239.4 17252.4 17287.5 17296.9 13942.1 13975.6 13978.4 14067.5 14137.6 9617.4 9677.3 9684.9 9728.3 9797.3 3754.7 3782.8 3806.7 3830.3 3865.1 1131.9 1207.4 1230.5 1235.0 1287.0 32388.8 32920.3 33416.4 33436.3 34379.8 1234.6 1251.2 1300.3 1310.0 1313.4 17012.4 17059.6 17528.4 17597.6 17759.5 512743.0 575000.0 578903.0 579748.0 601264.0 55891.7 56123.0 56362.0 56526.4 56660.4 1528.9 1544.2 1558.0 1573.0 1619.1 29774.9 30564.0 30697.5 30890.4 30959.5 52996.0 53283.5 53351.7 53665.0 53714.0 469685.0 470433.0 473531.0 473896.0 475772.0 30371.4 30577.8 30666.4 30949.4 31247.7 47727.3 48030.0 48210.8 48309.0 48814.3 41379.4 41601.6 41606.0 42676.4 42955.1 40054.4 40861.0 41080.8 41430.0 42068.9 42203.8 42551.8 42959.6 43048.0 43173.4 34653.3 35424.6 35578.8 35936.3 36457.8 28116.9 28621.0 28798.0 28906.9 29029.4 19:45:22 INFO - PROCESS | 30569 | 19:45:22 INFO - PROCESS | 30569 | [#2] jquery.html Cycles:180 Average:24869.33 Median:2111.92 stddev:61472.80 (2910.7%) stddev-sans-first:61617.82 19:45:22 INFO - PROCESS | 30569 | Values: 412.5 415.3 417.5 423.7 431.2 14770.6 18744.7 19181.3 19367.4 19393.3 18343.6 18704.3 18826.2 19448.6 19616.5 5425.9 5635.0 6030.6 6042.3 6052.9 5613.9 5643.2 5660.2 5664.2 5666.0 5551.5 5625.5 5803.3 5833.5 5859.1 5815.5 5818.9 5822.3 5842.6 5850.7 5204.9 5496.7 5501.3 5516.1 5717.1 12980.0 13125.7 14779.6 22571.8 22799.1 2417.7 2541.4 2585.9 2586.7 2605.3 10154.9 10163.4 10180.3 10290.8 11735.8 1951.9 1993.8 1999.0 2003.5 2014.5 46916.0 70752.6 78511.6 80710.0 83071.6 10834.3 11310.2 11391.2 11412.7 11658.6 15561.6 15648.3 15679.5 15830.8 15856.7 8490.5 8575.2 8627.3 8712.2 8717.3 8487.8 8537.1 8667.0 8677.6 8849.6 4745.3 4805.2 4841.9 4976.6 5115.8 2021.5 2097.1 2109.1 2114.7 2210.5 1015.0 1061.5 1089.7 1102.8 1156.7 18985.9 19113.0 19488.0 19820.5 20206.1 1079.6 1087.8 1134.2 1145.9 1176.9 10558.5 10953.0 10960.0 10989.5 11148.0 363335.0 366360.0 372747.0 372833.0 374832.0 57354.0 59437.7 84331.6 99672.5 100388.5 1127.0 1136.4 1142.7 1150.7 1160.6 17425.7 17540.8 17828.0 18514.0 18898.1 40048.2 40245.2 42088.0 42243.0 42493.0 53583.2 57959.0 58063.0 58827.4 58941.4 8223.4 8612.8 8661.3 8700.7 8826.0 10698.6 12128.3 12161.1 12173.6 12196.1 10524.5 10540.6 10686.4 10738.9 10866.8 10670.3 10689.4 10751.2 10952.2 11267.7 11101.2 11261.8 11405.4 11418.5 11525.9 8407.7 8448.6 8602.4 8697.0 8808.1 9906.0 10565.6 10609.9 10642.6 10833.0 19:45:22 INFO - PROCESS | 30569 | 19:45:22 INFO - PROCESS | 30569 | [#3] mootools.html Cycles:180 Average:5430.35 Median:5132.24 stddev:2924.68 (57.0%) stddev-sans-first:2917.99 19:45:22 INFO - PROCESS | 30569 | Values: 1502.5 1520.0 1697.4 1856.3 1867.1 7140.4 7653.3 7853.6 8102.0 8125.2 7840.6 7876.1 7978.6 7981.0 7990.9 2282.7 2293.5 2299.5 2301.0 2303.6 2210.9 2234.1 2257.6 2260.0 2269.3 2355.9 2381.4 2399.7 2400.0 2400.4 2303.8 2316.3 2320.2 2324.4 2364.7 2322.2 2328.6 2331.3 2350.6 2358.7 8170.1 8273.6 8278.8 8283.5 8304.3 5124.2 5168.3 5181.6 5190.3 5201.3 3165.3 3182.6 3293.5 3326.2 3327.6 1122.7 1135.3 1141.1 1165.6 1176.9 11064.4 11125.6 11138.6 11168.5 11234.9 4386.0 4406.7 4467.5 4480.8 4501.1 9643.0 9643.2 9668.1 9705.9 9717.7 5097.9 5140.3 5180.8 5189.4 5191.9 4164.1 4601.1 4672.3 4778.3 4780.9 4085.1 4136.6 4149.2 4200.3 4201.7 1339.5 1347.2 1359.5 1362.3 1362.7 1003.3 1017.2 1025.1 1036.9 1047.9 5491.1 5674.7 5674.9 5739.9 5773.6 448.4 452.5 453.4 454.4 463.2 3907.3 4124.6 4190.0 4196.8 4214.2 9700.8 9714.7 9780.3 9797.2 9804.3 9345.0 9627.0 9684.9 9710.6 9713.3 7403.6 7581.1 7622.3 7638.0 7651.3 5545.2 5562.0 5679.0 5781.8 5849.8 8843.4 8938.6 9021.9 9082.9 9097.9 8785.4 8891.4 9208.9 9213.6 9248.0 6376.3 7149.2 7237.7 7476.3 7690.1 7732.5 7801.0 7808.3 7822.3 7879.9 6994.3 7164.4 7208.3 7222.5 7309.7 7123.8 7163.6 7207.9 7257.0 7290.4 6530.7 6691.4 6722.5 6734.1 6741.5 4918.3 4966.2 5023.3 5024.8 5038.8 5004.5 5058.8 5068.3 5103.9 5144.9 19:45:22 INFO - PROCESS | 30569 | 19:45:22 INFO - PROCESS | 30569 | [#4] prototype.html Cycles:180 Average:5882.19 Median:6696.87 stddev:1819.44 (27.2%) stddev-sans-first:1776.24 19:45:22 INFO - PROCESS | 30569 | Values: 333.6 340.0 340.6 343.7 345.9 6561.7 6667.9 6720.9 6731.6 6810.1 6535.7 6547.4 6625.7 6632.4 6638.3 4944.3 4993.2 5004.8 5009.5 5019.7 4997.7 4999.0 5013.9 5020.7 5023.2 4930.8 4932.9 4953.3 4972.9 4985.2 4819.9 4951.0 4967.1 4992.9 4996.9 4324.8 4330.4 4338.6 4342.3 4343.1 6289.6 6294.0 6378.0 6382.6 6419.7 5845.8 5859.6 5884.1 5898.1 5919.2 7001.7 7044.7 7052.3 7055.6 7063.6 4769.3 4793.9 4810.5 4845.5 4847.7 7142.6 7283.1 7285.5 7288.2 7366.7 4739.0 4771.5 4782.2 4825.9 4827.7 4887.5 4890.5 4897.5 4899.7 4901.8 5726.1 5743.9 5745.4 5761.0 5768.0 7032.9 7032.9 7054.6 7071.0 7083.0 1709.3 1743.4 1746.7 1756.1 1770.4 1135.6 1158.6 1162.4 1168.5 1177.7 6695.0 6712.7 6724.6 6728.9 6736.9 7126.8 7134.4 7158.9 7168.4 7177.4 6689.8 6692.3 6693.8 6698.7 6700.5 3841.2 3904.2 3912.0 3941.1 3953.2 7474.1 7548.6 7555.5 7562.0 7580.9 7392.5 7403.9 7417.9 7451.0 7473.0 7627.4 7660.4 7663.3 7668.7 7690.2 7175.7 7316.0 7348.1 7367.6 7428.7 7307.9 7319.6 7322.7 7328.6 7337.7 7683.7 7713.2 7721.5 7723.2 7724.4 4804.6 4836.1 4846.7 4852.3 4875.0 7079.3 7382.1 7399.4 7406.5 7415.8 7159.3 7172.2 7174.2 7192.3 7194.5 7107.9 7108.5 7147.6 7152.2 7154.3 6950.3 6960.8 6999.4 7025.5 7039.4 7050.8 7176.1 7194.0 7216.9 7226.5 6932.4 6960.7 6999.5 7022.8 7023.4 19:45:22 INFO - PROCESS | 30569 | 19:45:22 INFO - PROCESS | 30569 | [#5] yui.html Cycles:180 Average:14923.95 Median:4716.31 stddev:17576.40 (372.7%) stddev-sans-first:17593.12 19:45:22 INFO - PROCESS | 30569 | Values: 671.3 698.6 785.0 838.8 852.5 15316.1 15429.0 15512.8 15516.6 15546.7 12654.0 12715.8 12796.0 12888.2 12982.2 745.2 883.1 889.8 893.0 894.3 885.4 888.9 889.9 890.1 890.7 932.5 933.2 935.6 937.6 937.9 920.1 923.1 926.6 930.1 931.1 690.2 692.0 692.7 693.1 694.1 14419.3 14449.5 14507.3 14524.8 14633.4 12596.5 12772.7 12850.2 12865.2 13016.9 10937.6 11003.9 11047.2 11276.5 11360.2 3833.1 3882.6 3890.4 3902.1 4023.8 55905.7 56397.0 56434.7 56869.0 56925.4 10191.9 10284.8 10609.3 10712.6 10718.7 21211.9 21307.8 21344.7 21365.4 21371.3 8537.7 8727.9 8868.2 8914.2 8933.7 4834.7 4863.7 4869.0 4937.2 5019.8 3574.3 3586.1 3586.3 3606.5 3614.5 649.1 659.9 669.8 676.0 685.1 702.6 711.1 714.1 726.9 737.0 9677.0 9740.2 9843.3 9876.5 10029.0 639.2 685.6 689.0 720.2 738.1 4205.2 4472.0 4485.6 4547.5 4598.0 60442.0 62229.0 62431.4 62836.7 62931.1 54888.7 56565.2 57023.7 57278.4 58281.7 49869.5 50001.7 50003.7 50997.2 51258.0 8598.0 8756.6 8759.3 8804.4 8915.5 36336.8 37066.4 37162.3 37426.1 37696.4 42357.8 44652.6 48784.0 49408.3 49718.5 10762.2 10806.6 10861.6 11114.1 11254.7 11446.6 11458.8 11522.8 11701.1 11977.3 11445.9 11509.2 11724.6 11739.4 12390.8 10614.0 10707.8 11073.7 11231.0 11473.6 10438.3 10714.1 10809.3 11044.8 11457.8 9246.2 9350.8 10506.6 10689.9 10966.5 10316.8 10773.5 11029.9 11049.6 11100.8 19:45:22 INFO - PROCESS | 30569 | -------- Summary: end -------- 19:45:22 INFO - PROCESS | 30569 | 19:45:22 INFO - TEST-INFO | 30569: exit 0 19:45:22 INFO - TEST-OK | dromaeo_css | took 1108412ms 19:45:22 INFO - TEST-START | kraken 19:45:22 INFO - operating with platform_type : linux_ 19:45:22 INFO - Initialising browser for kraken test... 19:45:22 INFO - TEST-INFO | started process 30809 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp05_PMr/profile http://localhost:35382/getInfo.html) 19:45:25 INFO - PROCESS | 30809 | 19:45:25 INFO - PROCESS | 30809 | (process:30890): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:45:26 INFO - PROCESS | 30809 | __metrics Screen width/height:1600/1200 19:45:26 INFO - PROCESS | 30809 | colorDepth:24 19:45:26 INFO - PROCESS | 30809 | Browser inner width/height: 1024/697 19:45:26 INFO - PROCESS | 30809 | __metrics 19:45:27 ERROR - PROCESS | 30809 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 19:45:27 INFO - TEST-INFO | 30809: exit 0 19:45:27 INFO - Browser initialized. 19:45:27 INFO - Running cycle 1/1 for kraken test... 19:45:27 INFO - TEST-INFO | started process 30941 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp05_PMr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:45:29 INFO - PROCESS | 30941 | 19:45:29 INFO - PROCESS | 30941 | (process:31008): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:45:39 INFO - PROCESS | 30941 | RSS: Main: 151515136 19:45:39 INFO - PROCESS | 30941 | 19:45:42 INFO - PROCESS | 30941 | Cycle 1(1): loaded http://localhost:35382/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35382/tests/kraken/driver.html?testName=audio-beat-detection) 19:45:43 INFO - PROCESS | 30941 | RSS: Main: 156512256 19:45:43 INFO - PROCESS | 30941 | 19:45:45 INFO - PROCESS | 30941 | Cycle 1(1): loaded http://localhost:35382/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35382/tests/kraken/driver.html?testName=audio-dft) 19:45:46 INFO - PROCESS | 30941 | RSS: Main: 156532736 19:45:46 INFO - PROCESS | 30941 | 19:45:49 INFO - PROCESS | 30941 | Cycle 1(1): loaded http://localhost:35382/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35382/tests/kraken/driver.html?testName=audio-fft) 19:45:49 INFO - PROCESS | 30941 | RSS: Main: 156590080 19:45:49 INFO - PROCESS | 30941 | 19:45:51 INFO - PROCESS | 30941 | Cycle 1(1): loaded http://localhost:35382/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35382/tests/kraken/driver.html?testName=audio-oscillator) 19:45:52 INFO - PROCESS | 30941 | RSS: Main: 156442624 19:45:52 INFO - PROCESS | 30941 | 19:45:54 INFO - PROCESS | 30941 | Cycle 1(1): loaded http://localhost:35382/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35382/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:45:55 INFO - PROCESS | 30941 | RSS: Main: 156942336 19:45:55 INFO - PROCESS | 30941 | 19:45:58 INFO - PROCESS | 30941 | Cycle 1(1): loaded http://localhost:35382/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35382/tests/kraken/driver.html?testName=imaging-darkroom) 19:45:59 INFO - PROCESS | 30941 | RSS: Main: 156430336 19:45:59 INFO - PROCESS | 30941 | 19:46:02 INFO - PROCESS | 30941 | Cycle 1(1): loaded http://localhost:35382/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35382/tests/kraken/driver.html?testName=imaging-desaturate) 19:46:02 INFO - PROCESS | 30941 | RSS: Main: 156487680 19:46:02 INFO - PROCESS | 30941 | 19:46:05 INFO - PROCESS | 30941 | Cycle 1(1): loaded http://localhost:35382/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35382/tests/kraken/driver.html?testName=json-parse-financial) 19:46:06 INFO - PROCESS | 30941 | RSS: Main: 156745728 19:46:06 INFO - PROCESS | 30941 | 19:46:07 INFO - PROCESS | 30941 | Cycle 1(1): loaded http://localhost:35382/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35382/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:46:08 INFO - PROCESS | 30941 | RSS: Main: 157368320 19:46:08 INFO - PROCESS | 30941 | 19:46:10 INFO - PROCESS | 30941 | Cycle 1(1): loaded http://localhost:35382/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35382/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:46:10 INFO - PROCESS | 30941 | RSS: Main: 157007872 19:46:10 INFO - PROCESS | 30941 | 19:46:12 INFO - PROCESS | 30941 | Cycle 1(1): loaded http://localhost:35382/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35382/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:46:13 INFO - PROCESS | 30941 | RSS: Main: 156860416 19:46:13 INFO - PROCESS | 30941 | 19:46:15 INFO - PROCESS | 30941 | Cycle 1(1): loaded http://localhost:35382/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35382/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:46:16 INFO - PROCESS | 30941 | RSS: Main: 157843456 19:46:16 INFO - PROCESS | 30941 | 19:46:19 INFO - PROCESS | 30941 | Cycle 1(1): loaded http://localhost:35382/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35382/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:46:19 INFO - PROCESS | 30941 | RSS: Main: 157278208 19:46:19 INFO - PROCESS | 30941 | 19:46:21 INFO - PROCESS | 30941 | Cycle 1(1): loaded http://localhost:35382/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35382/tests/kraken/driver.html?testName=ai-astar) 19:46:21 INFO - PROCESS | 30941 | RSS: Main: 158560256 19:46:21 INFO - PROCESS | 30941 | 19:46:21 INFO - PROCESS | 30941 | __start_tp_report 19:46:21 INFO - PROCESS | 30941 | _x_x_mozilla_page_load 19:46:21 INFO - PROCESS | 30941 | _x_x_mozilla_page_load_details 19:46:21 INFO - PROCESS | 30941 | |i|pagename|runs| 19:46:21 INFO - PROCESS | 30941 | |0;ai-astar;109;111;102;109;112;111;103;112;112;111 19:46:21 INFO - PROCESS | 30941 | |1;audio-beat-detection;152;134;159;170;128;162;156;125;190;133 19:46:21 INFO - PROCESS | 30941 | |2;audio-dft;164;163;163;163;164;173;162;162;163;163 19:46:21 INFO - PROCESS | 30941 | |3;audio-fft;76;74;74;183;76;76;73;77;172;76 19:46:21 INFO - PROCESS | 30941 | |4;audio-oscillator;93;92;147;99;93;92;144;92;92;146 19:46:21 INFO - PROCESS | 30941 | |5;imaging-gaussian-blur;117;117;118;119;118;118;117;118;118;117 19:46:21 INFO - PROCESS | 30941 | |6;imaging-darkroom;148;154;147;147;147;148;147;147;147;147 19:46:21 INFO - PROCESS | 30941 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;96;96 19:46:21 INFO - PROCESS | 30941 | |8;json-parse-financial;55;56;57;57;57;61;60;77;54;55 19:46:21 INFO - PROCESS | 30941 | |9;json-stringify-tinderbox;59;60;58;58;59;58;59;59;59;60 19:46:21 INFO - PROCESS | 30941 | |10;stanford-crypto-aes;73;80;72;73;73;75;75;74;74;75 19:46:21 INFO - PROCESS | 30941 | |11;stanford-crypto-ccm;115;120;126;124;113;116;120;114;129;125 19:46:21 INFO - PROCESS | 30941 | |12;stanford-crypto-pbkdf2;160;173;156;159;160;158;164;155;157;158 19:46:21 INFO - PROCESS | 30941 | |13;stanford-crypto-sha256-iterative;67;71;67;67;68;74;67;67;66;70 19:46:21 INFO - PROCESS | 30941 | __end_tp_report 19:46:21 INFO - PROCESS | 30941 | __start_cc_report 19:46:21 INFO - PROCESS | 30941 | _x_x_mozilla_cycle_collect,886 19:46:21 INFO - PROCESS | 30941 | __end_cc_report 19:46:21 INFO - PROCESS | 30941 | __startTimestamp1464057981825__endTimestamp 19:46:21 INFO - PROCESS | 30941 | 19:46:21 INFO - PROCESS | 30941 | ------- Summary: start ------- 19:46:21 INFO - PROCESS | 30941 | Number of tests: 14 19:46:21 INFO - PROCESS | 30941 | 19:46:21 INFO - PROCESS | 30941 | [#0] ai-astar Cycles:10 Average:109.20 Median:111.00 stddev:3.71 (3.3%) stddev-sans-first:3.93 19:46:21 INFO - PROCESS | 30941 | Values: 109.0 111.0 102.0 109.0 112.0 111.0 103.0 112.0 112.0 111.0 19:46:21 INFO - PROCESS | 30941 | 19:46:21 INFO - PROCESS | 30941 | [#1] audio-beat-detection Cycles:10 Average:150.90 Median:157.50 stddev:20.85 (13.2%) stddev-sans-first:22.11 19:46:21 INFO - PROCESS | 30941 | Values: 152.0 134.0 159.0 170.0 128.0 162.0 156.0 125.0 190.0 133.0 19:46:21 INFO - PROCESS | 30941 | 19:46:21 INFO - PROCESS | 30941 | [#2] audio-dft Cycles:10 Average:164.00 Median:163.00 stddev:3.23 (2.0%) stddev-sans-first:3.43 19:46:21 INFO - PROCESS | 30941 | Values: 164.0 163.0 163.0 163.0 164.0 173.0 162.0 162.0 163.0 163.0 19:46:21 INFO - PROCESS | 30941 | 19:46:21 INFO - PROCESS | 30941 | [#3] audio-fft Cycles:10 Average:95.70 Median:76.00 stddev:43.21 (56.9%) stddev-sans-first:45.24 19:46:21 INFO - PROCESS | 30941 | Values: 76.0 74.0 74.0 183.0 76.0 76.0 73.0 77.0 172.0 76.0 19:46:21 INFO - PROCESS | 30941 | 19:46:21 INFO - PROCESS | 30941 | [#4] audio-oscillator Cycles:10 Average:109.00 Median:92.00 stddev:25.40 (27.6%) stddev-sans-first:26.27 19:46:21 INFO - PROCESS | 30941 | Values: 93.0 92.0 147.0 99.0 93.0 92.0 144.0 92.0 92.0 146.0 19:46:21 INFO - PROCESS | 30941 | 19:46:21 INFO - PROCESS | 30941 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.67 (0.6%) stddev-sans-first:0.67 19:46:21 INFO - PROCESS | 30941 | Values: 117.0 117.0 118.0 119.0 118.0 118.0 117.0 118.0 118.0 117.0 19:46:21 INFO - PROCESS | 30941 | 19:46:21 INFO - PROCESS | 30941 | [#6] imaging-darkroom Cycles:10 Average:147.90 Median:147.00 stddev:2.18 (1.5%) stddev-sans-first:2.32 19:46:21 INFO - PROCESS | 30941 | Values: 148.0 154.0 147.0 147.0 147.0 148.0 147.0 147.0 147.0 147.0 19:46:21 INFO - PROCESS | 30941 | 19:46:21 INFO - PROCESS | 30941 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 19:46:21 INFO - PROCESS | 30941 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 96.0 19:46:21 INFO - PROCESS | 30941 | 19:46:21 INFO - PROCESS | 30941 | [#8] json-parse-financial Cycles:10 Average:58.90 Median:57.00 stddev:6.72 (11.8%) stddev-sans-first:6.98 19:46:21 INFO - PROCESS | 30941 | Values: 55.0 56.0 57.0 57.0 57.0 61.0 60.0 77.0 54.0 55.0 19:46:21 INFO - PROCESS | 30941 | 19:46:21 INFO - PROCESS | 30941 | [#9] json-stringify-tinderbox Cycles:10 Average:58.90 Median:59.00 stddev:0.74 (1.3%) stddev-sans-first:0.78 19:46:21 INFO - PROCESS | 30941 | Values: 59.0 60.0 58.0 58.0 59.0 58.0 59.0 59.0 59.0 60.0 19:46:21 INFO - PROCESS | 30941 | 19:46:21 INFO - PROCESS | 30941 | [#10] stanford-crypto-aes Cycles:10 Average:74.40 Median:74.50 stddev:2.22 (3.0%) stddev-sans-first:2.30 19:46:21 INFO - PROCESS | 30941 | Values: 73.0 80.0 72.0 73.0 73.0 75.0 75.0 74.0 74.0 75.0 19:46:21 INFO - PROCESS | 30941 | 19:46:21 INFO - PROCESS | 30941 | [#11] stanford-crypto-ccm Cycles:10 Average:120.20 Median:122.00 stddev:5.61 (4.6%) stddev-sans-first:5.63 19:46:21 INFO - PROCESS | 30941 | Values: 115.0 120.0 126.0 124.0 113.0 116.0 120.0 114.0 129.0 125.0 19:46:21 INFO - PROCESS | 30941 | 19:46:21 INFO - PROCESS | 30941 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.00 Median:159.50 stddev:5.21 (3.3%) stddev-sans-first:5.52 19:46:21 INFO - PROCESS | 30941 | Values: 160.0 173.0 156.0 159.0 160.0 158.0 164.0 155.0 157.0 158.0 19:46:21 INFO - PROCESS | 30941 | 19:46:21 INFO - PROCESS | 30941 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.40 Median:67.50 stddev:2.50 (3.7%) stddev-sans-first:2.60 19:46:21 INFO - PROCESS | 30941 | Values: 67.0 71.0 67.0 67.0 68.0 74.0 67.0 67.0 66.0 70.0 19:46:21 INFO - PROCESS | 30941 | -------- Summary: end -------- 19:46:21 INFO - PROCESS | 30941 | 19:46:22 INFO - TEST-INFO | 30941: exit 0 19:46:22 INFO - TEST-OK | kraken | took 60141ms 19:46:22 INFO - SUITE-END | took 1168s 19:46:22 INFO - Completed test suite (00:19:28) 19:46:22 INFO - javascript benchmark 19:46:23 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3301.9339613207735, 3349.9832500837524, 3366.4277072897603, 3404.8808291709797, 3404.880829170981, 5534.723263836802, 5554.1946417769395, 5572.0, 5595.664260144395, 5629.0, 5520.227168196456, 5581.609287349887, 5598.944010559893, 5599.524040456556, 5606.607537472379, 5046.435604962455, 5117.692938423706, 5155.278261043457, 5155.484451554833, 5183.118869792144, 5023.196288593826, 5130.819911420375, 5216.8174113906025, 5256.763445644936, 5294.788208471676, 5051.166557518023, 5075.264086707425, 5118.4113826909825, 5216.347956505437, 5233.241180028913, 5092.6180536459915, 5101.642884998052, 5109.770060347256, 5111.463296353903, 5149.124648809711, 4985.90028199434, 5045.798168073273, 5075.670081444694, 5089.872753181163, 5096.770645320932, 5334.786608535654, 5375.11310633745, 5472.972635136839, 5497.587680923947, 5524.66851988882, 5909.054551271819, 5947.940520594782, 5951.821445356646, 5952.672603006876, 5953.672548009858, 5849.85375365615, 5939.9109013364405, 5946.108083787423, 6011.789587364465, 6013.639181649115, 5513.862153446155, 5557.472040156179, 5596.356419011784, 5677.233573467612, 5680.403557626431, 5999.9100013498955, 6016.548758843104, 6068.969655151696, 6075.605085669417, 6078.878422431527, 5777.45114214149, 5839.328477225174, 5844.386339434383, 5844.444777746107, 5852.4147585241135, 5953.970230148821, 6002.6698531580305, 6002.909956350658, 6017.0, 6017.759289628366, 5941.138534912414, 5942.227510423703, 5945.375735547792, 5953.255843019622, 5960.880782384328, 5814.331351894586, 5893.970530147408, 5941.405859414111, 5991.7603295867675, 6001.729922153426, 4546.272596384562, 4569.0, 4570.65720070996, 4575.336576196433, 4601.539846015438, 4110.979445102756, 4128.814203360856, 4136.255474014706, 4144.647704945053, 4149.211649786531, 5635.154726791015, 5703.7148142592705, 5715.942840571541, 5734.483896449339, 5749.9425005750245, 5774.509166720792, 5948.910766338508, 6059.151718759377, 6067.787627433018, 6072.301685306246, 5568.0, 5692.288463942007, 5704.11586204139, 5704.71476426177, 5706.686132262766, 5079.74601269935, 5155.9742201288755, 5156.123459011902, 5175.534201921845, 5190.506901844319, 6103.35914728956, 6159.476444502178, 6167.907481387782, 6174.289956655042, 6180.412860778219, 5918.3489816121055, 5965.075413310944, 5972.074328479092, 5980.192673988956, 6022.5784195105925, 6118.632882027093, 6120.508083830972, 6123.649268312112, 6130.750073614967, 6155.1382806406245, 5840.737166827418, 5846.883062338815, 5849.766009359578, 5862.677552734641, 5874.060150375919, 5802.970985145047, 5901.675407852437, 5940.405959404025, 5952.285725712769, 5968.865915476045, 5856.970715146397, 5858.209141765807, 5908.970455147697, 5910.497607703393, 5918.674472904032, 5823.679697616672, 5844.3571207168025, 5845.707714614167, 5860.9450298946595, 5873.060310350324, 5506.0, 5683.318001839806, 5759.769609215752, 5761.049426844524, 5768.653880767168, 5851.736671849862, 5852.4147585241135, 5882.5293976480925, 5890.52875769946, 5945.137954996588, 5766.826995190151, 5770.596058275881, 5781.508571771278, 5783.3638299787835, 5784.161296612052], "value": 5513.475443012029, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [648.672420427684, 657.0800878769721, 671.4359937652371, 704.3027402871156, 731.7073170731707, 39964.0, 40090.599094009085, 40424.0, 40707.59292407075, 40728.59271407289, 42249.36625950613, 43194.784026079906, 43307.78346108273, 43345.78327108368, 43433.0, 8741.344399170055, 8902.332325075613, 8968.372213945026, 8974.641014359418, 8987.460752354848, 8822.161894620032, 8948.776280592972, 8958.059403762609, 8958.86561701575, 8965.775855603597, 9081.318901082444, 9196.12636799503, 9201.631934722604, 9224.538773061353, 9262.861057084148, 9040.593173307185, 9080.954595227015, 9107.271418286555, 9154.771130721785, 9156.359054866096, 9051.411658242194, 9118.86321705175, 9164.954175229148, 9189.264858811279, 9203.53982300889, 43599.34600980988, 43812.3428148578, 44004.77997609991, 44404.777976109915, 44410.333844992354, 3476.4263896457055, 3598.712103031751, 3684.410494320896, 3701.370766969622, 3838.405047217686, 29751.0, 29951.850240748874, 29997.70002299993, 30162.547561786592, 30283.242918926982, 4335.479742430897, 4429.335599660045, 4550.977245113786, 4572.908541829145, 4713.740744259065, 327641.0, 332114.0, 334122.0, 334157.0, 334324.99999999756, 40868.0, 41351.379729304084, 41449.171016580105, 66135.0, 67730.3226967734, 40380.394294085614, 40479.7976010124, 40696.593034069876, 40700.59299406968, 40732.79633601813, 17092.743608845878, 17239.3966211182, 17252.396166134375, 17287.481375558753, 17296.91351543234, 13942.093763905517, 13975.580732578039, 13978.370973306226, 14067.507637232648, 14137.646558835906, 9617.374870633386, 9677.338856586757, 9684.903150968541, 9728.319017668695, 9797.314188006914, 3754.662080412776, 3782.8108594570162, 3806.733528652968, 3830.3105441020325, 3865.072382628149, 1131.8641762988493, 1207.3661327802974, 1230.4585982167816, 1234.962951111468, 1287.016683364984, 32388.83805580957, 32920.341593168, 33416.364809209255, 33436.331273374395, 34379.828100859835, 1234.6172686467223, 1251.2304932466468, 1300.2523548959198, 1309.9803502947464, 1313.4352228541818, 17012.404565840137, 17059.573510662332, 17528.386506472467, 17597.560060998323, 17759.467215983543, 512743.0, 575000.0, 578903.0, 579748.0, 601264.0, 55891.72054139703, 56123.0, 56362.0, 56526.43473565212, 56660.43339566634, 1528.9068316154226, 1544.1661502788593, 1558.0397245234146, 1572.9764053539207, 1619.093307747665, 29774.851125744233, 30564.0, 30697.53953690652, 30890.382192355577, 30959.535606966365, 52996.0, 53283.46716532785, 53351.733241333546, 53665.0, 53714.0, 469685.0, 470433.0, 473531.0, 473896.0, 475772.0, 30371.39257214799, 30577.847110764305, 30666.386672266875, 30949.381012379177, 31247.687523125387, 47727.28409073797, 48030.0, 48210.758946205046, 48309.0, 48814.267785983946, 41379.379309309785, 41601.583984160985, 41606.0, 42676.359854601586, 42955.14089718251, 40054.39918401168, 40861.0, 41080.794596026826, 41430.0, 42068.94827629334, 42203.788981054895, 42551.7872410636, 42959.57040429681, 43048.0, 43173.3523997134, 34653.306933861684, 35424.645753542136, 35578.8221058893, 35936.28127437489, 36457.81771091127, 28116.85941570279, 28621.0, 28798.0, 28906.855465722536, 29029.41941161207], "value": 19684.674403011653, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [412.53795748761394, 415.347903791048, 417.45105186679496, 423.6568379612514, 431.2237971651027, 14770.556883293491, 18744.718829217574, 19181.32865349713, 19367.418977430665, 19393.321233756822, 18343.633127337478, 18704.251829926787, 18826.24695012198, 19448.611027779436, 19616.509587260327, 5425.891482170354, 5634.9718251408785, 6030.608010479326, 6042.335343112254, 6052.9394706053035, 5613.9157912631135, 5643.181738647893, 5660.235868157787, 5664.150377443396, 5666.0, 5551.528120109796, 5625.5218306444, 5803.303603567578, 5833.504152147073, 5859.0625499920025, 5815.47660710536, 5818.883622327551, 5822.272215973004, 5842.5618078644275, 5850.707464626752, 5204.921926171072, 5496.725163741797, 5501.312335958005, 5516.14499752539, 5717.142428635696, 12980.026498012687, 13125.737485250336, 14779.630509237248, 22571.77428225713, 22799.088036478523, 2417.6857008588945, 2541.4281786598053, 2585.935351616206, 2586.6646815057297, 2605.3486628342916, 10154.9492252539, 10163.390196588229, 10180.287379883412, 10290.794184116276, 11735.823962640481, 1951.9024048797503, 1993.7707163676073, 1998.99000504998, 2003.5291706448972, 2014.4653652455352, 46916.0, 70752.646236769, 78511.607441963, 80710.0, 83071.5846420764, 10834.349939003685, 11310.208285420105, 11391.202615816814, 11412.714682133013, 11658.591949281734, 15561.610959726097, 15648.295826687827, 15679.529614111594, 15830.841691583168, 15856.682866342608, 8490.490570565786, 8575.228229459253, 8627.309815214894, 8712.21590056898, 8717.302615790848, 8487.787805304793, 8537.103604121601, 8666.956665216634, 8677.56612169389, 8849.60176792046, 4745.311929770233, 4805.159097158054, 4841.927371089437, 4976.576990955737, 5115.846524604268, 2021.4542073640034, 2097.1401725292862, 2109.135254545629, 2114.714513540683, 2210.5026369067155, 1014.9644762433279, 1061.4957894999814, 1089.727568107973, 1102.8456016157745, 1156.7455159864817, 18985.90507047456, 19113.044347782554, 19488.0, 19820.50448738793, 20206.09072591737, 1079.5735684404774, 1087.7770057138268, 1134.189054825787, 1145.8796826333282, 1176.923499972499, 10558.472076396149, 10952.959468850446, 10960.013598776148, 10989.546553147435, 11147.996680298813, 363335.0, 366360.0, 372747.0, 372833.0, 374832.0, 57354.0, 59437.70281148653, 84331.5783421079, 99672.5016374928, 100388.49805750925, 1126.983095253572, 1136.3749937534487, 1142.7485953090306, 1150.7065698246893, 1160.5821904114512, 17425.651486970444, 17540.82459175392, 17828.0, 18514.0, 18898.055097245357, 40048.1990360197, 40245.195096097326, 42088.0, 42243.0, 42493.0, 53583.19625205703, 57959.0, 58063.0, 58827.4117258839, 58941.410585895304, 8223.383246256435, 8612.827743445221, 8661.263792577449, 8700.651973921225, 8826.029136795076, 10698.62554810578, 12128.272303661808, 12161.087918405978, 12173.57392491294, 12196.146269761031, 10524.52639631203, 10540.631077912236, 10686.412247326472, 10738.946305268424, 10866.836997444887, 10670.30643008202, 10689.412082335546, 10751.247412681038, 10952.178586605876, 11267.718307042061, 11101.16741244426, 11261.831072534082, 11405.429728513707, 11418.486168122288, 11525.88474115248, 8407.747767566983, 8448.619812108593, 8602.39783215169, 8696.956515217384, 8808.11918808114, 9906.0, 10565.63020294286, 10609.9469502652, 10642.574297028032, 10833.02502774754], "value": 9125.54760258749, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1502.496663617688, 1520.0347779160234, 1697.3889399816064, 1856.33172058059, 1867.0851282871388, 7140.428765698732, 7653.272939070794, 7853.607319634017, 8102.0, 8125.187481251872, 7840.607969601526, 7876.094249161348, 7978.601069946509, 7980.960095199531, 7990.92009079909, 2282.6804247405375, 2293.5068960173558, 2299.4711216420233, 2300.9769902301014, 2303.5738388398117, 2210.9447263818374, 2234.0616940884865, 2257.559775843711, 2260.028187879211, 2269.2851751698245, 2355.9175428859994, 2381.368937231635, 2399.6520504526834, 2400.0399840063938, 2400.3999000249937, 2303.838731288802, 2316.293530473205, 2320.1879342230254, 2324.418895276181, 2364.7398786133513, 2322.15241436876, 2328.557574060923, 2331.3239160643393, 2350.612148995414, 2358.716953965518, 8170.060443049066, 8273.586320684002, 8278.751637450887, 8283.544405057719, 8304.335653147733, 5124.231365295198, 5168.250603662448, 5181.559567436735, 5190.273361729361, 5201.29782479368, 3165.2878102427, 3182.554442378069, 3293.4730443128983, 3326.234965957843, 3327.617324007746, 1122.691259903525, 1135.250734515216, 1141.081429449293, 1165.6153469355093, 1176.8587769467633, 11064.446777661085, 11125.610603628835, 11138.610148644759, 11168.497417616309, 11234.943825280903, 4385.9692972151515, 4406.735595864258, 4467.530909254547, 4480.775961201927, 4501.144782491317, 9643.035696430301, 9643.228541716646, 9668.129868311886, 9705.902940970642, 9717.708468745948, 5097.923531147036, 5140.254663073833, 5180.844574662766, 5189.351331083614, 5191.9480805192225, 4164.125533637909, 4601.079784043205, 4672.252439609646, 4778.331033655291, 4780.928286075712, 4085.080856807195, 4136.607022332873, 4149.190907773016, 4200.348945913388, 4201.747895126302, 1339.4575197045017, 1347.2455424961856, 1359.4969861151437, 1362.3256488038485, 1362.6525236064938, 1003.2826529031777, 1017.1964148322742, 1025.103034844511, 1036.9325993810528, 1047.8847326794046, 5491.148871924858, 5674.659520428788, 5674.858128546737, 5739.885202295931, 5773.566982476331, 448.38571157513763, 452.5135479359636, 453.4400015980262, 454.3548161610521, 463.2449107954081, 3907.29668659644, 4124.587541245912, 4190.0, 4196.769177695256, 4214.220369231702, 9700.75748106303, 9714.708558743248, 9780.315377923476, 9797.167240784613, 9804.313698041211, 9345.0, 9627.0, 9684.854727179098, 9710.6115755369, 9713.271504637181, 7403.629818509053, 7581.090269167735, 7622.313991740659, 7638.0, 7651.311381975649, 5545.223668686306, 5561.972190139023, 5679.0, 5781.768729250783, 5849.795257165979, 8843.425177363451, 8938.553072346487, 9021.864672029793, 9082.863757043782, 9097.909020909707, 8785.428947118417, 8891.377603567687, 9208.907910920805, 9213.631454741735, 9248.0, 6376.330485299162, 7149.177844547736, 7237.746678866214, 7476.289752473506, 7690.077190737147, 7732.497387669783, 7801.0, 7808.336291415066, 7822.295993360625, 7879.881801773093, 6994.33553812387, 7164.355208031302, 7208.27917208275, 7222.458315626454, 7309.707611695472, 7123.7506687265695, 7163.570185788869, 7207.927920720936, 7256.96371518139, 7290.416766658761, 6530.67346632657, 6691.364320389555, 6722.529422940347, 6734.090897728744, 6741.494387921024, 4918.311436398979, 4966.230234313687, 5023.271625614192, 5024.773885175103, 5038.798448062036, 5004.549590536869, 5058.848234552969, 5068.315777370155, 5103.948960510347, 5144.871378215575], "value": 4383.050351671325, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [333.56281938155126, 339.9830008499574, 340.5623773451116, 343.68896148985175, 345.8858576669699, 6561.704723287446, 6667.899981500282, 6720.932790672092, 6731.596104233738, 6810.148731408574, 6535.738570457176, 6547.377999090078, 6625.668716564177, 6632.403083722464, 6638.336166383359, 4944.283078953549, 4993.176125939225, 5004.774785134659, 5009.524095210967, 5019.673721208128, 4997.725125118117, 4999.0, 5013.899722005558, 5020.698758074527, 5023.2214006829, 4930.781148483179, 4932.901341973158, 4953.257011448276, 4972.8508144755715, 4985.152524070917, 4819.927701084486, 4950.975245123769, 4967.05625931072, 4992.850214493571, 4996.925046124311, 4324.8486302979245, 4330.350447432878, 4338.631216346615, 4342.348647702838, 4343.087951530182, 6289.559730818844, 6294.0, 6378.0, 6382.553221274513, 6419.743210271584, 5845.801610669802, 5859.648421094748, 5884.146798714205, 5898.14476900847, 5919.1713160157615, 7001.719931202746, 7044.682989265495, 7052.294770522906, 7055.588882223525, 7063.576185428839, 4769.284607308897, 4793.880152996168, 4810.494898035726, 4845.466998630148, 4847.660663753539, 7142.607156606385, 7283.126024876996, 7285.490015698851, 7288.234735352765, 7366.742164024287, 4738.976305118521, 4771.498992605796, 4782.187028205213, 4825.914169311947, 4827.744786355573, 4887.511248875084, 4890.486498917634, 4897.510248975074, 4899.706017638953, 4901.779419926112, 5726.0838265877255, 5743.8851222976145, 5745.425457454221, 5761.049426844607, 5767.971160144256, 7032.859342813217, 7032.8945065824055, 7054.576725396492, 7071.0, 7083.0, 1709.3248166974224, 1743.4246698589436, 1746.6594014167115, 1756.1394916490829, 1770.4334612924, 1135.6138912769698, 1158.623447379605, 1162.4071723421116, 1168.5384273212035, 1177.682025853015, 6695.0, 6712.664366781642, 6724.630145342053, 6728.865422691519, 6736.8989465158065, 7126.750563730245, 7134.429245660334, 7158.92841071593, 7168.354848063699, 7177.4258059355125, 6689.832754181184, 6692.297308782605, 6693.799186024427, 6698.732050718014, 6700.463962882957, 3841.2317536492815, 3904.2386734586485, 3912.0415498203124, 3941.1329507508303, 3953.2291203215673, 7474.065741782278, 7548.584827834522, 7555.508891922117, 7561.962190189124, 7580.886286705704, 7392.519486233377, 7403.888941665879, 7417.925820741723, 7450.96274518624, 7472.962635186789, 7627.351675107567, 7660.425468089916, 7663.348615367756, 7668.654910528928, 7690.230976902265, 7175.712971481291, 7316.0, 7348.1182258129365, 7367.594782287026, 7428.665710042953, 7307.890381644173, 7319.634018298957, 7322.707091716272, 7328.633568321456, 7337.669804858688, 7683.654235559525, 7713.151553329017, 7721.53670779755, 7723.150453450228, 7724.420668450001, 4804.639652026042, 4836.12949669063, 4846.684965477232, 4852.272159176152, 4874.975625121851, 7079.327463890922, 7382.114146302478, 7399.408047356306, 7406.518576292524, 7415.8146046349275, 7159.284071592799, 7172.246914073947, 7174.246704096204, 7192.280771922766, 7194.460415468756, 7107.857842843011, 7108.537945033556, 7147.64261786919, 7152.213256541881, 7154.320339567733, 6950.339717726808, 6960.79117626472, 6999.440044796506, 7025.473089518408, 7039.401650859734, 7050.788476345718, 7176.102987126609, 7193.964030179815, 7216.855662886608, 7226.494145409771, 6932.44540436774, 6960.651967401711, 6999.47503937217, 7022.789316320519, 7023.438124950094], "value": 5277.372041774446, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [671.2884342596844, 698.6402002968472, 784.9764507064788, 838.8406202821463, 852.5481494807752, 15316.081035137886, 15429.0, 15512.84487155128, 15516.612084697888, 15546.689066218669, 12654.0, 12715.809262861065, 12796.0, 12888.226706397623, 12982.22106673598, 745.2100773180446, 883.1433509495779, 889.7864512516982, 892.9508877011762, 894.2622336572322, 885.3758100539137, 888.8844450221494, 889.8665200219987, 890.1054440287535, 890.7060669978891, 932.4778124250407, 933.2207606648457, 935.5836652689555, 937.6108914800384, 937.9202767764748, 920.052346083535, 923.1368670293264, 926.5969303353063, 930.0885132570052, 931.0549791961165, 690.2338404371144, 691.9584824910521, 692.7159864455599, 693.0955103589813, 694.0734119949873, 14419.279036048156, 14449.49426770058, 14507.347169377297, 14524.782128268085, 14633.414663413558, 12596.496140154382, 12772.680682982907, 12850.228986260854, 12865.194272399553, 13016.869831301756, 10937.56249750009, 11003.944980275128, 11047.171462140292, 11276.548938042468, 11360.204785665006, 3833.118382771978, 3882.5729169791302, 3890.4164375343926, 3902.083010492532, 4023.839046438139, 55905.72047139779, 56397.0, 56434.71782641102, 56869.0, 56925.43074569243, 10191.898081019095, 10284.845727314096, 10609.310394824312, 10712.625987537403, 10718.660167479065, 21211.893940530197, 21307.78692213058, 21344.679829802564, 21365.35903922885, 21371.25200618002, 8537.74386768398, 8727.91272087271, 8868.15752503511, 8914.242289405343, 8933.731988040368, 4834.661573689878, 4863.708177509361, 4869.0, 4937.23472861707, 5019.824306149268, 3574.267275208576, 3586.103474131467, 3586.28274345132, 3606.549181352331, 3614.493970844084, 649.1139594453631, 659.9274079851212, 669.7622344067884, 676.046774048599, 685.0614657918584, 702.5644100657523, 711.0969069281983, 714.0645754062091, 726.9418446524265, 736.9963150184215, 9677.032296770267, 9740.220782337537, 9843.261755368376, 9876.45679487635, 10028.997100290058, 639.1531221132019, 685.6297599296424, 688.9837489702649, 720.1646090534954, 738.092146659601, 4205.201011807747, 4471.977640111843, 4485.641148708096, 4547.545245475426, 4597.95402045982, 60442.0, 62229.0, 62431.37568624347, 62836.68581657062, 62931.05603415953, 54888.72555637196, 56565.15152272719, 57023.71488142533, 57278.427215728145, 58281.70859145762, 49869.501304987214, 50001.74999124981, 50003.749981249865, 50997.23504147441, 51258.0, 8597.957010214908, 8756.649734010569, 8759.255463285692, 8804.383693141419, 8915.509646969478, 36336.81831590931, 37066.444003339435, 37162.25675486421, 37426.064348391505, 37696.43455348227, 42357.788211058745, 44652.55347446484, 48784.0, 49408.25887611761, 49718.50281497283, 10762.19283553721, 10806.583343645589, 10861.578189105672, 11114.05530529914, 11254.718632034264, 11446.599369022044, 11458.77082458363, 11522.827157592475, 11701.122415818678, 11977.281363117892, 11445.885541144815, 11509.194356394972, 11724.58963936258, 11739.354335511629, 12390.752184956431, 10614.027270296618, 10707.839382409114, 11073.667789966314, 11231.045361144068, 11473.598424055119, 10438.321509101885, 10714.089302409382, 10809.297395669257, 11044.834327484934, 11457.828132578185, 9246.214071803703, 9350.812983740423, 10506.632267870587, 10689.9465502672, 10966.506507207354, 10316.813566439956, 10773.461326933466, 11029.944850276019, 11049.558017679203, 11100.833487497532], "value": 6789.453112508121, "unit": "score"}], "name": "dromaeo_css", "value": 7333.5344430987325, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 111.0, 102.0, 109.0, 112.0, 111.0, 103.0, 112.0, 112.0, 111.0], "value": 109.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 134.0, 159.0, 170.0, 128.0, 162.0, 156.0, 125.0, 190.0, 133.0], "value": 150.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 163.0, 163.0, 164.0, 173.0, 162.0, 162.0, 163.0, 163.0], "value": 164.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 74.0, 183.0, 76.0, 76.0, 73.0, 77.0, 172.0, 76.0], "value": 95.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 147.0, 99.0, 93.0, 92.0, 144.0, 92.0, 92.0, 146.0], "value": 109.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 119.0, 118.0, 118.0, 117.0, 118.0, 118.0, 117.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 154.0, 147.0, 147.0, 147.0, 148.0, 147.0, 147.0, 147.0, 147.0], "value": 147.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 96.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 57.0, 57.0, 57.0, 61.0, 60.0, 77.0, 54.0, 55.0], "value": 58.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 58.0, 58.0, 59.0, 58.0, 59.0, 59.0, 59.0, 60.0], "value": 58.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 80.0, 72.0, 73.0, 73.0, 75.0, 75.0, 74.0, 74.0, 75.0], "value": 74.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 120.0, 126.0, 124.0, 113.0, 116.0, 120.0, 114.0, 129.0, 125.0], "value": 120.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 173.0, 156.0, 159.0, 160.0, 158.0, 164.0, 155.0, 157.0, 158.0], "value": 160.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 71.0, 67.0, 67.0, 68.0, 74.0, 67.0, 67.0, 66.0, 70.0], "value": 68.4, "unit": "score"}], "name": "kraken", "value": 1530.4000000000005, "alertThreshold": 2.0}]} 19:46:23 INFO - Return code: 0 19:46:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 19:46:23 ERROR - # TBPL SUCCESS # 19:46:23 INFO - Running post-action listener: _resource_record_post_action 19:46:23 INFO - Running post-run listener: _resource_record_post_run 19:46:24 INFO - Total resource usage - Wall time: 1186s; CPU: 13.0%; Read bytes: 266240; Write bytes: 401305600; Read time: 20; Write time: 243588 19:46:24 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 148025344; Read time: 0; Write time: 106044 19:46:24 INFO - run-tests - Wall time: 1170s; CPU: 13.0%; Read bytes: 266240; Write bytes: 253280256; Read time: 20; Write time: 137544 19:46:24 INFO - Running post-run listener: _upload_blobber_files 19:46:24 INFO - Blob upload gear active. 19:46:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:46:24 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 19:46:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:46:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:46:24 INFO - (blobuploader) - INFO - Open directory for files ... 19:46:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:46:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:46:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:46:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:46:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:46:25 INFO - (blobuploader) - INFO - Done attempting. 19:46:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:46:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:46:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:46:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:46:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:46:26 INFO - (blobuploader) - INFO - Done attempting. 19:46:26 INFO - (blobuploader) - INFO - Iteration through files over. 19:46:26 INFO - Return code: 0 19:46:26 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:46:26 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:46:26 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/660e99a2c3212a84ad9725df9388bc5c8327abac34b73e0dfb563494fd0d07033be385bb826434d1019dbe608c98e9da4b5d73cd04233c86577a292398b71ee9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/588ded1bb1de9a1447332517db2d908884a97bafc83471b16d06c6714d062bf01b4d4d20e8bfd38f82d4a040bc0460c5ca451246667ed86174603fe984a8557c"} 19:46:26 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:46:26 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:46:26 INFO - Contents: 19:46:26 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/660e99a2c3212a84ad9725df9388bc5c8327abac34b73e0dfb563494fd0d07033be385bb826434d1019dbe608c98e9da4b5d73cd04233c86577a292398b71ee9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/588ded1bb1de9a1447332517db2d908884a97bafc83471b16d06c6714d062bf01b4d4d20e8bfd38f82d4a040bc0460c5ca451246667ed86174603fe984a8557c"} 19:46:26 INFO - Running post-run listener: copy_logs_to_upload_dir 19:46:26 INFO - Copying logs to upload dir... 19:46:26 INFO - mkdir: /builds/slave/test/build/upload/logs 19:46:26 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.695325 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-05-23 19:46:25.027379) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-23 19:46:25.031092) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1464056559.558668-1230769119 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/660e99a2c3212a84ad9725df9388bc5c8327abac34b73e0dfb563494fd0d07033be385bb826434d1019dbe608c98e9da4b5d73cd04233c86577a292398b71ee9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/588ded1bb1de9a1447332517db2d908884a97bafc83471b16d06c6714d062bf01b4d4d20e8bfd38f82d4a040bc0460c5ca451246667ed86174603fe984a8557c"} build_url:https://queue.taskcluster.net/v1/task/SlT1HGtRS6Sh3pQGcr3yhA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011446 build_url: 'https://queue.taskcluster.net/v1/task/SlT1HGtRS6Sh3pQGcr3yhA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/660e99a2c3212a84ad9725df9388bc5c8327abac34b73e0dfb563494fd0d07033be385bb826434d1019dbe608c98e9da4b5d73cd04233c86577a292398b71ee9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/588ded1bb1de9a1447332517db2d908884a97bafc83471b16d06c6714d062bf01b4d4d20e8bfd38f82d4a040bc0460c5ca451246667ed86174603fe984a8557c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-23 19:46:25.056212) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 19:46:25.056540) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1464056559.558668-1230769119 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004495 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 19:46:25.140604) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-23 19:46:25.140924) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-23 19:46:25.141211) ========= ========= Total master_lag: 0.17 =========