builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-022 starttime: 1461376518.13 results: success (0) buildid: 20160422163023 builduid: 990e57531c33475a8544e1a09f96fb15 revision: fb0d7b82c072b81ec2d2551dd832f48c287527f9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-22 18:55:18.131919) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-22 18:55:18.132461) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-22 18:55:18.132803) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-22 18:55:18.167675) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 18:55:18.168175) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1461370729.204741-1070592121 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-22 18:55:18-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 82.1M=0s 2016-04-22 18:55:18 (82.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.091262 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 18:55:18.286509) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 18:55:18.286961) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1461370729.204741-1070592121 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017934 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 18:55:18.341792) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-22 18:55:18.342197) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev fb0d7b82c072b81ec2d2551dd832f48c287527f9 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev fb0d7b82c072b81ec2d2551dd832f48c287527f9 --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=9c43b49b387003dc8f5b4e5c000001c4-1461370729.204741-1070592121 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-22 18:55:18,493 truncating revision to first 12 chars 2016-04-22 18:55:18,493 Setting DEBUG logging. 2016-04-22 18:55:18,493 attempt 1/10 2016-04-22 18:55:18,493 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/fb0d7b82c072?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-22 18:55:19,574 unpacking tar archive at: mozilla-inbound-fb0d7b82c072/testing/mozharness/ program finished with exit code 0 elapsedTime=1.433023 ========= master_lag: 0.13 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-22 18:55:19.909843) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-22 18:55:19.910224) ========= script_repo_revision: fb0d7b82c072b81ec2d2551dd832f48c287527f9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-22 18:55:19.910765) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-22 18:55:19.911120) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-22 18:55:19.925601) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-04-22 18:55:19.926132) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 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-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=9c43b49b387003dc8f5b4e5c000001c4-1461370729.204741-1070592121 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:55:20 INFO - MultiFileLogger online at 20160422 18:55:20 in /builds/slave/test 18:55:20 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 18:55:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:55:20 INFO - {'append_to_log': False, 18:55:20 INFO - 'base_work_dir': '/builds/slave/test', 18:55:20 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 18:55:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:55:20 INFO - 'branch': 'Mozilla-Inbound', 18:55:20 INFO - 'buildbot_json_path': 'buildprops.json', 18:55:20 INFO - 'config_files': ('talos/linux_config.py',), 18:55:20 INFO - 'default_actions': ('clobber', 18:55:20 INFO - 'read-buildbot-config', 18:55:20 INFO - 'download-and-extract', 18:55:20 INFO - 'populate-webroot', 18:55:20 INFO - 'create-virtualenv', 18:55:20 INFO - 'install', 18:55:20 INFO - 'run-tests'), 18:55:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:55:20 INFO - 'download_minidump_stackwalk': True, 18:55:20 INFO - 'download_symbols': 'ondemand', 18:55:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:55:20 INFO - 'tooltool.py': '/tools/tooltool.py', 18:55:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:55:20 INFO - '/tools/misc-python/virtualenv.py')}, 18:55:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:55:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:55:20 INFO - 'installer_path': 'installer.exe', 18:55:20 INFO - 'log_level': 'info', 18:55:20 INFO - 'log_name': 'talos', 18:55:20 INFO - 'log_to_console': True, 18:55:20 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:55:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:55:20 INFO - 'opt_config_files': (), 18:55:20 INFO - 'pip_index': False, 18:55:20 INFO - 'sps_profile': False, 18:55:20 INFO - 'sps_profile_interval': 0, 18:55:20 INFO - 'suite': 'dromaeojs-e10s', 18:55:20 INFO - 'system_bits': '32', 18:55:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:55:20 INFO - 'title': 'talos-linux64-ix-022', 18:55:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:55:20 INFO - 'use_talos_json': True, 18:55:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:55:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:55:20 INFO - 'work_dir': 'build'} 18:55:20 INFO - ##### 18:55:20 INFO - ##### Running clobber step. 18:55:20 INFO - ##### 18:55:20 INFO - Running pre-action listener: _resource_record_pre_action 18:55:20 INFO - Running main action method: clobber 18:55:20 INFO - rmtree: /builds/slave/test/build 18:55:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:55:20 INFO - Running post-action listener: _resource_record_post_action 18:55:20 INFO - ##### 18:55:20 INFO - ##### Running read-buildbot-config step. 18:55:20 INFO - ##### 18:55:20 INFO - Running pre-action listener: _resource_record_pre_action 18:55:20 INFO - Running main action method: read_buildbot_config 18:55:20 INFO - Using buildbot properties: 18:55:20 INFO - { 18:55:20 INFO - "project": "", 18:55:20 INFO - "product": "firefox", 18:55:20 INFO - "script_repo_revision": "production", 18:55:20 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 18:55:20 INFO - "repository": "", 18:55:20 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 18:55:20 INFO - "buildid": "20160422163023", 18:55:20 INFO - "pgo_build": "True", 18:55:20 INFO - "basedir": "/builds/slave/test", 18:55:20 INFO - "buildnumber": 499, 18:55:20 INFO - "slavename": "talos-linux64-ix-022", 18:55:20 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 18:55:20 INFO - "platform": "ubuntu64_hw", 18:55:20 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 18:55:20 INFO - "branch": "mozilla-inbound", 18:55:20 INFO - "repo_path": "integration/mozilla-inbound", 18:55:20 INFO - "revision": "fb0d7b82c072b81ec2d2551dd832f48c287527f9", 18:55:20 INFO - "stage_platform": "linux64-pgo", 18:55:20 INFO - "builduid": "990e57531c33475a8544e1a09f96fb15", 18:55:20 INFO - "slavebuilddir": "test" 18:55:20 INFO - } 18:55:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/dXMD-g5HS_6V2K5vuC86uQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 18:55:20 INFO - Running post-action listener: _resource_record_post_action 18:55:20 INFO - ##### 18:55:20 INFO - ##### Running download-and-extract step. 18:55:20 INFO - ##### 18:55:20 INFO - Running pre-action listener: _resource_record_pre_action 18:55:20 INFO - Running main action method: download_and_extract 18:55:20 INFO - mkdir: /builds/slave/test/build/tests 18:55: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')]} 18:55:20 INFO - https://queue.taskcluster.net/v1/task/dXMD-g5HS_6V2K5vuC86uQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 18:55:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dXMD-g5HS_6V2K5vuC86uQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 18:55:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dXMD-g5HS_6V2K5vuC86uQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 18:55:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dXMD-g5HS_6V2K5vuC86uQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 18:55:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dXMD-g5HS_6V2K5vuC86uQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 18:55:23 INFO - Downloaded 1361 bytes. 18:55:23 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 18:55:23 INFO - Using the following test package requirements: 18:55:23 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 18:55:23 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:55:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:55:23 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:55:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 18:55:23 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:55:23 INFO - u'jsshell-linux-x86_64.zip'], 18:55:23 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:55:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:55:23 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 18:55:23 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:55:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:55:23 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:55:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:55:23 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:55:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:55:23 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:55:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:55:23 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:55: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')]} 18:55:23 INFO - https://queue.taskcluster.net/v1/task/dXMD-g5HS_6V2K5vuC86uQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:55:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dXMD-g5HS_6V2K5vuC86uQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 18:55:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dXMD-g5HS_6V2K5vuC86uQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 18:55:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dXMD-g5HS_6V2K5vuC86uQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 18:55:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dXMD-g5HS_6V2K5vuC86uQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:55:24 INFO - Downloaded 23858096 bytes. 18:55:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:55:24 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 18:55:26 INFO - Return code: 0 18:55:26 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 18:55:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:55:26 INFO - https://queue.taskcluster.net/v1/task/dXMD-g5HS_6V2K5vuC86uQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:55:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dXMD-g5HS_6V2K5vuC86uQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 18:55:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dXMD-g5HS_6V2K5vuC86uQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 18:55:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dXMD-g5HS_6V2K5vuC86uQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 18:55:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dXMD-g5HS_6V2K5vuC86uQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:55:38 INFO - Downloaded 23858096 bytes. 18:55:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:55:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 18:55:40 INFO - Return code: 0 18:55:40 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')]} 18:55:40 INFO - https://queue.taskcluster.net/v1/task/dXMD-g5HS_6V2K5vuC86uQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 18:55:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dXMD-g5HS_6V2K5vuC86uQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 18:55:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dXMD-g5HS_6V2K5vuC86uQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 18:55:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dXMD-g5HS_6V2K5vuC86uQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 18:55:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dXMD-g5HS_6V2K5vuC86uQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 18:55:42 INFO - Downloaded 10840145 bytes. 18:55:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:55:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 18:55:42 INFO - Return code: 0 18:55:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:55:42 INFO - https://queue.taskcluster.net/v1/task/dXMD-g5HS_6V2K5vuC86uQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 18:55:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dXMD-g5HS_6V2K5vuC86uQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 18:55:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dXMD-g5HS_6V2K5vuC86uQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 18:55:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dXMD-g5HS_6V2K5vuC86uQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 18:55:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dXMD-g5HS_6V2K5vuC86uQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 18:55:43 INFO - Downloaded 58338750 bytes. 18:55:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dXMD-g5HS_6V2K5vuC86uQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 18:55:43 INFO - mkdir: /builds/slave/test/properties 18:55:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:55:43 INFO - Writing to file /builds/slave/test/properties/build_url 18:55:43 INFO - Contents: 18:55:43 INFO - build_url:https://queue.taskcluster.net/v1/task/dXMD-g5HS_6V2K5vuC86uQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 18:55:44 INFO - Running post-action listener: _resource_record_post_action 18:55:44 INFO - Running post-action listener: set_extra_try_arguments 18:55:44 INFO - ##### 18:55:44 INFO - ##### Running populate-webroot step. 18:55:44 INFO - ##### 18:55:44 INFO - Running pre-action listener: _resource_record_pre_action 18:55:44 INFO - Running main action method: populate_webroot 18:55:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:55:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:55:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:55:44 INFO - '--tppagecycles', 18:55:44 INFO - '7'], 18:55:44 INFO - 'tests': ['tsvgm']}}, 18:55:44 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:55:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:55:44 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:55:44 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:55:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:55:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:55:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:55:44 INFO - 'talos_options': ['--disable-e10s'], 18:55:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:55:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:55:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:55:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:55:44 INFO - 'talos_options': ['--disable-e10s'], 18:55:44 INFO - 'tests': ['damp', 'tps']}, 18:55:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:55:44 INFO - 'tests': ['damp', 'tps']}, 18:55:44 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:55:44 INFO - 'tests': ['dromaeo_dom']}, 18:55:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:55:44 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:55:44 INFO - 'tests': ['a11yr', 18:55:44 INFO - 'ts_paint', 18:55:44 INFO - 'tpaint', 18:55:44 INFO - 'sessionrestore', 18:55:44 INFO - 'sessionrestore_no_auto_restore', 18:55:44 INFO - 'tabpaint']}, 18:55:44 INFO - 'other-e10s': {'tests': ['a11yr', 18:55:44 INFO - 'ts_paint', 18:55:44 INFO - 'tpaint', 18:55:44 INFO - 'sessionrestore', 18:55:44 INFO - 'sessionrestore_no_auto_restore', 18:55:44 INFO - 'tabpaint']}, 18:55:44 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:55:44 INFO - 'ts_paint', 18:55:44 INFO - 'tpaint', 18:55:44 INFO - 'sessionrestore', 18:55:44 INFO - 'sessionrestore_no_auto_restore', 18:55:44 INFO - 'tabpaint']}, 18:55:44 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:55:44 INFO - 'ts_paint', 18:55:44 INFO - 'tpaint', 18:55:44 INFO - 'sessionrestore', 18:55:44 INFO - 'sessionrestore_no_auto_restore', 18:55:44 INFO - 'tabpaint']}, 18:55:44 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:55:44 INFO - 'tests': ['a11yr', 18:55:44 INFO - 'ts_paint', 18:55:44 INFO - 'tpaint', 18:55:44 INFO - 'sessionrestore', 18:55:44 INFO - 'sessionrestore_no_auto_restore', 18:55:44 INFO - 'tabpaint']}, 18:55:44 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:55:44 INFO - 'tests': ['a11yr', 18:55:44 INFO - 'ts_paint', 18:55:44 INFO - 'tpaint', 18:55:44 INFO - 'sessionrestore', 18:55:44 INFO - 'sessionrestore_no_auto_restore', 18:55:44 INFO - 'tabpaint']}, 18:55:44 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:55:44 INFO - 'tests': ['tsvgx', 18:55:44 INFO - 'tsvgr_opacity', 18:55:44 INFO - 'tart', 18:55:44 INFO - 'tscrollx', 18:55:44 INFO - 'cart']}, 18:55:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:55:44 INFO - 'tsvgr_opacity', 18:55:44 INFO - 'tart', 18:55:44 INFO - 'tscrollx', 18:55:44 INFO - 'cart']}, 18:55:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:55:44 INFO - 'talos_options': ['--disable-e10s'], 18:55:44 INFO - 'tests': ['tp5o']}, 18:55:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:55:44 INFO - 'tests': ['tp5o']}, 18:55:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:55:44 INFO - 'talos_options': ['--disable-e10s', 18:55:44 INFO - '--xperf_path', 18:55:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:55:44 INFO - 'tests': ['tp5n']}, 18:55:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:55:44 INFO - 'talos_options': ['--xperf_path', 18:55:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:55:44 INFO - 'tests': ['tp5n']}}, 18:55:44 INFO - 'talos.zip': {'path': '', 18:55:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:55:44 INFO - Running post-action listener: _resource_record_post_action 18:55:44 INFO - ##### 18:55:44 INFO - ##### Running create-virtualenv step. 18:55:44 INFO - ##### 18:55:44 INFO - Running pre-action listener: _resource_record_pre_action 18:55:44 INFO - Running main action method: create_virtualenv 18:55:44 INFO - Creating virtualenv /builds/slave/test/build/venv 18:55:44 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 18:55:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:55:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:55:44 INFO - Using real prefix '/usr' 18:55:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:55:45 INFO - Installing distribute.............................................................................................................................................................................................done. 18:55:47 INFO - Installing pip.................done. 18:55:47 INFO - Return code: 0 18:55:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:55:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:55:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:55:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:55:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:55:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:55:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:55:47 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 0x7fafc7fc5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c1e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ce95a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d78410>, '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 0x1d79310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d797a0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1461370729.204741-1070592121', '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 18:55:47 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 18:55:47 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 18:55:47 INFO - Using env: {'DISPLAY': ':0', 18:55:47 INFO - 'HOME': '/home/cltbld', 18:55:47 INFO - 'LANG': 'en_US.UTF-8', 18:55:47 INFO - 'LANGUAGE': 'en_US:en', 18:55:47 INFO - 'LOGNAME': 'cltbld', 18:55:47 INFO - 'MAIL': '/var/mail/cltbld', 18:55:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:55:47 INFO - 'MOZ_NO_REMOTE': '1', 18:55:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:55:47 INFO - 'NO_EM_RESTART': '1', 18:55:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:55:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:55:47 INFO - 'PWD': '/builds/slave/test', 18:55:47 INFO - 'SHELL': '/bin/bash', 18:55:47 INFO - 'SHLVL': '1', 18:55:47 INFO - 'TERM': 'linux', 18:55:47 INFO - 'TMOUT': '86400', 18:55:47 INFO - 'USER': 'cltbld', 18:55:47 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1461370729.204741-1070592121', 18:55:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:55:47 INFO - '_': '/tools/buildbot/bin/python'} 18:55:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:55:47 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 18:55:47 INFO - Cleaning up... 18:55:47 INFO - Return code: 0 18:55:47 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 18:55:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:55:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:55:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:55:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:55:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:55:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:55:47 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 0x7fafc7fc5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c1e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ce95a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d78410>, '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 0x1d79310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d797a0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1461370729.204741-1070592121', '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 18:55:47 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 18:55:47 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 18:55:47 INFO - Using env: {'DISPLAY': ':0', 18:55:47 INFO - 'HOME': '/home/cltbld', 18:55:47 INFO - 'LANG': 'en_US.UTF-8', 18:55:47 INFO - 'LANGUAGE': 'en_US:en', 18:55:47 INFO - 'LOGNAME': 'cltbld', 18:55:47 INFO - 'MAIL': '/var/mail/cltbld', 18:55:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:55:47 INFO - 'MOZ_NO_REMOTE': '1', 18:55:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:55:47 INFO - 'NO_EM_RESTART': '1', 18:55:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:55:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:55:47 INFO - 'PWD': '/builds/slave/test', 18:55:47 INFO - 'SHELL': '/bin/bash', 18:55:47 INFO - 'SHLVL': '1', 18:55:47 INFO - 'TERM': 'linux', 18:55:47 INFO - 'TMOUT': '86400', 18:55:47 INFO - 'USER': 'cltbld', 18:55:47 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1461370729.204741-1070592121', 18:55:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:55:47 INFO - '_': '/tools/buildbot/bin/python'} 18:55:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:55:47 INFO - Downloading/unpacking psutil>=0.7.1 18:55:47 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 18:55:47 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 18:55:47 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 18:55:47 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 18:55:47 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 18:55:47 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 18:55:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:55:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:55:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:55:49 INFO - Installing collected packages: psutil 18:55:49 INFO - Running setup.py install for psutil 18:55:49 INFO - building 'psutil._psutil_linux' extension 18:55:49 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 18:55:49 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 18:55:49 INFO - building 'psutil._psutil_posix' extension 18:55:49 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 18:55:49 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 18:55:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:55:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:55:50 INFO - Successfully installed psutil 18:55:50 INFO - Cleaning up... 18:55:50 INFO - Return code: 0 18:55:50 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 18:55:50 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')]} 18:55:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:55:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:55:50 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')]} 18:55:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:55:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:55:50 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 0x7fafc7fc5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c1e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ce95a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d78410>, '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 0x1d79310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d797a0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1461370729.204741-1070592121', '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 18:55:50 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 18:55:50 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 18:55:50 INFO - Using env: {'DISPLAY': ':0', 18:55:50 INFO - 'HOME': '/home/cltbld', 18:55:50 INFO - 'LANG': 'en_US.UTF-8', 18:55:50 INFO - 'LANGUAGE': 'en_US:en', 18:55:50 INFO - 'LOGNAME': 'cltbld', 18:55:50 INFO - 'MAIL': '/var/mail/cltbld', 18:55:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:55:50 INFO - 'MOZ_NO_REMOTE': '1', 18:55:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:55:50 INFO - 'NO_EM_RESTART': '1', 18:55:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:55:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:55:50 INFO - 'PWD': '/builds/slave/test', 18:55:50 INFO - 'SHELL': '/bin/bash', 18:55:50 INFO - 'SHLVL': '1', 18:55:50 INFO - 'TERM': 'linux', 18:55:50 INFO - 'TMOUT': '86400', 18:55:50 INFO - 'USER': 'cltbld', 18:55:50 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1461370729.204741-1070592121', 18:55:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:55:50 INFO - '_': '/tools/buildbot/bin/python'} 18:55:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:55:50 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:55:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:55:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:55:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:55:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:55:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:55:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:55:52 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:55:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:55:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 18:55:52 INFO - Installing collected packages: mozsystemmonitor 18:55:52 INFO - Running setup.py install for mozsystemmonitor 18:55:52 INFO - Successfully installed mozsystemmonitor 18:55:52 INFO - Cleaning up... 18:55:52 INFO - Return code: 0 18:55:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:55: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')]} 18:55:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:55:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:55: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')]} 18:55:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:55:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:55:52 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 0x7fafc7fc5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c1e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ce95a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d78410>, '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 0x1d79310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d797a0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1461370729.204741-1070592121', '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 18:55:52 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 18:55:52 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 18:55:52 INFO - Using env: {'DISPLAY': ':0', 18:55:52 INFO - 'HOME': '/home/cltbld', 18:55:52 INFO - 'LANG': 'en_US.UTF-8', 18:55:52 INFO - 'LANGUAGE': 'en_US:en', 18:55:52 INFO - 'LOGNAME': 'cltbld', 18:55:52 INFO - 'MAIL': '/var/mail/cltbld', 18:55:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:55:52 INFO - 'MOZ_NO_REMOTE': '1', 18:55:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:55:52 INFO - 'NO_EM_RESTART': '1', 18:55:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:55:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:55:52 INFO - 'PWD': '/builds/slave/test', 18:55:52 INFO - 'SHELL': '/bin/bash', 18:55:52 INFO - 'SHLVL': '1', 18:55:52 INFO - 'TERM': 'linux', 18:55:52 INFO - 'TMOUT': '86400', 18:55:52 INFO - 'USER': 'cltbld', 18:55:52 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1461370729.204741-1070592121', 18:55:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:55:52 INFO - '_': '/tools/buildbot/bin/python'} 18:55:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:55:52 INFO - Downloading/unpacking blobuploader==1.2.4 18:55:52 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 18:55:52 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 18:55:52 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 18:55:52 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 18:55:52 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 18:55:52 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 18:55:54 INFO - Downloading blobuploader-1.2.4.tar.gz 18:55:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:55:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:55:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:55:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:55:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:55:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:55:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:55:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:55:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:55:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:55:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:55:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:55:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:55:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:55:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:55:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:55:55 INFO - Downloading docopt-0.6.1.tar.gz 18:55:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:55:55 INFO - Installing collected packages: blobuploader, requests, docopt 18:55:55 INFO - Running setup.py install for blobuploader 18:55:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:55:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:55:55 INFO - Running setup.py install for requests 18:55:55 INFO - Running setup.py install for docopt 18:55:55 INFO - Successfully installed blobuploader requests docopt 18:55:55 INFO - Cleaning up... 18:55:55 INFO - Return code: 0 18:55:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:55: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')]} 18:55:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:55:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:55: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')]} 18:55:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:55:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:55:55 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 0x7fafc7fc5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c1e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ce95a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d78410>, '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 0x1d79310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d797a0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1461370729.204741-1070592121', '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 18:55:55 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 18:55:55 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 18:55:55 INFO - Using env: {'DISPLAY': ':0', 18:55:55 INFO - 'HOME': '/home/cltbld', 18:55:55 INFO - 'LANG': 'en_US.UTF-8', 18:55:55 INFO - 'LANGUAGE': 'en_US:en', 18:55:55 INFO - 'LOGNAME': 'cltbld', 18:55:55 INFO - 'MAIL': '/var/mail/cltbld', 18:55:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:55:55 INFO - 'MOZ_NO_REMOTE': '1', 18:55:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:55:55 INFO - 'NO_EM_RESTART': '1', 18:55:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:55:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:55:55 INFO - 'PWD': '/builds/slave/test', 18:55:55 INFO - 'SHELL': '/bin/bash', 18:55:55 INFO - 'SHLVL': '1', 18:55:55 INFO - 'TERM': 'linux', 18:55:55 INFO - 'TMOUT': '86400', 18:55:55 INFO - 'USER': 'cltbld', 18:55:55 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1461370729.204741-1070592121', 18:55:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:55:55 INFO - '_': '/tools/buildbot/bin/python'} 18:55:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:55:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:55:56 INFO - Running setup.py (path:/tmp/pip-GCokpz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:55:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:55:56 INFO - Running setup.py (path:/tmp/pip-yekKUd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:55:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:55:56 INFO - Running setup.py (path:/tmp/pip-ciHGOT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:55:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:55:56 INFO - Running setup.py (path:/tmp/pip-7Yg7A7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:55:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:55:56 INFO - Running setup.py (path:/tmp/pip-ILfkj3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:55:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:55:56 INFO - Running setup.py (path:/tmp/pip-P21jBP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:55:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:55:56 INFO - Running setup.py (path:/tmp/pip-9q2ZDz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:55:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:55:56 INFO - Running setup.py (path:/tmp/pip-j7_G0N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:55:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:55:56 INFO - Running setup.py (path:/tmp/pip-ZUyxHh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:55:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:55:56 INFO - Running setup.py (path:/tmp/pip-poUGh7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:55:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:55:56 INFO - Running setup.py (path:/tmp/pip-F9fyS3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:55:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:55:56 INFO - Running setup.py (path:/tmp/pip-cBsF0i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:55:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:55:56 INFO - Running setup.py (path:/tmp/pip-n71scU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:55:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:55:56 INFO - Running setup.py (path:/tmp/pip-oZhaJ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:55:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:55:57 INFO - Running setup.py (path:/tmp/pip-pn2alf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:55:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:55:57 INFO - Running setup.py (path:/tmp/pip-9ByuZC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:55:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:55:57 INFO - Running setup.py (path:/tmp/pip-HBFV9t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:55:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:55:57 INFO - Running setup.py install for manifestparser 18:55:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:55:57 INFO - Running setup.py install for mozcrash 18:55:57 INFO - Running setup.py install for mozdebug 18:55:57 INFO - Running setup.py install for mozdevice 18:55:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:55:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:55:57 INFO - Running setup.py install for mozfile 18:55:57 INFO - Running setup.py install for mozhttpd 18:55:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:55:57 INFO - Running setup.py install for mozinfo 18:55:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:55:57 INFO - Running setup.py install for mozInstall 18:55:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:55:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:55:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:55:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:55:58 INFO - Running setup.py install for mozleak 18:55:58 INFO - Running setup.py install for mozlog 18:55:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:55:58 INFO - Running setup.py install for moznetwork 18:55:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:55:58 INFO - Running setup.py install for mozprocess 18:55:58 INFO - Running setup.py install for mozprofile 18:55:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:55:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:55:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:55:58 INFO - Running setup.py install for mozrunner 18:55:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:55:58 INFO - Running setup.py install for mozscreenshot 18:55:58 INFO - Running setup.py install for moztest 18:55:58 INFO - Running setup.py install for mozversion 18:55:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:55:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:55:59 INFO - Cleaning up... 18:55:59 INFO - Return code: 0 18:55:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:55:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:55:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:55:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:55:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:55:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:55:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:55:59 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 0x7fafc7fc5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c1e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ce95a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d78410>, '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 0x1d79310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d797a0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1461370729.204741-1070592121', '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 18:55:59 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 18:55:59 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 18:55:59 INFO - Using env: {'DISPLAY': ':0', 18:55:59 INFO - 'HOME': '/home/cltbld', 18:55:59 INFO - 'LANG': 'en_US.UTF-8', 18:55:59 INFO - 'LANGUAGE': 'en_US:en', 18:55:59 INFO - 'LOGNAME': 'cltbld', 18:55:59 INFO - 'MAIL': '/var/mail/cltbld', 18:55:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:55:59 INFO - 'MOZ_NO_REMOTE': '1', 18:55:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:55:59 INFO - 'NO_EM_RESTART': '1', 18:55:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:55:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:55:59 INFO - 'PWD': '/builds/slave/test', 18:55:59 INFO - 'SHELL': '/bin/bash', 18:55:59 INFO - 'SHLVL': '1', 18:55:59 INFO - 'TERM': 'linux', 18:55:59 INFO - 'TMOUT': '86400', 18:55:59 INFO - 'USER': 'cltbld', 18:55:59 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1461370729.204741-1070592121', 18:55:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:55:59 INFO - '_': '/tools/buildbot/bin/python'} 18:55:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:55:59 INFO - Running setup.py (path:/tmp/pip-R31Uvn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:55:59 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)) 18:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:55:59 INFO - Running setup.py (path:/tmp/pip-dQcqWY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:55:59 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)) 18:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:55:59 INFO - Running setup.py (path:/tmp/pip-5duRWP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:55:59 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)) 18:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:55:59 INFO - Running setup.py (path:/tmp/pip-lPIE0S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:55:59 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)) 18:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:55:59 INFO - Running setup.py (path:/tmp/pip-3XCY0F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:55:59 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)) 18:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:55:59 INFO - Running setup.py (path:/tmp/pip-Ggid7_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:55:59 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)) 18:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:55:59 INFO - Running setup.py (path:/tmp/pip-V6jZKw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:55:59 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)) 18:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:55:59 INFO - Running setup.py (path:/tmp/pip-f53gR1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:55:59 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)) 18:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:55:59 INFO - Running setup.py (path:/tmp/pip-oger1m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:55:59 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)) 18:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:55:59 INFO - Running setup.py (path:/tmp/pip-2QvXeU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:55:59 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)) 18:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:55:59 INFO - Running setup.py (path:/tmp/pip-VZX9SR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:56:00 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)) 18:56:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:56:00 INFO - Running setup.py (path:/tmp/pip-kLGAsZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:56:00 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)) 18:56:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:56:00 INFO - Running setup.py (path:/tmp/pip-J_BlZ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:56:00 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)) 18:56:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:56:00 INFO - Running setup.py (path:/tmp/pip-kPUO36-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:56:00 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)) 18:56:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:56:00 INFO - Running setup.py (path:/tmp/pip-GP3K4y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:56:00 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)) 18:56:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:56:00 INFO - Running setup.py (path:/tmp/pip-uaf28w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:56:00 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)) 18:56:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:56:00 INFO - Running setup.py (path:/tmp/pip-4gwbn9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:56:00 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)) 18:56:00 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)) 18:56:00 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)) 18:56:00 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)) 18:56:00 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)) 18:56:00 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)) 18:56:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:56:00 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 18:56:00 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 18:56:00 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 18:56:00 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 18:56:00 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 18:56:00 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 18:56:02 INFO - Downloading blessings-1.6.tar.gz 18:56:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:56:02 INFO - Installing collected packages: blessings 18:56:02 INFO - Running setup.py install for blessings 18:56:02 INFO - Successfully installed blessings 18:56:02 INFO - Cleaning up... 18:56:02 INFO - Return code: 0 18:56:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:56:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:56:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:56:02 INFO - Reading from file tmpfile_stdout 18:56:02 INFO - Current package versions: 18:56:02 INFO - argparse == 1.2.1 18:56:02 INFO - blessings == 1.6 18:56:02 INFO - blobuploader == 1.2.4 18:56:02 INFO - docopt == 0.6.1 18:56:02 INFO - manifestparser == 1.1 18:56:02 INFO - mozInstall == 1.12 18:56:02 INFO - mozcrash == 0.17 18:56:02 INFO - mozdebug == 0.1 18:56:02 INFO - mozdevice == 0.48 18:56:02 INFO - mozfile == 1.2 18:56:02 INFO - mozhttpd == 0.7 18:56:02 INFO - mozinfo == 0.9 18:56:02 INFO - mozleak == 0.1 18:56:02 INFO - mozlog == 3.1 18:56:02 INFO - moznetwork == 0.27 18:56:02 INFO - mozprocess == 0.22 18:56:02 INFO - mozprofile == 0.28 18:56:02 INFO - mozrunner == 6.11 18:56:02 INFO - mozscreenshot == 0.1 18:56:02 INFO - mozsystemmonitor == 0.0 18:56:02 INFO - moztest == 0.7 18:56:02 INFO - mozversion == 1.4 18:56:02 INFO - psutil == 3.1.1 18:56:02 INFO - requests == 1.2.3 18:56:02 INFO - wsgiref == 0.1.2 18:56:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:56:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:56:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:56:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:56:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:56:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:56:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:56:02 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 0x7fafc7fc5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c1e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ce95a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d78410>, '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 0x1d79310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d797a0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1461370729.204741-1070592121', '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 18:56:02 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 18:56:02 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 18:56:02 INFO - Using env: {'DISPLAY': ':0', 18:56:02 INFO - 'HOME': '/home/cltbld', 18:56:02 INFO - 'LANG': 'en_US.UTF-8', 18:56:02 INFO - 'LANGUAGE': 'en_US:en', 18:56:02 INFO - 'LOGNAME': 'cltbld', 18:56:02 INFO - 'MAIL': '/var/mail/cltbld', 18:56:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:56:02 INFO - 'MOZ_NO_REMOTE': '1', 18:56:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:56:02 INFO - 'NO_EM_RESTART': '1', 18:56:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:56:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:56:02 INFO - 'PWD': '/builds/slave/test', 18:56:02 INFO - 'SHELL': '/bin/bash', 18:56:02 INFO - 'SHLVL': '1', 18:56:02 INFO - 'TERM': 'linux', 18:56:02 INFO - 'TMOUT': '86400', 18:56:02 INFO - 'USER': 'cltbld', 18:56:02 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1461370729.204741-1070592121', 18:56:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:56:02 INFO - '_': '/tools/buildbot/bin/python'} 18:56:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:56:03 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)) 18:56:03 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)) 18:56:03 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)) 18:56:03 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)) 18:56:03 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)) 18:56:03 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)) 18:56:03 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)) 18:56:03 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)) 18:56:03 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)) 18:56:03 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)) 18:56:03 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)) 18:56:03 INFO - Cleaning up... 18:56:03 INFO - Return code: 0 18:56:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:56:03 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')]} 18:56:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:56:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:56:03 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')]} 18:56:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:56:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:56:03 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 0x7fafc7fc5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c1e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ce95a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d78410>, '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 0x1d79310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d797a0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1461370729.204741-1070592121', '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 18:56:03 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 18:56:03 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 18:56:03 INFO - Using env: {'DISPLAY': ':0', 18:56:03 INFO - 'HOME': '/home/cltbld', 18:56:03 INFO - 'LANG': 'en_US.UTF-8', 18:56:03 INFO - 'LANGUAGE': 'en_US:en', 18:56:03 INFO - 'LOGNAME': 'cltbld', 18:56:03 INFO - 'MAIL': '/var/mail/cltbld', 18:56:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:56:03 INFO - 'MOZ_NO_REMOTE': '1', 18:56:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:56:03 INFO - 'NO_EM_RESTART': '1', 18:56:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:56:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:56:03 INFO - 'PWD': '/builds/slave/test', 18:56:03 INFO - 'SHELL': '/bin/bash', 18:56:03 INFO - 'SHLVL': '1', 18:56:03 INFO - 'TERM': 'linux', 18:56:03 INFO - 'TMOUT': '86400', 18:56:03 INFO - 'USER': 'cltbld', 18:56:03 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1461370729.204741-1070592121', 18:56:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:56:03 INFO - '_': '/tools/buildbot/bin/python'} 18:56:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:56:03 INFO - Downloading/unpacking jsonschema 18:56:03 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 18:56:03 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 18:56:03 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 18:56:03 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 18:56:03 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 18:56:03 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 18:56:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:56:05 INFO - Downloading/unpacking functools32 (from jsonschema) 18:56:05 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 18:56:05 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 18:56:05 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 18:56:05 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 18:56:05 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 18:56:05 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 18:56:05 INFO - Downloading functools32-3.2.3-2.tar.gz 18:56:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:56:05 INFO - warning: no files found matching '*.txt' 18:56:05 INFO - no previously-included directories found matching 'build' 18:56:05 INFO - no previously-included directories found matching 'dist' 18:56:05 INFO - no previously-included directories found matching '.git*' 18:56:05 INFO - Installing collected packages: jsonschema, functools32 18:56:05 INFO - Running setup.py install for functools32 18:56:05 INFO - warning: no files found matching '*.txt' 18:56:05 INFO - no previously-included directories found matching 'build' 18:56:05 INFO - no previously-included directories found matching 'dist' 18:56:05 INFO - no previously-included directories found matching '.git*' 18:56:05 INFO - Successfully installed jsonschema functools32 18:56:05 INFO - Cleaning up... 18:56:05 INFO - Return code: 0 18:56:05 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 18:56:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:56:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:56:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:56:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:56:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:56:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:56:05 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 0x7fafc7fc5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c1e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ce95a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d78410>, '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 0x1d79310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d797a0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1461370729.204741-1070592121', '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 18:56:05 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 18:56:05 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 18:56:05 INFO - Using env: {'DISPLAY': ':0', 18:56:05 INFO - 'HOME': '/home/cltbld', 18:56:05 INFO - 'LANG': 'en_US.UTF-8', 18:56:05 INFO - 'LANGUAGE': 'en_US:en', 18:56:05 INFO - 'LOGNAME': 'cltbld', 18:56:05 INFO - 'MAIL': '/var/mail/cltbld', 18:56:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:56:05 INFO - 'MOZ_NO_REMOTE': '1', 18:56:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:56:05 INFO - 'NO_EM_RESTART': '1', 18:56:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:56:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:56:05 INFO - 'PWD': '/builds/slave/test', 18:56:05 INFO - 'SHELL': '/bin/bash', 18:56:05 INFO - 'SHLVL': '1', 18:56:05 INFO - 'TERM': 'linux', 18:56:05 INFO - 'TMOUT': '86400', 18:56:05 INFO - 'USER': 'cltbld', 18:56:05 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1461370729.204741-1070592121', 18:56:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:56:05 INFO - '_': '/tools/buildbot/bin/python'} 18:56:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:56:05 INFO - Downloading/unpacking flake8 18:56:05 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 18:56:05 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 18:56:05 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 18:56:05 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 18:56:05 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 18:56:05 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 18:56:07 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 18:56:07 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 18:56:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:56:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:56:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:56:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:56:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:56:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:56:07 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 18:56:07 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 18:56:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:56:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:56:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:56:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:56:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:56:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:56:08 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 18:56:08 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 18:56:08 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 18:56:08 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 18:56:08 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 18:56:08 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 18:56:08 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 18:56:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 18:56:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:56:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:56:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:56:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:56:08 INFO - no previously-included directories found matching 'docs/_build' 18:56:08 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 18:56:08 INFO - Running setup.py install for pep8 18:56:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:56:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:56:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:56:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:56:08 INFO - no previously-included directories found matching 'docs/_build' 18:56:08 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 18:56:08 INFO - Successfully installed flake8 mccabe pyflakes pep8 18:56:08 INFO - Cleaning up... 18:56:08 INFO - Return code: 0 18:56:08 INFO - Running post-action listener: _resource_record_post_action 18:56:08 INFO - Running post-action listener: _start_resource_monitoring 18:56:08 INFO - Starting resource monitoring. 18:56:08 INFO - ##### 18:56:08 INFO - ##### Running install step. 18:56:08 INFO - ##### 18:56:08 INFO - Running pre-action listener: _resource_record_pre_action 18:56:08 INFO - Running main action method: install 18:56:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:56:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:56:08 INFO - Reading from file tmpfile_stdout 18:56:08 INFO - Detecting whether we're running mozinstall >=1.0... 18:56:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:56:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:56:08 INFO - Reading from file tmpfile_stdout 18:56:08 INFO - Output received: 18:56:08 INFO - Usage: mozinstall [options] installer 18:56:08 INFO - Options: 18:56:08 INFO - -h, --help show this help message and exit 18:56:08 INFO - -d DEST, --destination=DEST 18:56:08 INFO - Directory to install application into. [default: 18:56:08 INFO - "/builds/slave/test"] 18:56:08 INFO - --app=APP Application being installed. [default: firefox] 18:56:08 INFO - mkdir: /builds/slave/test/build/application 18:56:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 18:56:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 18:56:25 INFO - Reading from file tmpfile_stdout 18:56:25 INFO - Output received: 18:56:25 INFO - /builds/slave/test/build/application/firefox/firefox 18:56:25 INFO - Running post-action listener: _resource_record_post_action 18:56:25 INFO - ##### 18:56:25 INFO - ##### Running run-tests step. 18:56:25 INFO - ##### 18:56:25 INFO - Running pre-action listener: _resource_record_pre_action 18:56:25 INFO - Running main action method: run_tests 18:56:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:56:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:56:25 INFO - Python 2.7.3 18:56:25 INFO - Return code: 0 18:56:25 INFO - grabbing minidump binary from tooltool 18:56:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:56:25 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 0x1d78410>, '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 0x1d79310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d797a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:56:25 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 18:56:25 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 18:56:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:56:25 INFO - Return code: 0 18:56:25 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:56:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:56:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:56:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:56:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:56:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 18:56:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 18:56:26 INFO - Return code: 0 18:56:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dXMD-g5HS_6V2K5vuC86uQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--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 18:56:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dXMD-g5HS_6V2K5vuC86uQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-022 --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 18:56:26 INFO - Using env: {'DISPLAY': ':0', 18:56:26 INFO - 'HOME': '/home/cltbld', 18:56:26 INFO - 'LANG': 'en_US.UTF-8', 18:56:26 INFO - 'LANGUAGE': 'en_US:en', 18:56:26 INFO - 'LOGNAME': 'cltbld', 18:56:26 INFO - 'MAIL': '/var/mail/cltbld', 18:56:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:56:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:56:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:56:26 INFO - 'MOZ_NO_REMOTE': '1', 18:56:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:56:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:56:26 INFO - 'NO_EM_RESTART': '1', 18:56:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:56:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:56:26 INFO - 'PWD': '/builds/slave/test', 18:56:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:56:26 INFO - 'SHELL': '/bin/bash', 18:56:26 INFO - 'SHLVL': '1', 18:56:26 INFO - 'TERM': 'linux', 18:56:26 INFO - 'TMOUT': '86400', 18:56:26 INFO - 'USER': 'cltbld', 18:56:26 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1461370729.204741-1070592121', 18:56:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:56:26 INFO - '_': '/tools/buildbot/bin/python'} 18:56:26 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dXMD-g5HS_6V2K5vuC86uQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--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 18:56:26 INFO - mozversion application_buildid: 20160422163023 18:56:26 INFO - mozversion application_changeset: fb0d7b82c072b81ec2d2551dd832f48c287527f9 18:56:26 INFO - mozversion application_display_name: Nightly 18:56:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:56:26 INFO - mozversion application_name: Firefox 18:56:26 INFO - mozversion application_remotingname: firefox 18:56:26 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 18:56:26 INFO - mozversion application_vendor: Mozilla 18:56:26 INFO - mozversion application_version: 48.0a1 18:56:26 INFO - mozversion platform_buildid: 20160422163023 18:56:26 INFO - mozversion platform_changeset: fb0d7b82c072b81ec2d2551dd832f48c287527f9 18:56:26 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 18:56:26 INFO - mozversion platform_version: 48.0a1 18:56:26 INFO - using testdate: 1461376586 18:56:26 INFO - actual date: 1461376586 18:56:26 INFO - starting webserver on 'localhost:41162' 18:56:26 INFO - SUITE-START | Running 2 tests 18:56:26 INFO - TEST-START | dromaeo_css 18:56:26 INFO - operating with platform_type : linux_ 18:56:26 INFO - Initialising browser for dromaeo_css test... 18:56:26 INFO - TEST-INFO | started process 4573 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8e39j5/profile http://localhost:41162/getInfo.html) 18:56:31 INFO - PROCESS | 4573 | 18:56:31 INFO - PROCESS | 4573 | (process:4643): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 18:56:31 INFO - PROCESS | 4573 | __metrics Screen width/height:1600/1200 18:56:31 INFO - PROCESS | 4573 | colorDepth:24 18:56:31 INFO - PROCESS | 4573 | Browser inner width/height: 1024/697 18:56:31 INFO - PROCESS | 4573 | __metrics 18:56:32 ERROR - PROCESS | 4573 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 18:56:33 INFO - TEST-INFO | 4573: exit 0 18:56:33 INFO - Browser initialized. 18:56:33 INFO - Running cycle 1/1 for dromaeo_css test... 18:56:33 INFO - TEST-INFO | started process 4694 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8e39j5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:56:35 INFO - PROCESS | 4694 | 18:56:35 INFO - PROCESS | 4694 | (process:4755): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 18:56:45 INFO - PROCESS | 4694 | RSS: Main: 164052992 18:56:45 INFO - PROCESS | 4694 | 18:57:34 INFO - PROCESS | 4694 | 1461376654753 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] 18:59:41 INFO - PROCESS | 4694 | Cycle 1(1): loaded http://localhost:41162/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41162/tests/dromaeo/cssquery-ext.html) 18:59:42 INFO - PROCESS | 4694 | RSS: Main: 167895040 18:59:42 INFO - PROCESS | 4694 | 19:02:44 INFO - PROCESS | 4694 | Cycle 1(1): loaded http://localhost:41162/tests/dromaeo/cssquery-ext.html (next: http://localhost:41162/tests/dromaeo/cssquery-jquery.html) 19:02:45 INFO - PROCESS | 4694 | RSS: Main: 166346752 19:02:45 INFO - PROCESS | 4694 | 19:05:47 INFO - PROCESS | 4694 | Cycle 1(1): loaded http://localhost:41162/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41162/tests/dromaeo/cssquery-mootools.html) 19:05:47 INFO - PROCESS | 4694 | RSS: Main: 166998016 19:05:47 INFO - PROCESS | 4694 | 19:08:49 INFO - PROCESS | 4694 | Cycle 1(1): loaded http://localhost:41162/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41162/tests/dromaeo/cssquery-prototype.html) 19:08:50 INFO - PROCESS | 4694 | RSS: Main: 164618240 19:08:50 INFO - PROCESS | 4694 | 19:11:52 INFO - PROCESS | 4694 | Cycle 1(1): loaded http://localhost:41162/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41162/tests/dromaeo/cssquery-yui.html) 19:11:53 INFO - PROCESS | 4694 | RSS: Main: 165625856 19:11:53 INFO - PROCESS | 4694 | 19:14:55 INFO - PROCESS | 4694 | Cycle 1(1): loaded http://localhost:41162/tests/dromaeo/cssquery-yui.html (next: http://localhost:41162/tests/dromaeo/cssquery-dojo.html) 19:14:55 INFO - PROCESS | 4694 | RSS: Main: 167768064 19:14:55 INFO - PROCESS | 4694 | 19:14:55 INFO - PROCESS | 4694 | __start_tp_report 19:14:55 INFO - PROCESS | 4694 | _x_x_mozilla_page_load 19:14:55 INFO - PROCESS | 4694 | _x_x_mozilla_page_load_details 19:14:55 INFO - PROCESS | 4694 | |i|pagename|runs| 19:14:55 INFO - PROCESS | 4694 | |0;dojo.html;3117.4544454720426;3157.0528841347596;3168.5405616185667;3172.793768405055;3204.2309845637055;5260.947390526098;5301.8939621207555;5305.787768489261;5335.4664533546675;5360.3299587551555;5252.395974462938;5377.489138531833;5421.756020979055;5461.399246082928;5467.835964921059;4781.66528343017;4837.492063333352;4918.114739346916;4919.237518184687;4921.901561968759;814.8557673490155;4757.333973243732;4831.830885918994;4852.441969173555;4903.950960490385;4840.983393487372;4862.878428039292;4863.294822250771;4871.926921096187;4873.463918968911;4835.782389792468;4843.75781210938;4846.5153484651255;4859.82990595331;4882.584980276681;4744.881377965544;4821.662483626147;4858.1983972644475;4878.682885612424;4910.607151427877;5200.915122851772;5209.114450543417;5247.212918062283;5258.6581872178185;5333.466653334674;5595.356533998602;5730.6275092119295;5737.282839645044;5740.311162660508;5752.856178595527;5796.188533605298;5821.62159459638;5835.270591176103;5870.090136028923;5883.17635531026;5329.813456529003;5360.758765855546;5362.490563396471;5366.114591092465;5367.0339338918975;5649.745761440745;5786.392428794916;5806.30324361071;5809.331926828469;5827.4172582741385;5599;5600.5799565032785;5602.963451761437;5616.9157462638095;5642.887142257132;5665.433456654384;5673.801416950387;5674.978503869261;5681.943180568224;5689.061304884731;5515.338159420895;5574.832755017356;5630.324361076697;5632.2678051853;5643.633163844419;5673.546116310686;5694.800681976111;5695.487406133468;5705.030144875298;5741.45456181662;4345.543717909637;4369.148016136886;4388.078503514298;4389.144116897174;4392.956070439319;3798.0315019669806;3872.8257228424786;3941.7043721720984;3949.2299001694396;3975.900602484961;5399.622026458111;5412.323459567554;5418.970395624819;5429.457054294539;5449.128139497661;5647.915281270784;5692.715364231772;5697.857553561194;5705.62913410627;5713.4000929902595;5357.598180136505;5418.647787893774;5483.341998960151;5532.778688852401;5579.218909352694;4940.950590494049;4952.900941981212;4966.751662416937;4989.925151122736;4998.375203099613;5933.139694744238;5951.077582974559;5956.493698035629;5976.970115149396;5978.312494063239;5609.298837645294;5624.100143977026;5659.915101273402;5680.289963754531;5685.0335442973965;5893.6463812171405;5916.727903500596;5928.34788173292;5941.58408911372;5942.286925568959;5496.642718223303;5609.49514543693;5622.1566764983945;5629.915551266652;5631.183478395692;5722.914156287576;5773.162891380643;5782.132680098019;5808.94191058084;5828.708564571839;5475.67145971243;5494.505494505353;5494.862628434321;5512.972435137959;5514.6691198528215;5437.809676661298;5479.506844384025;5480.534154596745;5532.944670553243;5535.3357597087;5542.7782888685615;5547.33431988164;5555.861103472445;5561.082421400423;5602.579806514446;5629.605927585029;5630.690312032878;5637.689927054052;5644.2380278663495;5667.801626943037;5408.242846001642;5414.160805075219;5497.038018346853;5553.278073850373;5562.471565201299 19:14:55 INFO - PROCESS | 4694 | |1;ext.html;599.3556926304221;642.5405834828099;655.9439302722616;662.6885363878976;685.6708779785706;36836.26327473449;37929.620703792985;38110.61889381112;38289.23421531568;38337.80831095848;38673.80663096688;39209.411858822066;39247.41128883062;39328.410073848914;39343.40984885222;8714;8873.3344999125;8900.599473023729;8909.242714369255;8931.062238464965;8746.212840844322;8874.511901845395;8880.822383552326;8898.28813694906;8899.288056955427;8872.15714507124;8955.19403253707;8955.731328060168;8956.910430895672;8958.820823583525;8828.867566986468;8877.778055548599;8884.422512536665;8906.955465222632;8922.197002269762;8713.69502067431;8776;8826.470411775314;8827.69103081389;8842.115788421172;28145.57781633277;38185.23629527394;38647.42028869569;38660;38769.61230387716;3250.496173093151;3482.112061424346;3577.2487777566744;3578.2127931854952;4194.769287689176;28433.57349639757;28604.427911441653;29011.562183924027;29333.413331733245;29345.41309173826;3586.4082426399614;3669.21111960927;3705.2589482103685;3747.6439738224826;3820.6943444524372;269398;270653;271522;273560.6321968397;274895.12762181106;32704;33871.83064084664;56982.71508642513;57354.7132264336;57422;34457.827710861784;34485.310293793984;34597.30805383878;34640;34668.653313467046;15814.841851581567;15995.360185592446;16029.759553606706;16032;16033.759493607606;13198.472061117447;13290.66773330655;13325.8673012795;13348.93325533366;13351.73296534064;8501.65993360271;8635.6977505787;8642.740717778477;8651.740447786577;8682.479051256945;3273.8690452382116;3278.1968417737808;3360.1095709636966;3365.3774051800497;3391.660833916638;1029.4852573713144;1047.7427087495037;1063.7659714862718;1184.088252045937;1186.0867132308074;30341.544876826865;30374.240643983634;30763.54778163813;30988;31201.531977020364;1117.3351855645878;1139.4473680265064;1157.288267715366;1242.130508643953;1248.5942068827667;15734.370625174864;16353;16406.917965410335;16623.6675266494;17079.537108715904;484580;487796;492756;493223;494508;56821.147682784795;57609.711951439975;58327.708361457924;58448;58469.4153058464;1396.7206558688304;1405.3816320818808;1419.3754747910887;1434.763264061439;1437.590286768287;30096.24759381033;30711.846440767655;30842.228944276572;31044.844775775975;31454;50161;50243.497565023885;50451.99096018133;50636.24045639245;50785.492145078075;415424;423491;423767;424115.6382654201;424831;42921.35617965795;43540.56459435492;43721;43743;45045.32432013588;47780;48080;48317.5168248313;48653;49096;40108.23902285793;40188;40733.79633101934;41567.58432415758;41988.790056049525;39110;39710;39972;40871.79564102161;40979;37620.62379376281;38586.80706596449;38726.80636596799;38775;40691.18617627572;31212.375752485277;32811;33015.50476742899;33425.66574334226;33927;25891.611625826004;26099;26132.477350452504;26494.86752566302;26504.734952650226 19:14:55 INFO - PROCESS | 4694 | |2;jquery.html;378.2907049282597;378.41534828689663;379.9962000379996;381.4716617484786;382.60018280896463;17748.11259437028;18064;18521.0739463027;19235.326763563276;19268.4219473416;10330.845037324447;10572.418516981563;10680.519376628052;10681.198910081735;10682.465876706154;4824.324594556765;4840.370751802261;5006.674566153207;5049.77276022578;5054.494550544953;4977.303177555145;5007.574356179729;5008.824691135811;5009.574186194178;5010.498950104997;4832.251001094836;4908.165611845995;4911.82808601699;4968.254761785725;4976.278439626252;4889.291052797343;4913.508649135094;4971.37857767779;4979.7261150636705;4985;4812.470628230892;4856.708597484162;4987.750612469398;5317.441668624778;5328;12480.251184928933;12682.74634507314;12728.490860365575;20983.524712930604;21898.45253868666;2069.855110142291;2272.420532764151;2320.62679821199;2379.710360931011;2417.746136655661;9177.311701622404;9426.434413935185;9451.621935122586;9467.289953253534;9712.737344145287;1893.6496748101645;1963.4242675662406;1987.175322241268;1990.6814909614393;1998.980010199894;79022;81797;85077;87593;87772.56113719454;10060.899391006142;10313.12338451225;10337.638182663572;10517;10633.255672103034;14349.713005739826;14387.78418323726;14396.496122635657;14401.711965760836;14432.927835360966;7891.289783919475;8140.715074972348;8218.506889586644;8231.135730748185;8260.504369737835;8162.26539611426;8188.426810123234;8295.087540370554;8340.62467188978;8398.454100483448;4152.875413737593;4187.45563076798;4231.640310573574;4288.224258246441;4303.806328715215;1899.5061284066242;1927.2772710233662;1969.4780883065998;1980.9900950495155;1994.5512259741731;910.7814124610046;951.0869565217331;992.980140397188;1027.4143738069379;1048.816457120001;17238.827611723973;17517.211725472385;18453.261869525337;18821.90589047046;19102.426927192206;935.3265648732902;1007.2646967713611;1037.2894567221476;1043.2957753516346;1081.7620123572801;8767.298616110696;10331.380117192843;10503.2122590806;10535.736606584896;10606.15150787935;480245;502737;508382;516593;517332;75421;96350;97642.51178744061;97782.51108744553;98046.01953980369;1023.6673081248624;1049.3861091261545;1081.3187691754144;1092.7268182954263;1095.1676725688376;15957.361705531648;15964.281607327466;16021.599460013593;16154.838451615333;16183;36789;37061.62938370582;37312.81343593264;38695.6130438692;39867;53609.19586206288;59300.40699592949;59432.40567594269;59888.101678473984;60199.69900150471;8071.596420179085;8100.149484304063;8113.959430202811;8125.67497300125;8318.62566184511;12348.197367171106;13086.476540938256;13125.54060607874;13145.73708525805;13334.666633334244;8167.836643266983;10913.23607347478;11162.888371116185;11361.431928403712;11434.885651143382;11425.714357141138;11583;11601.477933492844;11691.123165762432;11837.408129593314;11369.772604548029;11707.824382634097;12022.63932082039;12066.396680166132;12193.573224937085;8005.319547838266;8116.269535741575;8170.509769413617;8206.753797386087;8267.049289331804;8518.403711740119;11322.150838687296;11762.3530705812;11950.760984780429;12179.878201217874 19:14:55 INFO - PROCESS | 4694 | |3;mootools.html;1510.5770384292398;1512.7806468062129;1695.2795062098605;1784;1794.9820501794977;7029.543079699816;7647.158812530617;7711.922880771198;8132.105468398471;8133.959330203348;7756.301932826044;7770.8445831083345;7815.765527034184;7845.09781375142;7851.92148078519;2208.083645287204;2241.753407125223;2242;2245.65192395179;2249.2465024216826;2196.8242540596716;2204.1293688992837;2246.4608493961414;2255.616545187322;2261.977380226193;2239.7760223977552;2245.079517397867;2248.3816950338705;2263.569921714877;2296.1045192374986;2150.6881502182173;2158.4280165756086;2172.663237198237;2178.9564208715815;2184.7050648162453;2132.4029271803765;2157.870527768339;2183.9235626753148;2191.3206905859233;2202.48241663209;7954;8013.51918884863;8014.158513356072;8042.477238979448;8065.798355041112;4806.735629540374;4899.363082799249;4919.2129259318335;4927.408710954708;4973.055119527278;3039.893603723859;3130.2180442709027;3188.6651901550467;3219.919502012445;3234.7250483708913;1006.9496525173786;1017.3997341568436;1022.7494263905317;1031.9226058045676;1049.150188347441;10957.83563246544;10967.341959482377;11015;11034.062104721108;11078.833817492745;4239.194553034913;4249.893752656209;4317.136572685476;4345.587169218919;4369.2790689536505;9332.44005359667;9375.953120234355;9434.245260379153;9460.053994600623;9498.810023799624;4916.164252077156;4936.506349365035;4938.950610493921;4945.876353091202;4954.405471343462;3996.5204175499125;4324.200022995756;4352.782360882006;4402.647788176938;4513.661475389359;3702.22253326799;3840.2895464339185;3843.577206507282;3908.5309762828642;3927.096767743435;1191.4519321112211;1208.9818652720217;1229.5819421396768;1238.9530846434748;1246.0343233993729;933.4119504712123;940.83535381308;946.7396465971913;955.6846240740539;957.2676902169845;5212.166053431432;5500.532454741312;5513.972430137824;5556.083246264402;5579.721013949286;424.5775453423863;425.4936625415745;429.7056516286354;431.8920269932517;438.6030642268752;3871.2451072041245;3995.2832770278187;4042.595740425934;4103.97948010258;4140.047789008545;9612.375195612403;9801.950990245146;9903.306768526278;9917.206623470105;9921.454320012468;9675.225981921429;9717.708468745948;9788.706338809847;9799.461029643438;9824.508774561244;7432.3310902019075;7648.158702542716;7664.96522969392;7665.386769058574;7684.769456916301;5401.432849550741;5596.4463213250665;5640.830775076754;5694.686792226467;5697.259356283656;9272.072792720945;9345.579448924951;9384.95307523458;9465.242780577675;9544.856827147738;9321.906780932104;9423.717288481357;9430.481323527272;9459.527023648652;9680;7211.567305961659;7227.060482137288;7354.521956072838;7470.962645186739;7485.4385921055045;7470.514416562906;7491.213422590549;7514.398848092249;7520;7571.697132114654;6725.125733654593;6861.862762744817;6881.690323935335;6929.44564434834;7001.50989430735;6726.192856857208;6803.727850886107;6859.485538584527;6869.622170780655;6887.586744795329;6346.777862774781;6366.713497892513;6466.288708242184;6467.450266727381;6595.604263744191;4748.287756836364;4832.589229915497;4847.224444088929;4887.780049897692;4938.259261110862;4754.595859351855;4803.423589169322;4839.733814640088;4887.242477416006;4928.556429921325 19:14:55 INFO - PROCESS | 4694 | |4;prototype.html;292.9750971167449;303.3659651328723;307.13081978002253;308.60036253052294;309.299436775703;5363.115086010804;5418.756155972981;5496.835094947153;5539.390667026629;5647.407022262665;5415.350157981038;5455.672659640424;5467.059193986137;5484.588655850807;5540.750666220019;4232.809523571439;4241.851535196269;4260.403543503897;4272.743635381887;4274.957250427503;4110.321796903522;4225.957740422587;4258.339957306607;4265.680073994447;4266.338717498793;4153.127843152926;4157.690327546813;4180.811863466151;4196.895077623069;4213.094184750278;4157.147784704129;4203.327467605199;4207.768572728499;4213.304804707204;4215.57844215576;3669.43123815809;3693.445983102529;3710.4805327254207;3717.1636381814146;3730.9067273318115;5046.419661738911;5349.518543331119;5361.597880159004;5369.838904832861;5401.864953376158;4789.712617242942;4799.2321228603605;4815.374001379833;4818.469968303484;4823.13183626947;5452.182172674091;5736.3403208631125;5741.913871291934;5813.912791308134;5814.081353153491;4022.215667944752;4039.454673619053;4056.1887622475624;4077.6126268004787;4081.836726530965;5898.941010589925;5936.5547583931375;5986.640801551877;5990.801839632091;5991.172692328882;3978.482797236341;4130.194612050681;4132.40080188371;4142.627163555234;4157.459530261047;4145.108801607669;4149.522804877417;4165.10487728083;4173.24881521323;4181.686373521998;4759.809607615656;4766.523347665206;4782.617390608743;4824.903501929942;4826.155422801066;5227.947720522746;5743.655380677173;5780.826575202751;5815.714121521327;5816.214811000461;1503.158231390403;1525.313608875988;1534.6010037390358;1536.0015989606845;1536.2702716209935;1011.3476807459148;1014.6955913226003;1029.25893356783;1040.7918416316768;1046.100353695821;5960.225170727777;5964.642121472725;5989.8203053908455;5989.940100599026;5999.700014999233;6299.96850015747;6319.46284565817;6336.461400780985;6394.26465956421;6412.775552855627;5835.299764028344;5848.883022339614;5945.384031026335;5982.162497250389;5988.4909782668965;3361.310931259086;3395.9151021224175;3402.2515046689687;3404.5744281964753;3406.982965085159;6310.9368906311265;6514.348565143542;6525.11910892033;6525.4453371463005;6540.640264785482;6439.291677915426;6442.871142577123;6454.354139694442;6500.674966251763;6510.479161667055;6364.299927008025;6513.609183449008;6542.934570654233;6549.214094308809;6561.1142495763415;6298.275698294755;6298.370162983665;6340.873182536416;6345.365463453618;6374.107624932606;6207.54122781137;6230.532710046674;6242.500599951902;6273.435390814849;6274.1843560336865;6291.716872740646;6575.539712220098;6598.3401659833635;6610.173728283965;6641.933580664131;4331.891702707458;4358.498772641186;4359.825606975685;4366.476022877275;4371.562843715603;6256.5620406572925;6309.589876658002;6330.113784070142;6367.522435817425;6419.165508483868;6138.938610613836;6154.076813513724;6185.752569897334;6201.255849298113;6210.130581718653;5952.136940143741;6068.302145253352;6100.664463454553;6198.380161983766;6228.937710622836;5950.256217972754;5997.370276120944;6032.8793424132145;6041.426064523863;6065.636061836304;6144.846378840565;6177.660228687465;6194.473469755121;6206.689665516797;6207.565470417208;5768.336641286306;5972.64164150135;5990.281166260077;5999.850003749942;6015.308239552507 19:14:55 INFO - PROCESS | 4694 | |5;yui.html;757.7575175943697;761.6762875777797;824.9463784853984;847.1316900177318;861.4960248254771;14171.92914035431;14422.639434014154;14469.855301446982;14526.418943242257;14807.481738139168;14310;14348.282585870717;14377.640558986004;14437.061590996578;14441.566752997427;800.535689300206;824.1017291152642;825.4098319701412;829.1625458287114;832.9458585191943;822.2969361196181;823.6911158315631;824.3570015387977;825.9793505162389;830.5847076461769;860.8235311761106;863.568215892054;863.9265662418702;867.1112110087148;868.7741187291318;855.5422848775937;856.8072183758667;858.5921687198593;859.6389516403094;862.4437237981498;621.4003486635373;625.5871125057486;627.3914303125961;627.9874402511924;628.3904612525843;14394.712105757932;14464.421423143061;14480.637984050378;14552.92723536386;14559.927200364036;13809.378577963915;13974;14014.509492167826;14084.084534505328;14098.577042688736;10567.841482377771;10609.522571484302;10611.681649550526;10696.411697356642;10785.5685772569;3770.3213421584105;3796.943045854287;3839.8464061437508;3887.61123887609;3924.3132451820816;53950.46049539494;54113.1883021755;54243.72878135584;54434.72782636061;54777.1783423249;10448.512517381772;10862;11006.655117151024;11187.272827266203;11555.2489088209;20450.897745511178;20566.69149962752;20604.690929636068;20668.793312066686;20672.79327206739;8007.359411247086;8030.277275045157;8076.9192308077345;8207.466514676527;8346.874796878052;4551.158035763395;4589.816407343669;4598.747068911175;4643.326717625993;4774.092922344744;3321.2693207494312;3378.7465940054594;3386.9153271167925;3399.456087026064;3408.710259627959;588.4321629627344;603.5594016368076;608.0575108581769;615.3323643846387;644.7968889799698;722.6567380494223;748.7042618165794;753.2618034326281;763.5151678684076;767.54331172952;8724.65101395937;8944.955275223581;8963.551822408854;9094.181523662903;9160.725178244664;713.8183332341895;720.4272603280405;722.3210182428501;725.26747984536;728.1589763822793;4138.751674899516;4261.275583150872;4286.164197981364;4335.609795118455;4342.240107981091;56667;59607.40392596105;64797.352026480075;65909;66908.6654566724;51497.74251128795;51711.48288517067;51940.74029629903;55058;55686.16470752942;49871.75064124729;50149;50771.492285076674;50778.74610626997;50966.490335096176;8960.865587016331;8985;9048.728538143867;9139.725808225763;9152.496612686366;33652;34051.31897362089;34430.48354274638;34541.13647158841;35203.29593408169;42008.36987445252;43935.34096988484;44201.33697994468;44734.77632611946;45057.549424505334;11330.773384532427;11658.300501969909;11751.882481175078;11887.108466864847;12013.159078864395;10184.694459166238;10429.26995110335;12283;12331.630051098482;12437.813432798695;11654.242474239147;11723.062155027406;11885.821712674144;12018;12129.818052729393;11150.163737719866;11351.205415620827;11374.43127843621;11387.316760994367;11633.767324653629;11426.600068997544;11463.541458341906;11545.538178472767;11576.942115289707;11714.23857449263;9786.85319720219;9848.113669769755;9997.950010249902;10010.399376037461;10128.291019628556;9423.858642120511;9735.659251926148;9821.165200958;9828.459434731158;9839.754006149904 19:14:55 INFO - PROCESS | 4694 | __end_tp_report 19:14:55 INFO - PROCESS | 4694 | __start_cc_report 19:14:55 INFO - PROCESS | 4694 | _x_x_mozilla_cycle_collect,354 19:14:55 INFO - PROCESS | 4694 | __end_cc_report 19:14:55 INFO - PROCESS | 4694 | __startTimestamp1461377695617__endTimestamp 19:14:55 INFO - PROCESS | 4694 | 19:14:55 INFO - PROCESS | 4694 | ------- Summary: start ------- 19:14:55 INFO - PROCESS | 4694 | Number of tests: 6 19:14:55 INFO - PROCESS | 4694 | 19:14:55 INFO - PROCESS | 4694 | [#0] dojo.html Cycles:165 Average:5282.04 Median:5512.97 stddev:686.17 (12.4%) stddev-sans-first:666.93 19:14:55 INFO - PROCESS | 4694 | Values: 3117.5 3157.1 3168.5 3172.8 3204.2 5260.9 5301.9 5305.8 5335.5 5360.3 5252.4 5377.5 5421.8 5461.4 5467.8 4781.7 4837.5 4918.1 4919.2 4921.9 814.9 4757.3 4831.8 4852.4 4904.0 4841.0 4862.9 4863.3 4871.9 4873.5 4835.8 4843.8 4846.5 4859.8 4882.6 4744.9 4821.7 4858.2 4878.7 4910.6 5200.9 5209.1 5247.2 5258.7 5333.5 5595.4 5730.6 5737.3 5740.3 5752.9 5796.2 5821.6 5835.3 5870.1 5883.2 5329.8 5360.8 5362.5 5366.1 5367.0 5649.7 5786.4 5806.3 5809.3 5827.4 5599.0 5600.6 5603.0 5616.9 5642.9 5665.4 5673.8 5675.0 5681.9 5689.1 5515.3 5574.8 5630.3 5632.3 5643.6 5673.5 5694.8 5695.5 5705.0 5741.5 4345.5 4369.1 4388.1 4389.1 4393.0 3798.0 3872.8 3941.7 3949.2 3975.9 5399.6 5412.3 5419.0 5429.5 5449.1 5647.9 5692.7 5697.9 5705.6 5713.4 5357.6 5418.6 5483.3 5532.8 5579.2 4941.0 4952.9 4966.8 4989.9 4998.4 5933.1 5951.1 5956.5 5977.0 5978.3 5609.3 5624.1 5659.9 5680.3 5685.0 5893.6 5916.7 5928.3 5941.6 5942.3 5496.6 5609.5 5622.2 5629.9 5631.2 5722.9 5773.2 5782.1 5808.9 5828.7 5475.7 5494.5 5494.9 5513.0 5514.7 5437.8 5479.5 5480.5 5532.9 5535.3 5542.8 5547.3 5555.9 5561.1 5602.6 5629.6 5630.7 5637.7 5644.2 5667.8 5408.2 5414.2 5497.0 5553.3 5562.5 19:14:55 INFO - PROCESS | 4694 | 19:14:55 INFO - PROCESS | 4694 | [#1] ext.html Cycles:180 Average:54569.24 Median:38653.71 stddev:107594.08 (278.4%) stddev-sans-first:107819.60 19:14:55 INFO - PROCESS | 4694 | Values: 599.4 642.5 655.9 662.7 685.7 36836.3 37929.6 38110.6 38289.2 38337.8 38673.8 39209.4 39247.4 39328.4 39343.4 8714.0 8873.3 8900.6 8909.2 8931.1 8746.2 8874.5 8880.8 8898.3 8899.3 8872.2 8955.2 8955.7 8956.9 8958.8 8828.9 8877.8 8884.4 8907.0 8922.2 8713.7 8776.0 8826.5 8827.7 8842.1 28145.6 38185.2 38647.4 38660.0 38769.6 3250.5 3482.1 3577.2 3578.2 4194.8 28433.6 28604.4 29011.6 29333.4 29345.4 3586.4 3669.2 3705.3 3747.6 3820.7 269398.0 270653.0 271522.0 273560.6 274895.1 32704.0 33871.8 56982.7 57354.7 57422.0 34457.8 34485.3 34597.3 34640.0 34668.7 15814.8 15995.4 16029.8 16032.0 16033.8 13198.5 13290.7 13325.9 13348.9 13351.7 8501.7 8635.7 8642.7 8651.7 8682.5 3273.9 3278.2 3360.1 3365.4 3391.7 1029.5 1047.7 1063.8 1184.1 1186.1 30341.5 30374.2 30763.5 30988.0 31201.5 1117.3 1139.4 1157.3 1242.1 1248.6 15734.4 16353.0 16406.9 16623.7 17079.5 484580.0 487796.0 492756.0 493223.0 494508.0 56821.1 57609.7 58327.7 58448.0 58469.4 1396.7 1405.4 1419.4 1434.8 1437.6 30096.2 30711.8 30842.2 31044.8 31454.0 50161.0 50243.5 50452.0 50636.2 50785.5 415424.0 423491.0 423767.0 424115.6 424831.0 42921.4 43540.6 43721.0 43743.0 45045.3 47780.0 48080.0 48317.5 48653.0 49096.0 40108.2 40188.0 40733.8 41567.6 41988.8 39110.0 39710.0 39972.0 40871.8 40979.0 37620.6 38586.8 38726.8 38775.0 40691.2 31212.4 32811.0 33015.5 33425.7 33927.0 25891.6 26099.0 26132.5 26494.9 26504.7 19:14:55 INFO - PROCESS | 4694 | 19:14:55 INFO - PROCESS | 4694 | [#2] jquery.html Cycles:180 Average:28681.13 Median:18845.55 stddev:83450.92 (442.8%) stddev-sans-first:83657.96 19:14:55 INFO - PROCESS | 4694 | Values: 378.3 378.4 380.0 381.5 382.6 17748.1 18064.0 18521.1 19235.3 19268.4 10330.8 10572.4 10680.5 10681.2 10682.5 4824.3 4840.4 5006.7 5049.8 5054.5 4977.3 5007.6 5008.8 5009.6 5010.5 4832.3 4908.2 4911.8 4968.3 4976.3 4889.3 4913.5 4971.4 4979.7 4985.0 4812.5 4856.7 4987.8 5317.4 5328.0 12480.3 12682.7 12728.5 20983.5 21898.5 2069.9 2272.4 2320.6 2379.7 2417.7 9177.3 9426.4 9451.6 9467.3 9712.7 1893.6 1963.4 1987.2 1990.7 1999.0 79022.0 81797.0 85077.0 87593.0 87772.6 10060.9 10313.1 10337.6 10517.0 10633.3 14349.7 14387.8 14396.5 14401.7 14432.9 7891.3 8140.7 8218.5 8231.1 8260.5 8162.3 8188.4 8295.1 8340.6 8398.5 4152.9 4187.5 4231.6 4288.2 4303.8 1899.5 1927.3 1969.5 1981.0 1994.6 910.8 951.1 993.0 1027.4 1048.8 17238.8 17517.2 18453.3 18821.9 19102.4 935.3 1007.3 1037.3 1043.3 1081.8 8767.3 10331.4 10503.2 10535.7 10606.2 480245.0 502737.0 508382.0 516593.0 517332.0 75421.0 96350.0 97642.5 97782.5 98046.0 1023.7 1049.4 1081.3 1092.7 1095.2 15957.4 15964.3 16021.6 16154.8 16183.0 36789.0 37061.6 37312.8 38695.6 39867.0 53609.2 59300.4 59432.4 59888.1 60199.7 8071.6 8100.1 8114.0 8125.7 8318.6 12348.2 13086.5 13125.5 13145.7 13334.7 8167.8 10913.2 11162.9 11361.4 11434.9 11425.7 11583.0 11601.5 11691.1 11837.4 11369.8 11707.8 12022.6 12066.4 12193.6 8005.3 8116.3 8170.5 8206.8 8267.0 8518.4 11322.2 11762.4 11950.8 12179.9 19:14:55 INFO - PROCESS | 4694 | 19:14:55 INFO - PROCESS | 4694 | [#3] mootools.html Cycles:180 Average:5325.51 Median:4938.60 stddev:2962.76 (60.0%) stddev-sans-first:2957.20 19:14:55 INFO - PROCESS | 4694 | Values: 1510.6 1512.8 1695.3 1784.0 1795.0 7029.5 7647.2 7711.9 8132.1 8134.0 7756.3 7770.8 7815.8 7845.1 7851.9 2208.1 2241.8 2242.0 2245.7 2249.2 2196.8 2204.1 2246.5 2255.6 2262.0 2239.8 2245.1 2248.4 2263.6 2296.1 2150.7 2158.4 2172.7 2179.0 2184.7 2132.4 2157.9 2183.9 2191.3 2202.5 7954.0 8013.5 8014.2 8042.5 8065.8 4806.7 4899.4 4919.2 4927.4 4973.1 3039.9 3130.2 3188.7 3219.9 3234.7 1006.9 1017.4 1022.7 1031.9 1049.2 10957.8 10967.3 11015.0 11034.1 11078.8 4239.2 4249.9 4317.1 4345.6 4369.3 9332.4 9376.0 9434.2 9460.1 9498.8 4916.2 4936.5 4939.0 4945.9 4954.4 3996.5 4324.2 4352.8 4402.6 4513.7 3702.2 3840.3 3843.6 3908.5 3927.1 1191.5 1209.0 1229.6 1239.0 1246.0 933.4 940.8 946.7 955.7 957.3 5212.2 5500.5 5514.0 5556.1 5579.7 424.6 425.5 429.7 431.9 438.6 3871.2 3995.3 4042.6 4104.0 4140.0 9612.4 9802.0 9903.3 9917.2 9921.5 9675.2 9717.7 9788.7 9799.5 9824.5 7432.3 7648.2 7665.0 7665.4 7684.8 5401.4 5596.4 5640.8 5694.7 5697.3 9272.1 9345.6 9385.0 9465.2 9544.9 9321.9 9423.7 9430.5 9459.5 9680.0 7211.6 7227.1 7354.5 7471.0 7485.4 7470.5 7491.2 7514.4 7520.0 7571.7 6725.1 6861.9 6881.7 6929.4 7001.5 6726.2 6803.7 6859.5 6869.6 6887.6 6346.8 6366.7 6466.3 6467.5 6595.6 4748.3 4832.6 4847.2 4887.8 4938.3 4754.6 4803.4 4839.7 4887.2 4928.6 19:14:55 INFO - PROCESS | 4694 | 19:14:55 INFO - PROCESS | 4694 | [#4] prototype.html Cycles:180 Average:5009.36 Median:5594.08 stddev:1548.36 (27.7%) stddev-sans-first:1511.70 19:14:55 INFO - PROCESS | 4694 | Values: 293.0 303.4 307.1 308.6 309.3 5363.1 5418.8 5496.8 5539.4 5647.4 5415.4 5455.7 5467.1 5484.6 5540.8 4232.8 4241.9 4260.4 4272.7 4275.0 4110.3 4226.0 4258.3 4265.7 4266.3 4153.1 4157.7 4180.8 4196.9 4213.1 4157.1 4203.3 4207.8 4213.3 4215.6 3669.4 3693.4 3710.5 3717.2 3730.9 5046.4 5349.5 5361.6 5369.8 5401.9 4789.7 4799.2 4815.4 4818.5 4823.1 5452.2 5736.3 5741.9 5813.9 5814.1 4022.2 4039.5 4056.2 4077.6 4081.8 5898.9 5936.6 5986.6 5990.8 5991.2 3978.5 4130.2 4132.4 4142.6 4157.5 4145.1 4149.5 4165.1 4173.2 4181.7 4759.8 4766.5 4782.6 4824.9 4826.2 5227.9 5743.7 5780.8 5815.7 5816.2 1503.2 1525.3 1534.6 1536.0 1536.3 1011.3 1014.7 1029.3 1040.8 1046.1 5960.2 5964.6 5989.8 5989.9 5999.7 6300.0 6319.5 6336.5 6394.3 6412.8 5835.3 5848.9 5945.4 5982.2 5988.5 3361.3 3395.9 3402.3 3404.6 3407.0 6310.9 6514.3 6525.1 6525.4 6540.6 6439.3 6442.9 6454.4 6500.7 6510.5 6364.3 6513.6 6542.9 6549.2 6561.1 6298.3 6298.4 6340.9 6345.4 6374.1 6207.5 6230.5 6242.5 6273.4 6274.2 6291.7 6575.5 6598.3 6610.2 6641.9 4331.9 4358.5 4359.8 4366.5 4371.6 6256.6 6309.6 6330.1 6367.5 6419.2 6138.9 6154.1 6185.8 6201.3 6210.1 5952.1 6068.3 6100.7 6198.4 6228.9 5950.3 5997.4 6032.9 6041.4 6065.6 6144.8 6177.7 6194.5 6206.7 6207.6 5768.3 5972.6 5990.3 5999.9 6015.3 19:14:55 INFO - PROCESS | 4694 | 19:14:55 INFO - PROCESS | 4694 | [#5] yui.html Cycles:180 Average:14602.25 Median:4708.71 stddev:17028.59 (361.6%) stddev-sans-first:17044.63 19:14:55 INFO - PROCESS | 4694 | Values: 757.8 761.7 824.9 847.1 861.5 14171.9 14422.6 14469.9 14526.4 14807.5 14310.0 14348.3 14377.6 14437.1 14441.6 800.5 824.1 825.4 829.2 832.9 822.3 823.7 824.4 826.0 830.6 860.8 863.6 863.9 867.1 868.8 855.5 856.8 858.6 859.6 862.4 621.4 625.6 627.4 628.0 628.4 14394.7 14464.4 14480.6 14552.9 14559.9 13809.4 13974.0 14014.5 14084.1 14098.6 10567.8 10609.5 10611.7 10696.4 10785.6 3770.3 3796.9 3839.8 3887.6 3924.3 53950.5 54113.2 54243.7 54434.7 54777.2 10448.5 10862.0 11006.7 11187.3 11555.2 20450.9 20566.7 20604.7 20668.8 20672.8 8007.4 8030.3 8076.9 8207.5 8346.9 4551.2 4589.8 4598.7 4643.3 4774.1 3321.3 3378.7 3386.9 3399.5 3408.7 588.4 603.6 608.1 615.3 644.8 722.7 748.7 753.3 763.5 767.5 8724.7 8945.0 8963.6 9094.2 9160.7 713.8 720.4 722.3 725.3 728.2 4138.8 4261.3 4286.2 4335.6 4342.2 56667.0 59607.4 64797.4 65909.0 66908.7 51497.7 51711.5 51940.7 55058.0 55686.2 49871.8 50149.0 50771.5 50778.7 50966.5 8960.9 8985.0 9048.7 9139.7 9152.5 33652.0 34051.3 34430.5 34541.1 35203.3 42008.4 43935.3 44201.3 44734.8 45057.5 11330.8 11658.3 11751.9 11887.1 12013.2 10184.7 10429.3 12283.0 12331.6 12437.8 11654.2 11723.1 11885.8 12018.0 12129.8 11150.2 11351.2 11374.4 11387.3 11633.8 11426.6 11463.5 11545.5 11576.9 11714.2 9786.9 9848.1 9998.0 10010.4 10128.3 9423.9 9735.7 9821.2 9828.5 9839.8 19:14:55 INFO - PROCESS | 4694 | -------- Summary: end -------- 19:14:55 INFO - PROCESS | 4694 | 19:14:56 INFO - TEST-INFO | 4694: exit 0 19:14:56 INFO - TEST-OK | dromaeo_css | took 1109625ms 19:14:56 INFO - TEST-START | kraken 19:14:56 INFO - operating with platform_type : linux_ 19:14:56 INFO - Initialising browser for kraken test... 19:14:56 INFO - TEST-INFO | started process 4928 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppCuwFm/profile http://localhost:41162/getInfo.html) 19:15:00 INFO - PROCESS | 4928 | 19:15:00 INFO - PROCESS | 4928 | (process:4997): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:15:00 INFO - PROCESS | 4928 | __metrics Screen width/height:1600/1200 19:15:00 INFO - PROCESS | 4928 | colorDepth:24 19:15:00 INFO - PROCESS | 4928 | Browser inner width/height: 1024/697 19:15:00 INFO - PROCESS | 4928 | __metrics 19:15:01 ERROR - PROCESS | 4928 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 19:15:02 INFO - TEST-INFO | 4928: exit 0 19:15:02 INFO - Browser initialized. 19:15:02 INFO - Running cycle 1/1 for kraken test... 19:15:02 INFO - TEST-INFO | started process 5048 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppCuwFm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:15:04 INFO - PROCESS | 5048 | 19:15:04 INFO - PROCESS | 5048 | (process:5109): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:15:14 INFO - PROCESS | 5048 | RSS: Main: 164048896 19:15:14 INFO - PROCESS | 5048 | 19:15:16 INFO - PROCESS | 5048 | Cycle 1(1): loaded http://localhost:41162/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41162/tests/kraken/driver.html?testName=audio-beat-detection) 19:15:17 INFO - PROCESS | 5048 | RSS: Main: 169119744 19:15:17 INFO - PROCESS | 5048 | 19:15:20 INFO - PROCESS | 5048 | Cycle 1(1): loaded http://localhost:41162/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41162/tests/kraken/driver.html?testName=audio-dft) 19:15:21 INFO - PROCESS | 5048 | RSS: Main: 172523520 19:15:21 INFO - PROCESS | 5048 | 19:15:23 INFO - PROCESS | 5048 | Cycle 1(1): loaded http://localhost:41162/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41162/tests/kraken/driver.html?testName=audio-fft) 19:15:24 INFO - PROCESS | 5048 | RSS: Main: 164827136 19:15:24 INFO - PROCESS | 5048 | 19:15:26 INFO - PROCESS | 5048 | Cycle 1(1): loaded http://localhost:41162/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41162/tests/kraken/driver.html?testName=audio-oscillator) 19:15:27 INFO - PROCESS | 5048 | RSS: Main: 165216256 19:15:27 INFO - PROCESS | 5048 | 19:15:29 INFO - PROCESS | 5048 | Cycle 1(1): loaded http://localhost:41162/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41162/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:15:30 INFO - PROCESS | 5048 | RSS: Main: 165789696 19:15:30 INFO - PROCESS | 5048 | 19:15:33 INFO - PROCESS | 5048 | Cycle 1(1): loaded http://localhost:41162/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41162/tests/kraken/driver.html?testName=imaging-darkroom) 19:15:33 INFO - PROCESS | 5048 | RSS: Main: 166244352 19:15:33 INFO - PROCESS | 5048 | 19:15:37 INFO - PROCESS | 5048 | Cycle 1(1): loaded http://localhost:41162/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41162/tests/kraken/driver.html?testName=imaging-desaturate) 19:15:37 INFO - PROCESS | 5048 | RSS: Main: 163667968 19:15:37 INFO - PROCESS | 5048 | 19:15:40 INFO - PROCESS | 5048 | Cycle 1(1): loaded http://localhost:41162/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41162/tests/kraken/driver.html?testName=json-parse-financial) 19:15:41 INFO - PROCESS | 5048 | RSS: Main: 164495360 19:15:41 INFO - PROCESS | 5048 | 19:15:42 INFO - PROCESS | 5048 | Cycle 1(1): loaded http://localhost:41162/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41162/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:15:43 INFO - PROCESS | 5048 | RSS: Main: 164413440 19:15:43 INFO - PROCESS | 5048 | 19:15:45 INFO - PROCESS | 5048 | Cycle 1(1): loaded http://localhost:41162/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41162/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:15:45 INFO - PROCESS | 5048 | RSS: Main: 164773888 19:15:45 INFO - PROCESS | 5048 | 19:15:47 INFO - PROCESS | 5048 | Cycle 1(1): loaded http://localhost:41162/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41162/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:15:48 INFO - PROCESS | 5048 | RSS: Main: 164884480 19:15:48 INFO - PROCESS | 5048 | 19:15:51 INFO - PROCESS | 5048 | Cycle 1(1): loaded http://localhost:41162/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41162/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:15:51 INFO - PROCESS | 5048 | RSS: Main: 165883904 19:15:51 INFO - PROCESS | 5048 | 19:15:54 INFO - PROCESS | 5048 | Cycle 1(1): loaded http://localhost:41162/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41162/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:15:55 INFO - PROCESS | 5048 | RSS: Main: 165232640 19:15:55 INFO - PROCESS | 5048 | 19:15:57 INFO - PROCESS | 5048 | Cycle 1(1): loaded http://localhost:41162/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41162/tests/kraken/driver.html?testName=ai-astar) 19:15:57 INFO - PROCESS | 5048 | RSS: Main: 166465536 19:15:57 INFO - PROCESS | 5048 | 19:15:57 INFO - PROCESS | 5048 | __start_tp_report 19:15:57 INFO - PROCESS | 5048 | _x_x_mozilla_page_load 19:15:57 INFO - PROCESS | 5048 | _x_x_mozilla_page_load_details 19:15:57 INFO - PROCESS | 5048 | |i|pagename|runs| 19:15:57 INFO - PROCESS | 5048 | |0;ai-astar;112;107;112;113;114;124;113;113;113;112 19:15:57 INFO - PROCESS | 5048 | |1;audio-beat-detection;165;130;157;185;132;159;157;135;193;131 19:15:57 INFO - PROCESS | 5048 | |2;audio-dft;163;162;162;163;162;186;172;163;168;164 19:15:57 INFO - PROCESS | 5048 | |3;audio-fft;76;73;74;157;73;76;75;76;169;76 19:15:57 INFO - PROCESS | 5048 | |4;audio-oscillator;93;93;141;93;93;94;149;94;94;142 19:15:57 INFO - PROCESS | 5048 | |5;imaging-gaussian-blur;117;118;117;117;118;118;117;118;117;117 19:15:57 INFO - PROCESS | 5048 | |6;imaging-darkroom;147;149;148;146;146;147;146;146;147;146 19:15:57 INFO - PROCESS | 5048 | |7;imaging-desaturate;95;96;95;95;95;95;95;95;95;95 19:15:57 INFO - PROCESS | 5048 | |8;json-parse-financial;63;61;59;60;60;59;61;87;57;65 19:15:57 INFO - PROCESS | 5048 | |9;json-stringify-tinderbox;61;64;61;62;62;62;60;62;61;61 19:15:57 INFO - PROCESS | 5048 | |10;stanford-crypto-aes;77;87;78;84;86;77;79;79;79;78 19:15:57 INFO - PROCESS | 5048 | |11;stanford-crypto-ccm;136;129;125;127;135;141;122;124;156;137 19:15:57 INFO - PROCESS | 5048 | |12;stanford-crypto-pbkdf2;177;176;172;171;170;179;171;170;169;170 19:15:57 INFO - PROCESS | 5048 | |13;stanford-crypto-sha256-iterative;70;76;69;71;68;69;69;67;69;72 19:15:57 INFO - PROCESS | 5048 | __end_tp_report 19:15:57 INFO - PROCESS | 5048 | __start_cc_report 19:15:57 INFO - PROCESS | 5048 | _x_x_mozilla_cycle_collect,847 19:15:57 INFO - PROCESS | 5048 | __end_cc_report 19:15:57 INFO - PROCESS | 5048 | __startTimestamp1461377757312__endTimestamp 19:15:57 INFO - PROCESS | 5048 | 19:15:57 INFO - PROCESS | 5048 | ------- Summary: start ------- 19:15:57 INFO - PROCESS | 5048 | Number of tests: 14 19:15:57 INFO - PROCESS | 5048 | 19:15:57 INFO - PROCESS | 5048 | [#0] ai-astar Cycles:10 Average:113.30 Median:113.00 stddev:4.22 (3.7%) stddev-sans-first:4.45 19:15:57 INFO - PROCESS | 5048 | Values: 112.0 107.0 112.0 113.0 114.0 124.0 113.0 113.0 113.0 112.0 19:15:57 INFO - PROCESS | 5048 | 19:15:57 INFO - PROCESS | 5048 | [#1] audio-beat-detection Cycles:10 Average:154.40 Median:158.00 stddev:22.59 (14.3%) stddev-sans-first:23.64 19:15:57 INFO - PROCESS | 5048 | Values: 165.0 130.0 157.0 185.0 132.0 159.0 157.0 135.0 193.0 131.0 19:15:57 INFO - PROCESS | 5048 | 19:15:57 INFO - PROCESS | 5048 | [#2] audio-dft Cycles:10 Average:166.50 Median:163.50 stddev:7.58 (4.6%) stddev-sans-first:7.93 19:15:57 INFO - PROCESS | 5048 | Values: 163.0 162.0 162.0 163.0 162.0 186.0 172.0 163.0 168.0 164.0 19:15:57 INFO - PROCESS | 5048 | 19:15:57 INFO - PROCESS | 5048 | [#3] audio-fft Cycles:10 Average:92.50 Median:75.50 stddev:37.28 (49.4%) stddev-sans-first:39.06 19:15:57 INFO - PROCESS | 5048 | Values: 76.0 73.0 74.0 157.0 73.0 76.0 75.0 76.0 169.0 76.0 19:15:57 INFO - PROCESS | 5048 | 19:15:57 INFO - PROCESS | 5048 | [#4] audio-oscillator Cycles:10 Average:108.60 Median:93.00 stddev:24.52 (26.4%) stddev-sans-first:25.35 19:15:57 INFO - PROCESS | 5048 | Values: 93.0 93.0 141.0 93.0 93.0 94.0 149.0 94.0 94.0 142.0 19:15:57 INFO - PROCESS | 5048 | 19:15:57 INFO - PROCESS | 5048 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 19:15:57 INFO - PROCESS | 5048 | Values: 117.0 118.0 117.0 117.0 118.0 118.0 117.0 118.0 117.0 117.0 19:15:57 INFO - PROCESS | 5048 | 19:15:57 INFO - PROCESS | 5048 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:1.03 (0.7%) stddev-sans-first:1.09 19:15:57 INFO - PROCESS | 5048 | Values: 147.0 149.0 148.0 146.0 146.0 147.0 146.0 146.0 147.0 146.0 19:15:57 INFO - PROCESS | 5048 | 19:15:57 INFO - PROCESS | 5048 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 19:15:57 INFO - PROCESS | 5048 | Values: 95.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 19:15:57 INFO - PROCESS | 5048 | 19:15:57 INFO - PROCESS | 5048 | [#8] json-parse-financial Cycles:10 Average:63.20 Median:61.00 stddev:8.65 (14.2%) stddev-sans-first:9.18 19:15:57 INFO - PROCESS | 5048 | Values: 63.0 61.0 59.0 60.0 60.0 59.0 61.0 87.0 57.0 65.0 19:15:57 INFO - PROCESS | 5048 | 19:15:57 INFO - PROCESS | 5048 | [#9] json-stringify-tinderbox Cycles:10 Average:61.60 Median:62.00 stddev:1.07 (1.7%) stddev-sans-first:1.12 19:15:57 INFO - PROCESS | 5048 | Values: 61.0 64.0 61.0 62.0 62.0 62.0 60.0 62.0 61.0 61.0 19:15:57 INFO - PROCESS | 5048 | 19:15:57 INFO - PROCESS | 5048 | [#10] stanford-crypto-aes Cycles:10 Average:80.40 Median:79.00 stddev:3.78 (4.8%) stddev-sans-first:3.80 19:15:57 INFO - PROCESS | 5048 | Values: 77.0 87.0 78.0 84.0 86.0 77.0 79.0 79.0 79.0 78.0 19:15:57 INFO - PROCESS | 5048 | 19:15:57 INFO - PROCESS | 5048 | [#11] stanford-crypto-ccm Cycles:10 Average:133.20 Median:135.50 stddev:10.22 (7.5%) stddev-sans-first:10.79 19:15:57 INFO - PROCESS | 5048 | Values: 136.0 129.0 125.0 127.0 135.0 141.0 122.0 124.0 156.0 137.0 19:15:57 INFO - PROCESS | 5048 | 19:15:57 INFO - PROCESS | 5048 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.50 Median:171.50 stddev:3.50 (2.0%) stddev-sans-first:3.32 19:15:57 INFO - PROCESS | 5048 | Values: 177.0 176.0 172.0 171.0 170.0 179.0 171.0 170.0 169.0 170.0 19:15:57 INFO - PROCESS | 5048 | 19:15:57 INFO - PROCESS | 5048 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.00 Median:69.50 stddev:2.54 (3.7%) stddev-sans-first:2.69 19:15:57 INFO - PROCESS | 5048 | Values: 70.0 76.0 69.0 71.0 68.0 69.0 69.0 67.0 69.0 72.0 19:15:57 INFO - PROCESS | 5048 | -------- Summary: end -------- 19:15:57 INFO - PROCESS | 5048 | 19:15:58 INFO - TEST-INFO | 5048: exit 0 19:15:58 INFO - TEST-OK | kraken | took 61928ms 19:15:58 INFO - SUITE-END | took 1171s 19:15:58 INFO - Completed test suite (00:19:31) 19:15:58 INFO - javascript benchmark 19:15:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3117.4544454720426, 3157.0528841347596, 3168.5405616185667, 3172.793768405055, 3204.2309845637055, 5260.947390526098, 5301.8939621207555, 5305.787768489261, 5335.4664533546675, 5360.3299587551555, 5252.395974462938, 5377.489138531833, 5421.756020979055, 5461.399246082928, 5467.835964921059, 4781.66528343017, 4837.492063333352, 4918.114739346916, 4919.237518184687, 4921.901561968759, 814.8557673490155, 4757.333973243732, 4831.830885918994, 4852.441969173555, 4903.950960490385, 4840.983393487372, 4862.878428039292, 4863.294822250771, 4871.926921096187, 4873.463918968911, 4835.782389792468, 4843.75781210938, 4846.5153484651255, 4859.82990595331, 4882.584980276681, 4744.881377965544, 4821.662483626147, 4858.1983972644475, 4878.682885612424, 4910.607151427877, 5200.915122851772, 5209.114450543417, 5247.212918062283, 5258.6581872178185, 5333.466653334674, 5595.356533998602, 5730.6275092119295, 5737.282839645044, 5740.311162660508, 5752.856178595527, 5796.188533605298, 5821.62159459638, 5835.270591176103, 5870.090136028923, 5883.17635531026, 5329.813456529003, 5360.758765855546, 5362.490563396471, 5366.114591092465, 5367.0339338918975, 5649.745761440745, 5786.392428794916, 5806.30324361071, 5809.331926828469, 5827.4172582741385, 5599.0, 5600.5799565032785, 5602.963451761437, 5616.9157462638095, 5642.887142257132, 5665.433456654384, 5673.801416950387, 5674.978503869261, 5681.943180568224, 5689.061304884731, 5515.338159420895, 5574.832755017356, 5630.324361076697, 5632.2678051853, 5643.633163844419, 5673.546116310686, 5694.800681976111, 5695.487406133468, 5705.030144875298, 5741.45456181662, 4345.543717909637, 4369.148016136886, 4388.078503514298, 4389.144116897174, 4392.956070439319, 3798.0315019669806, 3872.8257228424786, 3941.7043721720984, 3949.2299001694396, 3975.900602484961, 5399.622026458111, 5412.323459567554, 5418.970395624819, 5429.457054294539, 5449.128139497661, 5647.915281270784, 5692.715364231772, 5697.857553561194, 5705.62913410627, 5713.4000929902595, 5357.598180136505, 5418.647787893774, 5483.341998960151, 5532.778688852401, 5579.218909352694, 4940.950590494049, 4952.900941981212, 4966.751662416937, 4989.925151122736, 4998.375203099613, 5933.139694744238, 5951.077582974559, 5956.493698035629, 5976.970115149396, 5978.312494063239, 5609.298837645294, 5624.100143977026, 5659.915101273402, 5680.289963754531, 5685.0335442973965, 5893.6463812171405, 5916.727903500596, 5928.34788173292, 5941.58408911372, 5942.286925568959, 5496.642718223303, 5609.49514543693, 5622.1566764983945, 5629.915551266652, 5631.183478395692, 5722.914156287576, 5773.162891380643, 5782.132680098019, 5808.94191058084, 5828.708564571839, 5475.67145971243, 5494.505494505353, 5494.862628434321, 5512.972435137959, 5514.6691198528215, 5437.809676661298, 5479.506844384025, 5480.534154596745, 5532.944670553243, 5535.3357597087, 5542.7782888685615, 5547.33431988164, 5555.861103472445, 5561.082421400423, 5602.579806514446, 5629.605927585029, 5630.690312032878, 5637.689927054052, 5644.2380278663495, 5667.801626943037, 5408.242846001642, 5414.160805075219, 5497.038018346853, 5553.278073850373, 5562.471565201299], "value": 5238.58793880268, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [599.3556926304221, 642.5405834828099, 655.9439302722616, 662.6885363878976, 685.6708779785706, 36836.26327473449, 37929.620703792985, 38110.61889381112, 38289.23421531568, 38337.80831095848, 38673.80663096688, 39209.411858822066, 39247.41128883062, 39328.410073848914, 39343.40984885222, 8714.0, 8873.3344999125, 8900.599473023729, 8909.242714369255, 8931.062238464965, 8746.212840844322, 8874.511901845395, 8880.822383552326, 8898.28813694906, 8899.288056955427, 8872.15714507124, 8955.19403253707, 8955.731328060168, 8956.910430895672, 8958.820823583525, 8828.867566986468, 8877.778055548599, 8884.422512536665, 8906.955465222632, 8922.197002269762, 8713.69502067431, 8776.0, 8826.470411775314, 8827.69103081389, 8842.115788421172, 28145.57781633277, 38185.23629527394, 38647.42028869569, 38660.0, 38769.61230387716, 3250.496173093151, 3482.112061424346, 3577.2487777566744, 3578.2127931854952, 4194.769287689176, 28433.57349639757, 28604.427911441653, 29011.562183924027, 29333.413331733245, 29345.41309173826, 3586.4082426399614, 3669.21111960927, 3705.2589482103685, 3747.6439738224826, 3820.6943444524372, 269398.0, 270653.0, 271522.0, 273560.6321968397, 274895.12762181106, 32704.0, 33871.83064084664, 56982.71508642513, 57354.7132264336, 57422.0, 34457.827710861784, 34485.310293793984, 34597.30805383878, 34640.0, 34668.653313467046, 15814.841851581567, 15995.360185592446, 16029.759553606706, 16032.0, 16033.759493607606, 13198.472061117447, 13290.66773330655, 13325.8673012795, 13348.93325533366, 13351.73296534064, 8501.65993360271, 8635.6977505787, 8642.740717778477, 8651.740447786577, 8682.479051256945, 3273.8690452382116, 3278.1968417737808, 3360.1095709636966, 3365.3774051800497, 3391.660833916638, 1029.4852573713144, 1047.7427087495037, 1063.7659714862718, 1184.088252045937, 1186.0867132308074, 30341.544876826865, 30374.240643983634, 30763.54778163813, 30988.0, 31201.531977020364, 1117.3351855645878, 1139.4473680265064, 1157.288267715366, 1242.130508643953, 1248.5942068827667, 15734.370625174864, 16353.0, 16406.917965410335, 16623.6675266494, 17079.537108715904, 484580.0, 487796.0, 492756.0, 493223.0, 494508.0, 56821.147682784795, 57609.711951439975, 58327.708361457924, 58448.0, 58469.4153058464, 1396.7206558688304, 1405.3816320818808, 1419.3754747910887, 1434.763264061439, 1437.590286768287, 30096.24759381033, 30711.846440767655, 30842.228944276572, 31044.844775775975, 31454.0, 50161.0, 50243.497565023885, 50451.99096018133, 50636.24045639245, 50785.492145078075, 415424.0, 423491.0, 423767.0, 424115.6382654201, 424831.0, 42921.35617965795, 43540.56459435492, 43721.0, 43743.0, 45045.32432013588, 47780.0, 48080.0, 48317.5168248313, 48653.0, 49096.0, 40108.23902285793, 40188.0, 40733.79633101934, 41567.58432415758, 41988.790056049525, 39110.0, 39710.0, 39972.0, 40871.79564102161, 40979.0, 37620.62379376281, 38586.80706596449, 38726.80636596799, 38775.0, 40691.18617627572, 31212.375752485277, 32811.0, 33015.50476742899, 33425.66574334226, 33927.0, 25891.611625826004, 26099.0, 26132.477350452504, 26494.86752566302, 26504.734952650226], "value": 18504.02528290162, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [378.2907049282597, 378.41534828689663, 379.9962000379996, 381.4716617484786, 382.60018280896463, 17748.11259437028, 18064.0, 18521.0739463027, 19235.326763563276, 19268.4219473416, 10330.845037324447, 10572.418516981563, 10680.519376628052, 10681.198910081735, 10682.465876706154, 4824.324594556765, 4840.370751802261, 5006.674566153207, 5049.77276022578, 5054.494550544953, 4977.303177555145, 5007.574356179729, 5008.824691135811, 5009.574186194178, 5010.498950104997, 4832.251001094836, 4908.165611845995, 4911.82808601699, 4968.254761785725, 4976.278439626252, 4889.291052797343, 4913.508649135094, 4971.37857767779, 4979.7261150636705, 4985.0, 4812.470628230892, 4856.708597484162, 4987.750612469398, 5317.441668624778, 5328.0, 12480.251184928933, 12682.74634507314, 12728.490860365575, 20983.524712930604, 21898.45253868666, 2069.855110142291, 2272.420532764151, 2320.62679821199, 2379.710360931011, 2417.746136655661, 9177.311701622404, 9426.434413935185, 9451.621935122586, 9467.289953253534, 9712.737344145287, 1893.6496748101645, 1963.4242675662406, 1987.175322241268, 1990.6814909614393, 1998.980010199894, 79022.0, 81797.0, 85077.0, 87593.0, 87772.56113719454, 10060.899391006142, 10313.12338451225, 10337.638182663572, 10517.0, 10633.255672103034, 14349.713005739826, 14387.78418323726, 14396.496122635657, 14401.711965760836, 14432.927835360966, 7891.289783919475, 8140.715074972348, 8218.506889586644, 8231.135730748185, 8260.504369737835, 8162.26539611426, 8188.426810123234, 8295.087540370554, 8340.62467188978, 8398.454100483448, 4152.875413737593, 4187.45563076798, 4231.640310573574, 4288.224258246441, 4303.806328715215, 1899.5061284066242, 1927.2772710233662, 1969.4780883065998, 1980.9900950495155, 1994.5512259741731, 910.7814124610046, 951.0869565217331, 992.980140397188, 1027.4143738069379, 1048.816457120001, 17238.827611723973, 17517.211725472385, 18453.261869525337, 18821.90589047046, 19102.426927192206, 935.3265648732902, 1007.2646967713611, 1037.2894567221476, 1043.2957753516346, 1081.7620123572801, 8767.298616110696, 10331.380117192843, 10503.2122590806, 10535.736606584896, 10606.15150787935, 480245.0, 502737.0, 508382.0, 516593.0, 517332.0, 75421.0, 96350.0, 97642.51178744061, 97782.51108744553, 98046.01953980369, 1023.6673081248624, 1049.3861091261545, 1081.3187691754144, 1092.7268182954263, 1095.1676725688376, 15957.361705531648, 15964.281607327466, 16021.599460013593, 16154.838451615333, 16183.0, 36789.0, 37061.62938370582, 37312.81343593264, 38695.6130438692, 39867.0, 53609.19586206288, 59300.40699592949, 59432.40567594269, 59888.101678473984, 60199.69900150471, 8071.596420179085, 8100.149484304063, 8113.959430202811, 8125.67497300125, 8318.62566184511, 12348.197367171106, 13086.476540938256, 13125.54060607874, 13145.73708525805, 13334.666633334244, 8167.836643266983, 10913.23607347478, 11162.888371116185, 11361.431928403712, 11434.885651143382, 11425.714357141138, 11583.0, 11601.477933492844, 11691.123165762432, 11837.408129593314, 11369.772604548029, 11707.824382634097, 12022.63932082039, 12066.396680166132, 12193.573224937085, 8005.319547838266, 8116.269535741575, 8170.509769413617, 8206.753797386087, 8267.049289331804, 8518.403711740119, 11322.150838687296, 11762.3530705812, 11950.760984780429, 12179.878201217874], "value": 8641.229863455741, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1510.5770384292398, 1512.7806468062129, 1695.2795062098605, 1784.0, 1794.9820501794977, 7029.543079699816, 7647.158812530617, 7711.922880771198, 8132.105468398471, 8133.959330203348, 7756.301932826044, 7770.8445831083345, 7815.765527034184, 7845.09781375142, 7851.92148078519, 2208.083645287204, 2241.753407125223, 2242.0, 2245.65192395179, 2249.2465024216826, 2196.8242540596716, 2204.1293688992837, 2246.4608493961414, 2255.616545187322, 2261.977380226193, 2239.7760223977552, 2245.079517397867, 2248.3816950338705, 2263.569921714877, 2296.1045192374986, 2150.6881502182173, 2158.4280165756086, 2172.663237198237, 2178.9564208715815, 2184.7050648162453, 2132.4029271803765, 2157.870527768339, 2183.9235626753148, 2191.3206905859233, 2202.48241663209, 7954.0, 8013.51918884863, 8014.158513356072, 8042.477238979448, 8065.798355041112, 4806.735629540374, 4899.363082799249, 4919.2129259318335, 4927.408710954708, 4973.055119527278, 3039.893603723859, 3130.2180442709027, 3188.6651901550467, 3219.919502012445, 3234.7250483708913, 1006.9496525173786, 1017.3997341568436, 1022.7494263905317, 1031.9226058045676, 1049.150188347441, 10957.83563246544, 10967.341959482377, 11015.0, 11034.062104721108, 11078.833817492745, 4239.194553034913, 4249.893752656209, 4317.136572685476, 4345.587169218919, 4369.2790689536505, 9332.44005359667, 9375.953120234355, 9434.245260379153, 9460.053994600623, 9498.810023799624, 4916.164252077156, 4936.506349365035, 4938.950610493921, 4945.876353091202, 4954.405471343462, 3996.5204175499125, 4324.200022995756, 4352.782360882006, 4402.647788176938, 4513.661475389359, 3702.22253326799, 3840.2895464339185, 3843.577206507282, 3908.5309762828642, 3927.096767743435, 1191.4519321112211, 1208.9818652720217, 1229.5819421396768, 1238.9530846434748, 1246.0343233993729, 933.4119504712123, 940.83535381308, 946.7396465971913, 955.6846240740539, 957.2676902169845, 5212.166053431432, 5500.532454741312, 5513.972430137824, 5556.083246264402, 5579.721013949286, 424.5775453423863, 425.4936625415745, 429.7056516286354, 431.8920269932517, 438.6030642268752, 3871.2451072041245, 3995.2832770278187, 4042.595740425934, 4103.97948010258, 4140.047789008545, 9612.375195612403, 9801.950990245146, 9903.306768526278, 9917.206623470105, 9921.454320012468, 9675.225981921429, 9717.708468745948, 9788.706338809847, 9799.461029643438, 9824.508774561244, 7432.3310902019075, 7648.158702542716, 7664.96522969392, 7665.386769058574, 7684.769456916301, 5401.432849550741, 5596.4463213250665, 5640.830775076754, 5694.686792226467, 5697.259356283656, 9272.072792720945, 9345.579448924951, 9384.95307523458, 9465.242780577675, 9544.856827147738, 9321.906780932104, 9423.717288481357, 9430.481323527272, 9459.527023648652, 9680.0, 7211.567305961659, 7227.060482137288, 7354.521956072838, 7470.962645186739, 7485.4385921055045, 7470.514416562906, 7491.213422590549, 7514.398848092249, 7520.0, 7571.697132114654, 6725.125733654593, 6861.862762744817, 6881.690323935335, 6929.44564434834, 7001.50989430735, 6726.192856857208, 6803.727850886107, 6859.485538584527, 6869.622170780655, 6887.586744795329, 6346.777862774781, 6366.713497892513, 6466.288708242184, 6467.450266727381, 6595.604263744191, 4748.287756836364, 4832.589229915497, 4847.224444088929, 4887.780049897692, 4938.259261110862, 4754.595859351855, 4803.423589169322, 4839.733814640088, 4887.242477416006, 4928.556429921325], "value": 4242.596692441621, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [292.9750971167449, 303.3659651328723, 307.13081978002253, 308.60036253052294, 309.299436775703, 5363.115086010804, 5418.756155972981, 5496.835094947153, 5539.390667026629, 5647.407022262665, 5415.350157981038, 5455.672659640424, 5467.059193986137, 5484.588655850807, 5540.750666220019, 4232.809523571439, 4241.851535196269, 4260.403543503897, 4272.743635381887, 4274.957250427503, 4110.321796903522, 4225.957740422587, 4258.339957306607, 4265.680073994447, 4266.338717498793, 4153.127843152926, 4157.690327546813, 4180.811863466151, 4196.895077623069, 4213.094184750278, 4157.147784704129, 4203.327467605199, 4207.768572728499, 4213.304804707204, 4215.57844215576, 3669.43123815809, 3693.445983102529, 3710.4805327254207, 3717.1636381814146, 3730.9067273318115, 5046.419661738911, 5349.518543331119, 5361.597880159004, 5369.838904832861, 5401.864953376158, 4789.712617242942, 4799.2321228603605, 4815.374001379833, 4818.469968303484, 4823.13183626947, 5452.182172674091, 5736.3403208631125, 5741.913871291934, 5813.912791308134, 5814.081353153491, 4022.215667944752, 4039.454673619053, 4056.1887622475624, 4077.6126268004787, 4081.836726530965, 5898.941010589925, 5936.5547583931375, 5986.640801551877, 5990.801839632091, 5991.172692328882, 3978.482797236341, 4130.194612050681, 4132.40080188371, 4142.627163555234, 4157.459530261047, 4145.108801607669, 4149.522804877417, 4165.10487728083, 4173.24881521323, 4181.686373521998, 4759.809607615656, 4766.523347665206, 4782.617390608743, 4824.903501929942, 4826.155422801066, 5227.947720522746, 5743.655380677173, 5780.826575202751, 5815.714121521327, 5816.214811000461, 1503.158231390403, 1525.313608875988, 1534.6010037390358, 1536.0015989606845, 1536.2702716209935, 1011.3476807459148, 1014.6955913226003, 1029.25893356783, 1040.7918416316768, 1046.100353695821, 5960.225170727777, 5964.642121472725, 5989.8203053908455, 5989.940100599026, 5999.700014999233, 6299.96850015747, 6319.46284565817, 6336.461400780985, 6394.26465956421, 6412.775552855627, 5835.299764028344, 5848.883022339614, 5945.384031026335, 5982.162497250389, 5988.4909782668965, 3361.310931259086, 3395.9151021224175, 3402.2515046689687, 3404.5744281964753, 3406.982965085159, 6310.9368906311265, 6514.348565143542, 6525.11910892033, 6525.4453371463005, 6540.640264785482, 6439.291677915426, 6442.871142577123, 6454.354139694442, 6500.674966251763, 6510.479161667055, 6364.299927008025, 6513.609183449008, 6542.934570654233, 6549.214094308809, 6561.1142495763415, 6298.275698294755, 6298.370162983665, 6340.873182536416, 6345.365463453618, 6374.107624932606, 6207.54122781137, 6230.532710046674, 6242.500599951902, 6273.435390814849, 6274.1843560336865, 6291.716872740646, 6575.539712220098, 6598.3401659833635, 6610.173728283965, 6641.933580664131, 4331.891702707458, 4358.498772641186, 4359.825606975685, 4366.476022877275, 4371.562843715603, 6256.5620406572925, 6309.589876658002, 6330.113784070142, 6367.522435817425, 6419.165508483868, 6138.938610613836, 6154.076813513724, 6185.752569897334, 6201.255849298113, 6210.130581718653, 5952.136940143741, 6068.302145253352, 6100.664463454553, 6198.380161983766, 6228.937710622836, 5950.256217972754, 5997.370276120944, 6032.8793424132145, 6041.426064523863, 6065.636061836304, 6144.846378840565, 6177.660228687465, 6194.473469755121, 6206.689665516797, 6207.565470417208, 5768.336641286306, 5972.64164150135, 5990.281166260077, 5999.850003749942, 6015.308239552507], "value": 4505.9588916023595, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [757.7575175943697, 761.6762875777797, 824.9463784853984, 847.1316900177318, 861.4960248254771, 14171.92914035431, 14422.639434014154, 14469.855301446982, 14526.418943242257, 14807.481738139168, 14310.0, 14348.282585870717, 14377.640558986004, 14437.061590996578, 14441.566752997427, 800.535689300206, 824.1017291152642, 825.4098319701412, 829.1625458287114, 832.9458585191943, 822.2969361196181, 823.6911158315631, 824.3570015387977, 825.9793505162389, 830.5847076461769, 860.8235311761106, 863.568215892054, 863.9265662418702, 867.1112110087148, 868.7741187291318, 855.5422848775937, 856.8072183758667, 858.5921687198593, 859.6389516403094, 862.4437237981498, 621.4003486635373, 625.5871125057486, 627.3914303125961, 627.9874402511924, 628.3904612525843, 14394.712105757932, 14464.421423143061, 14480.637984050378, 14552.92723536386, 14559.927200364036, 13809.378577963915, 13974.0, 14014.509492167826, 14084.084534505328, 14098.577042688736, 10567.841482377771, 10609.522571484302, 10611.681649550526, 10696.411697356642, 10785.5685772569, 3770.3213421584105, 3796.943045854287, 3839.8464061437508, 3887.61123887609, 3924.3132451820816, 53950.46049539494, 54113.1883021755, 54243.72878135584, 54434.72782636061, 54777.1783423249, 10448.512517381772, 10862.0, 11006.655117151024, 11187.272827266203, 11555.2489088209, 20450.897745511178, 20566.69149962752, 20604.690929636068, 20668.793312066686, 20672.79327206739, 8007.359411247086, 8030.277275045157, 8076.9192308077345, 8207.466514676527, 8346.874796878052, 4551.158035763395, 4589.816407343669, 4598.747068911175, 4643.326717625993, 4774.092922344744, 3321.2693207494312, 3378.7465940054594, 3386.9153271167925, 3399.456087026064, 3408.710259627959, 588.4321629627344, 603.5594016368076, 608.0575108581769, 615.3323643846387, 644.7968889799698, 722.6567380494223, 748.7042618165794, 753.2618034326281, 763.5151678684076, 767.54331172952, 8724.65101395937, 8944.955275223581, 8963.551822408854, 9094.181523662903, 9160.725178244664, 713.8183332341895, 720.4272603280405, 722.3210182428501, 725.26747984536, 728.1589763822793, 4138.751674899516, 4261.275583150872, 4286.164197981364, 4335.609795118455, 4342.240107981091, 56667.0, 59607.40392596105, 64797.352026480075, 65909.0, 66908.6654566724, 51497.74251128795, 51711.48288517067, 51940.74029629903, 55058.0, 55686.16470752942, 49871.75064124729, 50149.0, 50771.492285076674, 50778.74610626997, 50966.490335096176, 8960.865587016331, 8985.0, 9048.728538143867, 9139.725808225763, 9152.496612686366, 33652.0, 34051.31897362089, 34430.48354274638, 34541.13647158841, 35203.29593408169, 42008.36987445252, 43935.34096988484, 44201.33697994468, 44734.77632611946, 45057.549424505334, 11330.773384532427, 11658.300501969909, 11751.882481175078, 11887.108466864847, 12013.159078864395, 10184.694459166238, 10429.26995110335, 12283.0, 12331.630051098482, 12437.813432798695, 11654.242474239147, 11723.062155027406, 11885.821712674144, 12018.0, 12129.818052729393, 11150.163737719866, 11351.205415620827, 11374.43127843621, 11387.316760994367, 11633.767324653629, 11426.600068997544, 11463.541458341906, 11545.538178472767, 11576.942115289707, 11714.23857449263, 9786.85319720219, 9848.113669769755, 9997.950010249902, 10010.399376037461, 10128.291019628556, 9423.858642120511, 9735.659251926148, 9821.165200958, 9828.459434731158, 9839.754006149904], "value": 6651.129815604451, "unit": "score"}], "name": "dromaeo_css", "value": 6884.970758705295, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 107.0, 112.0, 113.0, 114.0, 124.0, 113.0, 113.0, 113.0, 112.0], "value": 113.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 130.0, 157.0, 185.0, 132.0, 159.0, 157.0, 135.0, 193.0, 131.0], "value": 154.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 162.0, 163.0, 162.0, 186.0, 172.0, 163.0, 168.0, 164.0], "value": 166.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 73.0, 74.0, 157.0, 73.0, 76.0, 75.0, 76.0, 169.0, 76.0], "value": 92.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 141.0, 93.0, 93.0, 94.0, 149.0, 94.0, 94.0, 142.0], "value": 108.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 117.0, 118.0, 118.0, 117.0, 118.0, 117.0, 117.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 149.0, 148.0, 146.0, 146.0, 147.0, 146.0, 146.0, 147.0, 146.0], "value": 146.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 61.0, 59.0, 60.0, 60.0, 59.0, 61.0, 87.0, 57.0, 65.0], "value": 63.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 64.0, 61.0, 62.0, 62.0, 62.0, 60.0, 62.0, 61.0, 61.0], "value": 61.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 87.0, 78.0, 84.0, 86.0, 77.0, 79.0, 79.0, 79.0, 78.0], "value": 80.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 129.0, 125.0, 127.0, 135.0, 141.0, 122.0, 124.0, 156.0, 137.0], "value": 133.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 176.0, 172.0, 171.0, 170.0, 179.0, 171.0, 170.0, 169.0, 170.0], "value": 172.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 76.0, 69.0, 71.0, 68.0, 69.0, 69.0, 67.0, 69.0, 72.0], "value": 70.0, "unit": "score"}], "name": "kraken", "value": 1575.5, "alertThreshold": 2.0}]} 19:15:58 INFO - Return code: 0 19:15:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 19:15:58 ERROR - # TBPL SUCCESS # 19:15:58 INFO - Running post-action listener: _resource_record_post_action 19:15:58 INFO - Running post-run listener: _resource_record_post_run 19:15:59 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 8192; Write bytes: 534822912; Read time: 160; Write time: 432248 19:15:59 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 244613120; Read time: 0; Write time: 292280 19:15:59 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 8192; Write bytes: 290021376; Read time: 160; Write time: 139968 19:15:59 INFO - Running post-run listener: _upload_blobber_files 19:15:59 INFO - Blob upload gear active. 19:15:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:15:59 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:15:59 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-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:15:59 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-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:16:00 INFO - (blobuploader) - INFO - Open directory for files ... 19:16:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:16:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:16:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:16:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:16:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:16:01 INFO - (blobuploader) - INFO - Done attempting. 19:16:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:16:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:16:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:16:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:16:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:16:02 INFO - (blobuploader) - INFO - Done attempting. 19:16:02 INFO - (blobuploader) - INFO - Iteration through files over. 19:16:02 INFO - Return code: 0 19:16:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:16:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:16:02 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4376a8d85e92f106e12a3386063c4e0a0b047ea19b77150b6917ac36321cfcf34ca73e165e51d6a3f866f39a2663372d195159b8443ae1cefdd603c9981a9464", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5354d0ca5a357ed4cd59802ece4b85adc87d9ab8e5bb5a1ac2fa3f7b90c47f6d9d32bbe87194824bbedae40d5fbd780e0fe896108459bb53ef21dcdaefc7f9fb"} 19:16:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:16:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:16:02 INFO - Contents: 19:16:02 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4376a8d85e92f106e12a3386063c4e0a0b047ea19b77150b6917ac36321cfcf34ca73e165e51d6a3f866f39a2663372d195159b8443ae1cefdd603c9981a9464", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5354d0ca5a357ed4cd59802ece4b85adc87d9ab8e5bb5a1ac2fa3f7b90c47f6d9d32bbe87194824bbedae40d5fbd780e0fe896108459bb53ef21dcdaefc7f9fb"} 19:16:02 INFO - Running post-run listener: copy_logs_to_upload_dir 19:16:02 INFO - Copying logs to upload dir... 19:16:02 INFO - mkdir: /builds/slave/test/build/upload/logs 19:16:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.112419 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-04-22 19:16:02.057806) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-22 19:16:02.061213) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1461370729.204741-1070592121 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-Inbound/sha512/4376a8d85e92f106e12a3386063c4e0a0b047ea19b77150b6917ac36321cfcf34ca73e165e51d6a3f866f39a2663372d195159b8443ae1cefdd603c9981a9464", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5354d0ca5a357ed4cd59802ece4b85adc87d9ab8e5bb5a1ac2fa3f7b90c47f6d9d32bbe87194824bbedae40d5fbd780e0fe896108459bb53ef21dcdaefc7f9fb"} build_url:https://queue.taskcluster.net/v1/task/dXMD-g5HS_6V2K5vuC86uQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011319 build_url: 'https://queue.taskcluster.net/v1/task/dXMD-g5HS_6V2K5vuC86uQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4376a8d85e92f106e12a3386063c4e0a0b047ea19b77150b6917ac36321cfcf34ca73e165e51d6a3f866f39a2663372d195159b8443ae1cefdd603c9981a9464", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5354d0ca5a357ed4cd59802ece4b85adc87d9ab8e5bb5a1ac2fa3f7b90c47f6d9d32bbe87194824bbedae40d5fbd780e0fe896108459bb53ef21dcdaefc7f9fb"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-22 19:16:02.086879) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 19:16:02.087239) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1461370729.204741-1070592121 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004506 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 19:16:02.171548) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-22 19:16:02.172098) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-22 19:16:02.172586) ========= ========= Total master_lag: 0.31 =========