builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-065 starttime: 1461349439.28 results: success (0) buildid: 20160422083248 builduid: 9f962c054afb47e89301c72130465769 revision: df4e550128b976a664216e57f78f80c36d78f275 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-22 11:23:59.276871) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-22 11:23:59.277295) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-22 11:23:59.277570) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-22 11:23:59.293733) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 11:23:59.294053) ========= 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=523ca41ca1e0623de333ad52000001bf-1461349438.743498-1884361186 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-22 11:23:59-- 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% 70.5M=0s 2016-04-22 11:23:59 (70.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.121853 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 11:23:59.428896) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 11:23:59.429442) ========= 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=523ca41ca1e0623de333ad52000001bf-1461349438.743498-1884361186 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015803 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 11:23:59.478445) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-22 11:23:59.478804) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev df4e550128b976a664216e57f78f80c36d78f275 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev df4e550128b976a664216e57f78f80c36d78f275 --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=523ca41ca1e0623de333ad52000001bf-1461349438.743498-1884361186 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-22 11:23:59,691 truncating revision to first 12 chars 2016-04-22 11:23:59,691 Setting DEBUG logging. 2016-04-22 11:23:59,691 attempt 1/10 2016-04-22 11:23:59,692 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/df4e550128b9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-22 11:24:00,466 unpacking tar archive at: fx-team-df4e550128b9/testing/mozharness/ program finished with exit code 0 elapsedTime=1.050339 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-22 11:24:00.541995) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-22 11:24:00.542347) ========= script_repo_revision: df4e550128b976a664216e57f78f80c36d78f275 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-22 11:24:00.542744) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-22 11:24:00.543062) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-22 11:24:00.552203) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 27 secs) (at 2016-04-22 11:24:00.552480) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=523ca41ca1e0623de333ad52000001bf-1461349438.743498-1884361186 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:24:00 INFO - MultiFileLogger online at 20160422 11:24:00 in /builds/slave/test 11:24:00 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 11:24:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:24:00 INFO - {'append_to_log': False, 11:24:00 INFO - 'base_work_dir': '/builds/slave/test', 11:24:00 INFO - 'blob_upload_branch': 'Fx-Team', 11:24:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:24:00 INFO - 'branch': 'Fx-Team', 11:24:00 INFO - 'buildbot_json_path': 'buildprops.json', 11:24:00 INFO - 'config_files': ('talos/linux_config.py',), 11:24:00 INFO - 'default_actions': ('clobber', 11:24:00 INFO - 'read-buildbot-config', 11:24:00 INFO - 'download-and-extract', 11:24:00 INFO - 'populate-webroot', 11:24:00 INFO - 'create-virtualenv', 11:24:00 INFO - 'install', 11:24:00 INFO - 'run-tests'), 11:24:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:24:00 INFO - 'download_minidump_stackwalk': True, 11:24:00 INFO - 'download_symbols': 'ondemand', 11:24:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:24:00 INFO - 'tooltool.py': '/tools/tooltool.py', 11:24:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:24:00 INFO - '/tools/misc-python/virtualenv.py')}, 11:24:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:24:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:24:00 INFO - 'installer_path': 'installer.exe', 11:24:00 INFO - 'log_level': 'info', 11:24:00 INFO - 'log_name': 'talos', 11:24:00 INFO - 'log_to_console': True, 11:24:00 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:24:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:24:00 INFO - 'opt_config_files': (), 11:24:00 INFO - 'pip_index': False, 11:24:00 INFO - 'sps_profile': False, 11:24:00 INFO - 'sps_profile_interval': 0, 11:24:00 INFO - 'suite': 'dromaeojs-e10s', 11:24:00 INFO - 'system_bits': '32', 11:24:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:24:00 INFO - 'title': 'talos-linux64-ix-065', 11:24:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:24:00 INFO - 'use_talos_json': True, 11:24:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:24:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:24:00 INFO - 'work_dir': 'build'} 11:24:00 INFO - ##### 11:24:00 INFO - ##### Running clobber step. 11:24:00 INFO - ##### 11:24:00 INFO - Running pre-action listener: _resource_record_pre_action 11:24:00 INFO - Running main action method: clobber 11:24:00 INFO - rmtree: /builds/slave/test/build 11:24:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:24:01 INFO - Running post-action listener: _resource_record_post_action 11:24:01 INFO - ##### 11:24:01 INFO - ##### Running read-buildbot-config step. 11:24:01 INFO - ##### 11:24:01 INFO - Running pre-action listener: _resource_record_pre_action 11:24:01 INFO - Running main action method: read_buildbot_config 11:24:01 INFO - Using buildbot properties: 11:24:01 INFO - { 11:24:01 INFO - "project": "", 11:24:01 INFO - "product": "firefox", 11:24:01 INFO - "script_repo_revision": "production", 11:24:01 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 11:24:01 INFO - "repository": "", 11:24:01 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 11:24:01 INFO - "buildid": "20160422083248", 11:24:01 INFO - "pgo_build": "True", 11:24:01 INFO - "basedir": "/builds/slave/test", 11:24:01 INFO - "buildnumber": 682, 11:24:01 INFO - "slavename": "talos-linux64-ix-065", 11:24:01 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:24:01 INFO - "platform": "ubuntu64_hw", 11:24:01 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 11:24:01 INFO - "branch": "fx-team", 11:24:01 INFO - "repo_path": "integration/fx-team", 11:24:01 INFO - "revision": "df4e550128b976a664216e57f78f80c36d78f275", 11:24:01 INFO - "stage_platform": "linux64-pgo", 11:24:01 INFO - "builduid": "9f962c054afb47e89301c72130465769", 11:24:01 INFO - "slavebuilddir": "test" 11:24:01 INFO - } 11:24:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/Zx-wswNnS1qxZsl05YdR2Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 11:24:01 INFO - Running post-action listener: _resource_record_post_action 11:24:01 INFO - ##### 11:24:01 INFO - ##### Running download-and-extract step. 11:24:01 INFO - ##### 11:24:01 INFO - Running pre-action listener: _resource_record_pre_action 11:24:01 INFO - Running main action method: download_and_extract 11:24:01 INFO - mkdir: /builds/slave/test/build/tests 11:24:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:24:01 INFO - https://queue.taskcluster.net/v1/task/Zx-wswNnS1qxZsl05YdR2Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 11:24:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zx-wswNnS1qxZsl05YdR2Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 11:24:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zx-wswNnS1qxZsl05YdR2Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 11:24:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zx-wswNnS1qxZsl05YdR2Q/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 11:24:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zx-wswNnS1qxZsl05YdR2Q/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 11:24:02 INFO - Downloaded 1361 bytes. 11:24:02 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 11:24:02 INFO - Using the following test package requirements: 11:24:02 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 11:24:02 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:24:02 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:24:02 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:24:02 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:24:02 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:24:02 INFO - u'jsshell-linux-x86_64.zip'], 11:24:02 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:24:02 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:24:02 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 11:24:02 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:24:02 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:24:02 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:24:02 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:24:02 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:24:02 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:24:02 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:24:02 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:24:02 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:24: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')]} 11:24:02 INFO - https://queue.taskcluster.net/v1/task/Zx-wswNnS1qxZsl05YdR2Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:24:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zx-wswNnS1qxZsl05YdR2Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 11:24:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zx-wswNnS1qxZsl05YdR2Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 11:24:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zx-wswNnS1qxZsl05YdR2Q/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 11:24:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zx-wswNnS1qxZsl05YdR2Q/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 11:24:03 INFO - Downloaded 23857749 bytes. 11:24:03 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'] 11:24:03 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 11:24:04 INFO - Return code: 0 11:24:04 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 11:24:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:24:04 INFO - https://queue.taskcluster.net/v1/task/Zx-wswNnS1qxZsl05YdR2Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:24:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zx-wswNnS1qxZsl05YdR2Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 11:24:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zx-wswNnS1qxZsl05YdR2Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 11:24:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zx-wswNnS1qxZsl05YdR2Q/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 11:24:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zx-wswNnS1qxZsl05YdR2Q/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 11:24:06 INFO - Downloaded 23857749 bytes. 11:24:06 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:24:06 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 11:24:07 INFO - Return code: 0 11:24:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:24:07 INFO - https://queue.taskcluster.net/v1/task/Zx-wswNnS1qxZsl05YdR2Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:24:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zx-wswNnS1qxZsl05YdR2Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 11:24:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zx-wswNnS1qxZsl05YdR2Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 11:24:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zx-wswNnS1qxZsl05YdR2Q/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 11:24:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zx-wswNnS1qxZsl05YdR2Q/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 11:24:08 INFO - Downloaded 10840145 bytes. 11:24:08 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'] 11:24:08 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 11:24:08 INFO - Return code: 0 11:24:08 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')]} 11:24:08 INFO - https://queue.taskcluster.net/v1/task/Zx-wswNnS1qxZsl05YdR2Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:24:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zx-wswNnS1qxZsl05YdR2Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 11:24:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zx-wswNnS1qxZsl05YdR2Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 11:24:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zx-wswNnS1qxZsl05YdR2Q/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 11:24:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zx-wswNnS1qxZsl05YdR2Q/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 11:24:10 INFO - Downloaded 58365529 bytes. 11:24:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Zx-wswNnS1qxZsl05YdR2Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 11:24:10 INFO - mkdir: /builds/slave/test/properties 11:24:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:24:10 INFO - Writing to file /builds/slave/test/properties/build_url 11:24:10 INFO - Contents: 11:24:10 INFO - build_url:https://queue.taskcluster.net/v1/task/Zx-wswNnS1qxZsl05YdR2Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 11:24:11 INFO - Running post-action listener: _resource_record_post_action 11:24:11 INFO - Running post-action listener: set_extra_try_arguments 11:24:11 INFO - ##### 11:24:11 INFO - ##### Running populate-webroot step. 11:24:11 INFO - ##### 11:24:11 INFO - Running pre-action listener: _resource_record_pre_action 11:24:11 INFO - Running main action method: populate_webroot 11:24:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:24:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:24:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:24:11 INFO - '--tppagecycles', 11:24:11 INFO - '7'], 11:24:11 INFO - 'tests': ['tsvgm']}}, 11:24:11 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:24:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:24:11 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:24:11 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:24:11 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:24:11 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:24:11 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:24:11 INFO - 'talos_options': ['--disable-e10s'], 11:24:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:24:11 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:24:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:24:11 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:24:11 INFO - 'talos_options': ['--disable-e10s'], 11:24:11 INFO - 'tests': ['damp', 'tps']}, 11:24:11 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:24:11 INFO - 'tests': ['damp', 'tps']}, 11:24:11 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:24:11 INFO - 'tests': ['dromaeo_dom']}, 11:24:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:24:11 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:24:11 INFO - 'tests': ['a11yr', 11:24:11 INFO - 'ts_paint', 11:24:11 INFO - 'tpaint', 11:24:11 INFO - 'sessionrestore', 11:24:11 INFO - 'sessionrestore_no_auto_restore', 11:24:11 INFO - 'tabpaint']}, 11:24:11 INFO - 'other-e10s': {'tests': ['a11yr', 11:24:11 INFO - 'ts_paint', 11:24:11 INFO - 'tpaint', 11:24:11 INFO - 'sessionrestore', 11:24:11 INFO - 'sessionrestore_no_auto_restore', 11:24:11 INFO - 'tabpaint']}, 11:24:11 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:24:11 INFO - 'ts_paint', 11:24:11 INFO - 'tpaint', 11:24:11 INFO - 'sessionrestore', 11:24:11 INFO - 'sessionrestore_no_auto_restore', 11:24:11 INFO - 'tabpaint']}, 11:24:11 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:24:11 INFO - 'ts_paint', 11:24:11 INFO - 'tpaint', 11:24:11 INFO - 'sessionrestore', 11:24:11 INFO - 'sessionrestore_no_auto_restore', 11:24:11 INFO - 'tabpaint']}, 11:24:11 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:24:11 INFO - 'tests': ['a11yr', 11:24:11 INFO - 'ts_paint', 11:24:11 INFO - 'tpaint', 11:24:11 INFO - 'sessionrestore', 11:24:11 INFO - 'sessionrestore_no_auto_restore', 11:24:11 INFO - 'tabpaint']}, 11:24:11 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:24:11 INFO - 'tests': ['a11yr', 11:24:11 INFO - 'ts_paint', 11:24:11 INFO - 'tpaint', 11:24:11 INFO - 'sessionrestore', 11:24:11 INFO - 'sessionrestore_no_auto_restore', 11:24:11 INFO - 'tabpaint']}, 11:24:11 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:24:11 INFO - 'tests': ['tsvgx', 11:24:11 INFO - 'tsvgr_opacity', 11:24:11 INFO - 'tart', 11:24:11 INFO - 'tscrollx', 11:24:11 INFO - 'cart']}, 11:24:11 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:24:11 INFO - 'tsvgr_opacity', 11:24:11 INFO - 'tart', 11:24:11 INFO - 'tscrollx', 11:24:11 INFO - 'cart']}, 11:24:11 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:24:11 INFO - 'talos_options': ['--disable-e10s'], 11:24:11 INFO - 'tests': ['tp5o']}, 11:24:11 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:24:11 INFO - 'tests': ['tp5o']}, 11:24:11 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:24:11 INFO - 'talos_options': ['--disable-e10s', 11:24:11 INFO - '--xperf_path', 11:24:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:24:11 INFO - 'tests': ['tp5n']}, 11:24:11 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:24:11 INFO - 'talos_options': ['--xperf_path', 11:24:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:24:11 INFO - 'tests': ['tp5n']}}, 11:24:11 INFO - 'talos.zip': {'path': '', 11:24:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:24:11 INFO - Running post-action listener: _resource_record_post_action 11:24:11 INFO - ##### 11:24:11 INFO - ##### Running create-virtualenv step. 11:24:11 INFO - ##### 11:24:11 INFO - Running pre-action listener: _resource_record_pre_action 11:24:11 INFO - Running main action method: create_virtualenv 11:24:11 INFO - Creating virtualenv /builds/slave/test/build/venv 11:24:11 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:24:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:24:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:24:11 INFO - Using real prefix '/usr' 11:24:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:24:12 INFO - Installing distribute.............................................................................................................................................................................................done. 11:24:14 INFO - Installing pip.................done. 11:24:14 INFO - Return code: 0 11:24:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:24:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:24:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:24:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7520537f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17835a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1812410>, '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 0x1813310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18137a0>, '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': '523ca41ca1e0623de333ad52000001bf-1461349438.743498-1884361186', '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 11:24:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:24:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:24:14 INFO - Using env: {'DISPLAY': ':0', 11:24:14 INFO - 'HOME': '/home/cltbld', 11:24:14 INFO - 'LANG': 'en_US.UTF-8', 11:24:14 INFO - 'LANGUAGE': 'en_US:en', 11:24:14 INFO - 'LOGNAME': 'cltbld', 11:24:14 INFO - 'MAIL': '/var/mail/cltbld', 11:24:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:14 INFO - 'MOZ_NO_REMOTE': '1', 11:24:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:24:14 INFO - 'NO_EM_RESTART': '1', 11:24:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:24:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:14 INFO - 'PWD': '/builds/slave/test', 11:24:14 INFO - 'SHELL': '/bin/bash', 11:24:14 INFO - 'SHLVL': '1', 11:24:14 INFO - 'TERM': 'linux', 11:24:14 INFO - 'TMOUT': '86400', 11:24:14 INFO - 'USER': 'cltbld', 11:24:14 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1461349438.743498-1884361186', 11:24:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:14 INFO - '_': '/tools/buildbot/bin/python'} 11:24:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:14 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 11:24:14 INFO - Cleaning up... 11:24:14 INFO - Return code: 0 11:24:14 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 11:24:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:24:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:24:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7520537f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17835a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1812410>, '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 0x1813310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18137a0>, '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': '523ca41ca1e0623de333ad52000001bf-1461349438.743498-1884361186', '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 11:24:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 11:24:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 11:24:14 INFO - Using env: {'DISPLAY': ':0', 11:24:14 INFO - 'HOME': '/home/cltbld', 11:24:14 INFO - 'LANG': 'en_US.UTF-8', 11:24:14 INFO - 'LANGUAGE': 'en_US:en', 11:24:14 INFO - 'LOGNAME': 'cltbld', 11:24:14 INFO - 'MAIL': '/var/mail/cltbld', 11:24:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:14 INFO - 'MOZ_NO_REMOTE': '1', 11:24:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:24:14 INFO - 'NO_EM_RESTART': '1', 11:24:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:24:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:14 INFO - 'PWD': '/builds/slave/test', 11:24:14 INFO - 'SHELL': '/bin/bash', 11:24:14 INFO - 'SHLVL': '1', 11:24:14 INFO - 'TERM': 'linux', 11:24:14 INFO - 'TMOUT': '86400', 11:24:14 INFO - 'USER': 'cltbld', 11:24:14 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1461349438.743498-1884361186', 11:24:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:14 INFO - '_': '/tools/buildbot/bin/python'} 11:24:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:14 INFO - Downloading/unpacking psutil>=0.7.1 11:24:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:24:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:24:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:24:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:24:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:24:16 INFO - Installing collected packages: psutil 11:24:16 INFO - Running setup.py install for psutil 11:24:16 INFO - building 'psutil._psutil_linux' extension 11:24:16 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 11:24:16 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 11:24:16 INFO - building 'psutil._psutil_posix' extension 11:24:16 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 11:24:16 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 11:24:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:24:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:24:16 INFO - Successfully installed psutil 11:24:16 INFO - Cleaning up... 11:24:17 INFO - Return code: 0 11:24:17 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 11:24:17 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')]} 11:24:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:17 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')]} 11:24:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:17 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 0x7f7520537f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17835a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1812410>, '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 0x1813310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18137a0>, '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': '523ca41ca1e0623de333ad52000001bf-1461349438.743498-1884361186', '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 11:24:17 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 11:24:17 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 11:24:17 INFO - Using env: {'DISPLAY': ':0', 11:24:17 INFO - 'HOME': '/home/cltbld', 11:24:17 INFO - 'LANG': 'en_US.UTF-8', 11:24:17 INFO - 'LANGUAGE': 'en_US:en', 11:24:17 INFO - 'LOGNAME': 'cltbld', 11:24:17 INFO - 'MAIL': '/var/mail/cltbld', 11:24:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:17 INFO - 'MOZ_NO_REMOTE': '1', 11:24:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:24:17 INFO - 'NO_EM_RESTART': '1', 11:24:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:24:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:17 INFO - 'PWD': '/builds/slave/test', 11:24:17 INFO - 'SHELL': '/bin/bash', 11:24:17 INFO - 'SHLVL': '1', 11:24:17 INFO - 'TERM': 'linux', 11:24:17 INFO - 'TMOUT': '86400', 11:24:17 INFO - 'USER': 'cltbld', 11:24:17 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1461349438.743498-1884361186', 11:24:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:17 INFO - '_': '/tools/buildbot/bin/python'} 11:24:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:17 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:24:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:24:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:24:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:19 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:24:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:24:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 11:24:19 INFO - Installing collected packages: mozsystemmonitor 11:24:19 INFO - Running setup.py install for mozsystemmonitor 11:24:19 INFO - Successfully installed mozsystemmonitor 11:24:19 INFO - Cleaning up... 11:24:19 INFO - Return code: 0 11:24:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:24:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:24:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:24:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7520537f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17835a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1812410>, '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 0x1813310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18137a0>, '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': '523ca41ca1e0623de333ad52000001bf-1461349438.743498-1884361186', '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 11:24:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:24:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:24:19 INFO - Using env: {'DISPLAY': ':0', 11:24:19 INFO - 'HOME': '/home/cltbld', 11:24:19 INFO - 'LANG': 'en_US.UTF-8', 11:24:19 INFO - 'LANGUAGE': 'en_US:en', 11:24:19 INFO - 'LOGNAME': 'cltbld', 11:24:19 INFO - 'MAIL': '/var/mail/cltbld', 11:24:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:19 INFO - 'MOZ_NO_REMOTE': '1', 11:24:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:24:19 INFO - 'NO_EM_RESTART': '1', 11:24:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:24:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:19 INFO - 'PWD': '/builds/slave/test', 11:24:19 INFO - 'SHELL': '/bin/bash', 11:24:19 INFO - 'SHLVL': '1', 11:24:19 INFO - 'TERM': 'linux', 11:24:19 INFO - 'TMOUT': '86400', 11:24:19 INFO - 'USER': 'cltbld', 11:24:19 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1461349438.743498-1884361186', 11:24:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:19 INFO - '_': '/tools/buildbot/bin/python'} 11:24:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:19 INFO - Downloading/unpacking blobuploader==1.2.4 11:24:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:24:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:24:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:21 INFO - Downloading blobuploader-1.2.4.tar.gz 11:24:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:24:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:24:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:24:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:24:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:24:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:24:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:24:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:24:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:22 INFO - Downloading docopt-0.6.1.tar.gz 11:24:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:24:22 INFO - Installing collected packages: blobuploader, requests, docopt 11:24:22 INFO - Running setup.py install for blobuploader 11:24:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:24:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:24:22 INFO - Running setup.py install for requests 11:24:22 INFO - Running setup.py install for docopt 11:24:22 INFO - Successfully installed blobuploader requests docopt 11:24:22 INFO - Cleaning up... 11:24:22 INFO - Return code: 0 11:24:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:24:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:24:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:24:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7520537f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17835a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1812410>, '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 0x1813310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18137a0>, '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': '523ca41ca1e0623de333ad52000001bf-1461349438.743498-1884361186', '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 11:24:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:24:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:24:22 INFO - Using env: {'DISPLAY': ':0', 11:24:22 INFO - 'HOME': '/home/cltbld', 11:24:22 INFO - 'LANG': 'en_US.UTF-8', 11:24:22 INFO - 'LANGUAGE': 'en_US:en', 11:24:22 INFO - 'LOGNAME': 'cltbld', 11:24:22 INFO - 'MAIL': '/var/mail/cltbld', 11:24:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:22 INFO - 'MOZ_NO_REMOTE': '1', 11:24:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:24:22 INFO - 'NO_EM_RESTART': '1', 11:24:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:24:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:22 INFO - 'PWD': '/builds/slave/test', 11:24:22 INFO - 'SHELL': '/bin/bash', 11:24:22 INFO - 'SHLVL': '1', 11:24:22 INFO - 'TERM': 'linux', 11:24:22 INFO - 'TMOUT': '86400', 11:24:22 INFO - 'USER': 'cltbld', 11:24:22 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1461349438.743498-1884361186', 11:24:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:22 INFO - '_': '/tools/buildbot/bin/python'} 11:24:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:24:23 INFO - Running setup.py (path:/tmp/pip-PcelzX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:24:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:24:23 INFO - Running setup.py (path:/tmp/pip-vyVhua-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:24:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:24:23 INFO - Running setup.py (path:/tmp/pip-Btz4pN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:24:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:24:23 INFO - Running setup.py (path:/tmp/pip-t3d5hi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:24:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:24:23 INFO - Running setup.py (path:/tmp/pip-6ern1M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:24:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:24:23 INFO - Running setup.py (path:/tmp/pip-Fw3T7T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:24:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:24:23 INFO - Running setup.py (path:/tmp/pip-R6S66H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:24:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:24:23 INFO - Running setup.py (path:/tmp/pip-1D_fCc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:24:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:24:23 INFO - Running setup.py (path:/tmp/pip-dxHFhs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:24:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:24:23 INFO - Running setup.py (path:/tmp/pip-_JVCKS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:24:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:24:23 INFO - Running setup.py (path:/tmp/pip-LWP7eo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:24:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:24:23 INFO - Running setup.py (path:/tmp/pip-EIVVea-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:24:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:24:23 INFO - Running setup.py (path:/tmp/pip-suronC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:24:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:24:23 INFO - Running setup.py (path:/tmp/pip-jMwzql-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:24:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:24:24 INFO - Running setup.py (path:/tmp/pip-wcATls-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:24:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:24:24 INFO - Running setup.py (path:/tmp/pip-FTcyvf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:24:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:24:24 INFO - Running setup.py (path:/tmp/pip-RlhsSQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:24:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:24:24 INFO - Running setup.py install for manifestparser 11:24:24 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:24:24 INFO - Running setup.py install for mozcrash 11:24:24 INFO - Running setup.py install for mozdebug 11:24:24 INFO - Running setup.py install for mozdevice 11:24:24 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:24:24 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:24:24 INFO - Running setup.py install for mozfile 11:24:24 INFO - Running setup.py install for mozhttpd 11:24:24 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:24:24 INFO - Running setup.py install for mozinfo 11:24:24 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:24:24 INFO - Running setup.py install for mozInstall 11:24:25 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:24:25 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:24:25 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:24:25 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:24:25 INFO - Running setup.py install for mozleak 11:24:25 INFO - Running setup.py install for mozlog 11:24:25 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:24:25 INFO - Running setup.py install for moznetwork 11:24:25 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:24:25 INFO - Running setup.py install for mozprocess 11:24:25 INFO - Running setup.py install for mozprofile 11:24:25 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:24:25 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:24:25 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:24:25 INFO - Running setup.py install for mozrunner 11:24:25 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:24:25 INFO - Running setup.py install for mozscreenshot 11:24:25 INFO - Running setup.py install for moztest 11:24:25 INFO - Running setup.py install for mozversion 11:24:25 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:24:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:24:25 INFO - Cleaning up... 11:24:26 INFO - Return code: 0 11:24:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:24: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')]} 11:24:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24: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')]} 11:24:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:26 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 0x7f7520537f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17835a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1812410>, '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 0x1813310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18137a0>, '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': '523ca41ca1e0623de333ad52000001bf-1461349438.743498-1884361186', '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 11:24:26 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 11:24:26 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 11:24:26 INFO - Using env: {'DISPLAY': ':0', 11:24:26 INFO - 'HOME': '/home/cltbld', 11:24:26 INFO - 'LANG': 'en_US.UTF-8', 11:24:26 INFO - 'LANGUAGE': 'en_US:en', 11:24:26 INFO - 'LOGNAME': 'cltbld', 11:24:26 INFO - 'MAIL': '/var/mail/cltbld', 11:24:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:26 INFO - 'MOZ_NO_REMOTE': '1', 11:24:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:24:26 INFO - 'NO_EM_RESTART': '1', 11:24:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:24:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:26 INFO - 'PWD': '/builds/slave/test', 11:24:26 INFO - 'SHELL': '/bin/bash', 11:24:26 INFO - 'SHLVL': '1', 11:24:26 INFO - 'TERM': 'linux', 11:24:26 INFO - 'TMOUT': '86400', 11:24:26 INFO - 'USER': 'cltbld', 11:24:26 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1461349438.743498-1884361186', 11:24:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:26 INFO - '_': '/tools/buildbot/bin/python'} 11:24:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:24:26 INFO - Running setup.py (path:/tmp/pip-DrmUzw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:24:26 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 11:24:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:24:26 INFO - Running setup.py (path:/tmp/pip-C7tS1o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:24:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:24:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:24:26 INFO - Running setup.py (path:/tmp/pip-VdYuuJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:24:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:24:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:24:26 INFO - Running setup.py (path:/tmp/pip-iyFVUP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:24:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:24:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:24:26 INFO - Running setup.py (path:/tmp/pip-4gaTWI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:24:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 11:24:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:24:26 INFO - Running setup.py (path:/tmp/pip-ZgT7q5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:24:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 11:24:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:24:26 INFO - Running setup.py (path:/tmp/pip-rwIsHu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:24:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 11:24:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:24:26 INFO - Running setup.py (path:/tmp/pip-ayD2QB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:24:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:24:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:24:26 INFO - Running setup.py (path:/tmp/pip-X8UdpF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:24:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 11:24:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:24:26 INFO - Running setup.py (path:/tmp/pip-ocmCom-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:24:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:24:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:24:26 INFO - Running setup.py (path:/tmp/pip-wNLkvS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:24:27 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)) 11:24:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:24:27 INFO - Running setup.py (path:/tmp/pip-Hf7LTU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:24:27 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)) 11:24:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:24:27 INFO - Running setup.py (path:/tmp/pip-N8rduJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:24:27 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)) 11:24:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:24:27 INFO - Running setup.py (path:/tmp/pip-dSZCGq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:24:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 11:24:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:24:27 INFO - Running setup.py (path:/tmp/pip-4YPeTm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:24:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 11:24:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:24:27 INFO - Running setup.py (path:/tmp/pip-nPXsgF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:24:27 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 11:24:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:24:27 INFO - Running setup.py (path:/tmp/pip-NT4MAy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:24:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 11:24:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:24:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:24:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:24:27 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:24:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:24:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:24:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:24:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:24:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:29 INFO - Downloading blessings-1.6.tar.gz 11:24:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:24:29 INFO - Installing collected packages: blessings 11:24:29 INFO - Running setup.py install for blessings 11:24:29 INFO - Successfully installed blessings 11:24:29 INFO - Cleaning up... 11:24:29 INFO - Return code: 0 11:24:29 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:24:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:24:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:24:29 INFO - Reading from file tmpfile_stdout 11:24:29 INFO - Current package versions: 11:24:29 INFO - argparse == 1.2.1 11:24:29 INFO - blessings == 1.6 11:24:29 INFO - blobuploader == 1.2.4 11:24:29 INFO - docopt == 0.6.1 11:24:29 INFO - manifestparser == 1.1 11:24:29 INFO - mozInstall == 1.12 11:24:29 INFO - mozcrash == 0.17 11:24:29 INFO - mozdebug == 0.1 11:24:29 INFO - mozdevice == 0.48 11:24:29 INFO - mozfile == 1.2 11:24:29 INFO - mozhttpd == 0.7 11:24:29 INFO - mozinfo == 0.9 11:24:29 INFO - mozleak == 0.1 11:24:29 INFO - mozlog == 3.1 11:24:29 INFO - moznetwork == 0.27 11:24:29 INFO - mozprocess == 0.22 11:24:29 INFO - mozprofile == 0.28 11:24:29 INFO - mozrunner == 6.11 11:24:29 INFO - mozscreenshot == 0.1 11:24:29 INFO - mozsystemmonitor == 0.0 11:24:29 INFO - moztest == 0.7 11:24:29 INFO - mozversion == 1.4 11:24:29 INFO - psutil == 3.1.1 11:24:29 INFO - requests == 1.2.3 11:24:29 INFO - wsgiref == 0.1.2 11:24:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:24:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:24:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:24:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7520537f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17835a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1812410>, '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 0x1813310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18137a0>, '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': '523ca41ca1e0623de333ad52000001bf-1461349438.743498-1884361186', '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 11:24:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 11:24:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:24:29 INFO - Using env: {'DISPLAY': ':0', 11:24:29 INFO - 'HOME': '/home/cltbld', 11:24:29 INFO - 'LANG': 'en_US.UTF-8', 11:24:29 INFO - 'LANGUAGE': 'en_US:en', 11:24:29 INFO - 'LOGNAME': 'cltbld', 11:24:29 INFO - 'MAIL': '/var/mail/cltbld', 11:24:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:29 INFO - 'MOZ_NO_REMOTE': '1', 11:24:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:24:29 INFO - 'NO_EM_RESTART': '1', 11:24:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:24:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:29 INFO - 'PWD': '/builds/slave/test', 11:24:29 INFO - 'SHELL': '/bin/bash', 11:24:29 INFO - 'SHLVL': '1', 11:24:29 INFO - 'TERM': 'linux', 11:24:29 INFO - 'TMOUT': '86400', 11:24:29 INFO - 'USER': 'cltbld', 11:24:29 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1461349438.743498-1884361186', 11:24:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:29 INFO - '_': '/tools/buildbot/bin/python'} 11:24:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:24:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 11:24:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 11:24:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:24:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 11:24:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 11:24:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 11:24:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 11:24:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 11:24:29 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:24:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:24:29 INFO - Cleaning up... 11:24:29 INFO - Return code: 0 11:24:29 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:24:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:24:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:24:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7520537f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17835a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1812410>, '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 0x1813310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18137a0>, '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': '523ca41ca1e0623de333ad52000001bf-1461349438.743498-1884361186', '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 11:24:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:24:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:24:29 INFO - Using env: {'DISPLAY': ':0', 11:24:29 INFO - 'HOME': '/home/cltbld', 11:24:29 INFO - 'LANG': 'en_US.UTF-8', 11:24:29 INFO - 'LANGUAGE': 'en_US:en', 11:24:29 INFO - 'LOGNAME': 'cltbld', 11:24:29 INFO - 'MAIL': '/var/mail/cltbld', 11:24:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:29 INFO - 'MOZ_NO_REMOTE': '1', 11:24:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:24:29 INFO - 'NO_EM_RESTART': '1', 11:24:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:24:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:29 INFO - 'PWD': '/builds/slave/test', 11:24:29 INFO - 'SHELL': '/bin/bash', 11:24:29 INFO - 'SHLVL': '1', 11:24:29 INFO - 'TERM': 'linux', 11:24:29 INFO - 'TMOUT': '86400', 11:24:29 INFO - 'USER': 'cltbld', 11:24:29 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1461349438.743498-1884361186', 11:24:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:29 INFO - '_': '/tools/buildbot/bin/python'} 11:24:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:30 INFO - Downloading/unpacking jsonschema 11:24:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:24:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:24:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:24:32 INFO - Downloading/unpacking functools32 (from jsonschema) 11:24:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:24:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:24:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:32 INFO - Downloading functools32-3.2.3-2.tar.gz 11:24:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:24:32 INFO - warning: no files found matching '*.txt' 11:24:32 INFO - no previously-included directories found matching 'build' 11:24:32 INFO - no previously-included directories found matching 'dist' 11:24:32 INFO - no previously-included directories found matching '.git*' 11:24:32 INFO - Installing collected packages: jsonschema, functools32 11:24:32 INFO - Running setup.py install for functools32 11:24:32 INFO - warning: no files found matching '*.txt' 11:24:32 INFO - no previously-included directories found matching 'build' 11:24:32 INFO - no previously-included directories found matching 'dist' 11:24:32 INFO - no previously-included directories found matching '.git*' 11:24:32 INFO - Successfully installed jsonschema functools32 11:24:32 INFO - Cleaning up... 11:24:32 INFO - Return code: 0 11:24:32 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:24:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:24:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:24:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7520537f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17835a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1812410>, '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 0x1813310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18137a0>, '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': '523ca41ca1e0623de333ad52000001bf-1461349438.743498-1884361186', '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 11:24:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 11:24:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 11:24:32 INFO - Using env: {'DISPLAY': ':0', 11:24:32 INFO - 'HOME': '/home/cltbld', 11:24:32 INFO - 'LANG': 'en_US.UTF-8', 11:24:32 INFO - 'LANGUAGE': 'en_US:en', 11:24:32 INFO - 'LOGNAME': 'cltbld', 11:24:32 INFO - 'MAIL': '/var/mail/cltbld', 11:24:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:32 INFO - 'MOZ_NO_REMOTE': '1', 11:24:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:24:32 INFO - 'NO_EM_RESTART': '1', 11:24:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:24:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:32 INFO - 'PWD': '/builds/slave/test', 11:24:32 INFO - 'SHELL': '/bin/bash', 11:24:32 INFO - 'SHLVL': '1', 11:24:32 INFO - 'TERM': 'linux', 11:24:32 INFO - 'TMOUT': '86400', 11:24:32 INFO - 'USER': 'cltbld', 11:24:32 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1461349438.743498-1884361186', 11:24:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:32 INFO - '_': '/tools/buildbot/bin/python'} 11:24:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:32 INFO - Downloading/unpacking flake8 11:24:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:24:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:24:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:34 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:24:34 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:24:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:24:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:24:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:34 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:24:34 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:24:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:24:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:24:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:35 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:24:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:24:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:24:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:24:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:24:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:24:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:24:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:24:35 INFO - no previously-included directories found matching 'docs/_build' 11:24:35 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:24:35 INFO - Running setup.py install for pep8 11:24:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:24:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:24:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:24:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:24:35 INFO - no previously-included directories found matching 'docs/_build' 11:24:35 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:24:35 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:24:35 INFO - Cleaning up... 11:24:35 INFO - Return code: 0 11:24:35 INFO - Running post-action listener: _resource_record_post_action 11:24:35 INFO - Running post-action listener: _start_resource_monitoring 11:24:35 INFO - Starting resource monitoring. 11:24:35 INFO - ##### 11:24:35 INFO - ##### Running install step. 11:24:35 INFO - ##### 11:24:35 INFO - Running pre-action listener: _resource_record_pre_action 11:24:35 INFO - Running main action method: install 11:24:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:24:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:24:36 INFO - Reading from file tmpfile_stdout 11:24:36 INFO - Detecting whether we're running mozinstall >=1.0... 11:24:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:24:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:24:36 INFO - Reading from file tmpfile_stdout 11:24:36 INFO - Output received: 11:24:36 INFO - Usage: mozinstall [options] installer 11:24:36 INFO - Options: 11:24:36 INFO - -h, --help show this help message and exit 11:24:36 INFO - -d DEST, --destination=DEST 11:24:36 INFO - Directory to install application into. [default: 11:24:36 INFO - "/builds/slave/test"] 11:24:36 INFO - --app=APP Application being installed. [default: firefox] 11:24:36 INFO - mkdir: /builds/slave/test/build/application 11:24:36 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'] 11:24:36 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 11:24:52 INFO - Reading from file tmpfile_stdout 11:24:52 INFO - Output received: 11:24:52 INFO - /builds/slave/test/build/application/firefox/firefox 11:24:52 INFO - Running post-action listener: _resource_record_post_action 11:24:52 INFO - ##### 11:24:52 INFO - ##### Running run-tests step. 11:24:52 INFO - ##### 11:24:52 INFO - Running pre-action listener: _resource_record_pre_action 11:24:52 INFO - Running main action method: run_tests 11:24:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:24:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:24:52 INFO - Python 2.7.3 11:24:52 INFO - Return code: 0 11:24:52 INFO - grabbing minidump binary from tooltool 11:24: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')]} 11:24:52 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 0x1812410>, '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 0x1813310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18137a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:24:52 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 11:24:52 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 11:24:52 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:24:52 INFO - Return code: 0 11:24:52 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:24:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:24:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:24:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:24:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:24:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:24:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:24:53 INFO - Return code: 0 11:24:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Zx-wswNnS1qxZsl05YdR2Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--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 11:24:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Zx-wswNnS1qxZsl05YdR2Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-065 --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 11:24:53 INFO - Using env: {'DISPLAY': ':0', 11:24:53 INFO - 'HOME': '/home/cltbld', 11:24:53 INFO - 'LANG': 'en_US.UTF-8', 11:24:53 INFO - 'LANGUAGE': 'en_US:en', 11:24:53 INFO - 'LOGNAME': 'cltbld', 11:24:53 INFO - 'MAIL': '/var/mail/cltbld', 11:24:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:24:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:24:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:53 INFO - 'MOZ_NO_REMOTE': '1', 11:24:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:24:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:24:53 INFO - 'NO_EM_RESTART': '1', 11:24:53 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:24:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:53 INFO - 'PWD': '/builds/slave/test', 11:24:53 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:24:53 INFO - 'SHELL': '/bin/bash', 11:24:53 INFO - 'SHLVL': '1', 11:24:53 INFO - 'TERM': 'linux', 11:24:53 INFO - 'TMOUT': '86400', 11:24:53 INFO - 'USER': 'cltbld', 11:24:53 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1461349438.743498-1884361186', 11:24:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:53 INFO - '_': '/tools/buildbot/bin/python'} 11:24:53 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Zx-wswNnS1qxZsl05YdR2Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--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 11:24:53 INFO - mozversion application_buildid: 20160422083248 11:24:53 INFO - mozversion application_changeset: df4e550128b976a664216e57f78f80c36d78f275 11:24:53 INFO - mozversion application_display_name: Nightly 11:24:53 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:24:53 INFO - mozversion application_name: Firefox 11:24:53 INFO - mozversion application_remotingname: firefox 11:24:53 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:24:53 INFO - mozversion application_vendor: Mozilla 11:24:53 INFO - mozversion application_version: 48.0a1 11:24:53 INFO - mozversion platform_buildid: 20160422083248 11:24:53 INFO - mozversion platform_changeset: df4e550128b976a664216e57f78f80c36d78f275 11:24:53 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:24:53 INFO - mozversion platform_version: 48.0a1 11:24:53 INFO - using testdate: 1461349493 11:24:53 INFO - actual date: 1461349493 11:24:53 INFO - starting webserver on 'localhost:46969' 11:24:53 INFO - SUITE-START | Running 2 tests 11:24:53 INFO - TEST-START | dromaeo_css 11:24:53 INFO - operating with platform_type : linux_ 11:24:53 INFO - Initialising browser for dromaeo_css test... 11:24:53 INFO - TEST-INFO | started process 20810 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp261cAq/profile http://localhost:46969/getInfo.html) 11:24:57 INFO - PROCESS | 20810 | 11:24:57 INFO - PROCESS | 20810 | (process:20877): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:24:58 INFO - PROCESS | 20810 | __metrics Screen width/height:1600/1200 11:24:58 INFO - PROCESS | 20810 | colorDepth:24 11:24:58 INFO - PROCESS | 20810 | Browser inner width/height: 1024/697 11:24:58 INFO - PROCESS | 20810 | __metrics 11:24:58 ERROR - PROCESS | 20810 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 11:24:59 INFO - TEST-INFO | 20810: exit 0 11:24:59 INFO - Browser initialized. 11:24:59 INFO - Running cycle 1/1 for dromaeo_css test... 11:24:59 INFO - TEST-INFO | started process 20928 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp261cAq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:25:01 INFO - PROCESS | 20928 | 11:25:01 INFO - PROCESS | 20928 | (process:20989): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:25:11 INFO - PROCESS | 20928 | RSS: Main: 164384768 11:25:11 INFO - PROCESS | 20928 | 11:26:01 INFO - PROCESS | 20928 | 1461349561198 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] 11:28:08 INFO - PROCESS | 20928 | Cycle 1(1): loaded http://localhost:46969/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46969/tests/dromaeo/cssquery-ext.html) 11:28:09 INFO - PROCESS | 20928 | RSS: Main: 169795584 11:28:09 INFO - PROCESS | 20928 | 11:31:11 INFO - PROCESS | 20928 | Cycle 1(1): loaded http://localhost:46969/tests/dromaeo/cssquery-ext.html (next: http://localhost:46969/tests/dromaeo/cssquery-jquery.html) 11:31:12 INFO - PROCESS | 20928 | RSS: Main: 166936576 11:31:12 INFO - PROCESS | 20928 | 11:34:13 INFO - PROCESS | 20928 | Cycle 1(1): loaded http://localhost:46969/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46969/tests/dromaeo/cssquery-mootools.html) 11:34:14 INFO - PROCESS | 20928 | RSS: Main: 167137280 11:34:14 INFO - PROCESS | 20928 | 11:37:16 INFO - PROCESS | 20928 | Cycle 1(1): loaded http://localhost:46969/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46969/tests/dromaeo/cssquery-prototype.html) 11:37:16 INFO - PROCESS | 20928 | RSS: Main: 164864000 11:37:16 INFO - PROCESS | 20928 | 11:40:19 INFO - PROCESS | 20928 | Cycle 1(1): loaded http://localhost:46969/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46969/tests/dromaeo/cssquery-yui.html) 11:40:19 INFO - PROCESS | 20928 | RSS: Main: 166473728 11:40:19 INFO - PROCESS | 20928 | 11:43:22 INFO - PROCESS | 20928 | Cycle 1(1): loaded http://localhost:46969/tests/dromaeo/cssquery-yui.html (next: http://localhost:46969/tests/dromaeo/cssquery-dojo.html) 11:43:22 INFO - PROCESS | 20928 | RSS: Main: 168148992 11:43:22 INFO - PROCESS | 20928 | 11:43:22 INFO - PROCESS | 20928 | __start_tp_report 11:43:22 INFO - PROCESS | 20928 | _x_x_mozilla_page_load 11:43:22 INFO - PROCESS | 20928 | _x_x_mozilla_page_load_details 11:43:22 INFO - PROCESS | 20928 | |i|pagename|runs| 11:43:22 INFO - PROCESS | 20928 | |0;dojo.html;3122.718955294023;3165.4776961801304;3182.204448887778;3193.8722451101944;3200.5679233303513;5339.599530035248;5342.145256758915;5357.598180136486;5422.83731488055;5455.772451198488;5166.509181627749;5286.947130528693;5360.463953604638;5413.83758487246;5445.618806683524;4728.432588089434;4766.499517550659;4807.687500312486;4814.687045342059;4869.318295438641;744.5968949177015;4721.881952951169;4789.377380940473;4854.441739199984;4896.167651499236;4843.346148269974;4849.345338379327;4852.8544143675745;4864.0515099555605;4901.852944411673;4816.060868130716;4855.83004594841;4858.17411040124;4877.756112194412;4931.70409775411;4733.266343716695;4842.757862106916;4880.365552478191;4884.535969082932;4929.778159982773;5201.505856943622;5209.635325527214;5222.216667499867;5224.8693782655355;5243.659162154448;5582.665040097607;5649.943500565024;5669.971650141764;5685.602007859451;5690.146478028329;5696.743646535916;5759.827205183809;5766.481016708474;5797.739101740432;5833.533317334603;5339.385970613391;5350;5350.090484617664;5355.518003379714;5360.865978350534;5756.65460072397;5799.94200057994;5836.503897168704;5849.6782676952325;5856.912146317809;5631;5635.492805647511;5636.126400407861;5637.182608521742;5685.147227915763;5691.857703557362;5692.658440493584;5695.829125126253;5704.572157088235;5706.914396284059;5500.037493438632;5563.610547261734;5622.409646987089;5661.405552417019;5670.858228544319;5577.247071645357;5577.581681373832;5581.274434323512;5587.608867379245;5634.464725851038;4258.254805409041;4267.701260911768;4292.5492823253735;4302.82788688449;4316.136772645484;3795.8102094895144;3890.494235749391;3891.0466935600393;3933.6853051755793;3963.0884896473394;5299.920501192485;5400.621956463088;5445.700486473203;5458.181272809111;5496.532794712494;5659.462351076641;5678.858028549319;5695.1741997410145;5734.799282025109;5742.626729262584;5383.461653834664;5433.673979561239;5499.50504454601;5543.916841247385;5567.276254086943;4911.926321105187;4927.28554359623;4931.728754918514;4953.1332016896895;5005.624578156653;5933.2880054393745;5939.990201665727;5941.316748573883;5943.851403714855;5946.256717910262;5516.703574660032;5752.13717942312;5760.222369979999;5799.82600521985;5803.7388317524965;5813.069908814569;5877.823665290048;5879.823605291848;5880.735366908414;5895.086261629454;5511.641743286674;5579.414161512983;5584.078627026495;5587.357453892854;5633.549316054788;5708.172315014383;5790.9710451449155;5802.912956305743;5827.912581311199;5827.9417205829095;5561.4716601922755;5578.163275508706;5585.776568937359;5606.131049687305;5606.6636001840025;5411.161270003156;5522.22688823557;5536.446355364593;5555.805546805843;5583.581231407742;5418.864528386822;5430.185472179205;5431.619786614899;5435.646682965595;5461.644993075437;5479.643823151482;5494.670319780826;5502.697351645698;5520.089185284383;5526.889462210653;5423.83728488146;5452.890942181213;5495.642783219078;5527.309086364205;5568.888622227614 11:43:22 INFO - PROCESS | 20928 | |1;ext.html;610.1610285856947;643.2120652201054;656.4157899469473;658.4567731621413;677.4986509982614;35861.10347241317;37486;37566.24867502648;37620.24759504812;37729.24541509168;40955.79522102385;41771.79114104433;41773.37339939896;41908.16183676325;42008.15983680324;8656.2642175415;8812.295016398673;8819.118088191193;8820.955895220515;8887.422317549339;8706.129387061306;8722.738317850442;8776.824463510726;8785.868211976825;8803.64785408583;8799.340049496313;8812.206901378875;8861.689840855572;8878.334124940622;8890.59992300348;8720.563971801384;8797.956010219972;8799.604017819214;8830.24942879856;8859;8733.432326898732;8801.911980880173;8803.119688031209;8825.602847871862;8843.69047083349;32258.354832903446;38172.618273817185;38404.231915361815;38472;38775.612243877484;3431.811250381228;3456;3692.5753538343165;3980.7213495055357;4157.833686652531;27687.723122768715;27866;27989.440211195866;28006.159815205578;29234;4112.568180341051;4128.710990230685;4222.641075508554;4302.311630139194;4365.279728844736;197473;198700;198929;200914;245062.99999999822;34198.48702269418;34477.310453790786;35523.46714799228;36489.628174168596;36630.26739465196;35115.29769404598;35127.4730879037;35180.648193517736;35211.4718279226;35267.823660882044;14963.625909352353;15104.471343502924;15219.847801522064;15229.543113706606;15257.237138143048;12715.554955576696;12726.300053496961;12739.235645861278;12801.167924084904;12832.743345133233;8395.160483951557;8471.66113355459;8477.576121193915;8481.194286542768;8518.914810851813;3286.260591366923;3301.5377847101427;3320.6181289151573;3324.1024923270584;3409.215880347534;1172.9472173752201;1174.753301806613;1204.6325870609548;1212.4483360071147;1261.962141135749;31169.68830311713;31689;31723.04830855078;31748.841255794036;31885.521717174262;1163.528770847808;1189.4290740444462;1209.4859684633996;1215.1797536662893;1281.8205451236834;14702.411903523953;14875.33061012257;15266.847331526542;15287.312070956834;15426.84573154254;470209;476477;477704;479563;480118;55463.44536554583;56983;57059.14411283834;57111.42888571061;57170.42829571734;1335.218896945298;1422.8292604887479;1447.6959838433836;1448.9420423183165;1462.4150339864138;28932.56601150942;29069.27326816762;29351.412971740017;30128.54807177938;30467.695323046486;47478.52521474741;48110.5188948106;48151.75924120357;48353.5164648349;48460.757696211294;415198;420045;424658;424852;425536;27485.725142748317;27592;27675.58486622662;27804.16587502378;27936.161915142577;46992.29511557261;47568.52431475641;47568.762156189;48225.27662085001;48420.5157948416;39572.40641390439;40363.3945490812;40457;40497;41405.79297103616;39445;40327.798361008005;40613.39079913744;40639.39040914329;41617.79191104025;39949.2010159801;40025;40794;41143.38284925669;41175;33587;36299.81850090733;36543.45184822283;36573.26853462969;37104.81447592745;28039.579406308512;28040.71959280381;28468.572971405858;28477.572836407056;28491.145265642062 11:43:22 INFO - PROCESS | 20928 | |2;jquery.html;401.6144501278772;404.4762033167048;406.37621251379136;407.309610210693;414.6309784291981;13801.447942082305;17324.220410081543;17928.910355448206;17985;18673.90663046683;17391.130443477807;17630.206640701166;17927.820721792777;18389.44831655049;18436.078196090177;4991;5460.945390546103;5573.303337082864;5595.944040559583;5694.487496125348;5627.352854421732;5666.150077488389;5670.0927851543765;5686.545076393879;5702.54379649627;5528.281323427969;5680.857978550549;5681.261436013312;5683.403242659502;5709.172170035343;5636.2954630671165;5648;5649.887002259952;5674.546036317085;5689.743961521742;4811.49479304675;5079.898402031976;5127.589792816566;5128.153854613985;5130.07658621448;22283.331500055025;22683.54632907349;22717.43206419836;22871.42821429461;23189.88405057964;2385.85684858909;2391.3065211088765;2402.771736685012;2596.7533084357146;2747.2582402751145;14324.928375358057;14698.33857476416;14728.18994955277;14832.110073395523;14859.777103343458;1989.4628450318478;1995.2617531513433;2000.0599718132455;2044.1210279579775;2047.6109539187507;61302.999999999556;67858.3214167857;70972.2902770976;78462.21537784606;78565.21434785637;9593.616255349847;9603.567839447242;10056.145227655732;10322.638707645196;10382.480875956171;14896.478623248135;14937.477188298357;15017.924910375377;15026.398944042116;15038;7868.173841746534;8016.7194148204535;8129.878051829227;8166.714165004197;8233.259006689426;7952.085510166405;7997.400194985399;8070.475419097857;8087.191280871866;8112.918870811216;6261.342559031327;6261.655608941552;6294.874102517924;6321;6353.904691429632;1801.4595621313815;1844.271512752482;1860.944171674852;1873.7421407204286;1877.5270087694219;439.1831193979196;452.1431886574922;454.8248924164154;463.4947906781624;1038.7766630174397;11481.253718508271;11927.224730392496;12020.819687704692;12022.158448908667;12162.817557736642;451.5552181101612;454.23688203817244;466.8996165824364;470.37440204527894;480.9879753006133;6373.139626150411;6464.644444555594;6485.092087107809;6511.967440162769;6587.637679927554;452493;452805;466838;518598;522815;88430;97908.51045744868;103353.48323258336;103772;104273.47863260635;1082.1505118481955;1120.1263014848432;1142.702897246722;1142.948567314473;1151.5624062856061;16628.908472140596;16694;16915.069671168203;17436;17634.73547896757;28276;38660.42009369918;38834.80582597069;39017.609823901395;39506.60493395029;49987.50012499974;52851.20723189078;52995.20507192472;53862.46137538574;54391.45608543864;7915.406344524068;8568.143185681382;8638.222559969381;8725.694600688945;8791;8600.440971336842;8881.200691937756;9096.317776166947;9400.623975040922;9725.367851089657;8142.226488483585;8626.870596941177;8650.43772154808;8732.126787321216;8903.73288801337;4722.858314250578;7073.257307982588;8261.669533218845;8349;8620.52587107715;8531.104234055334;8741.256993155654;8807.955960220157;9079.046700096394;9138.588763505792;12660.430280637209;13060.542880999119;13133.146345487512;13215.801762973755;13443.395047222702;12814.743705126031;13009.349532523525;13135.146215495963;13164.275964822027;13190.670233244246 11:43:22 INFO - PROCESS | 20928 | |3;mootools.html;1537.8539038791312;1581.7231984402727;1746.196749495232;1826.6438044581312;1855.09100540735;7527.661255243514;8011.67953281868;8073.87889181662;8398.874016889751;8408.159184081596;8015.679372825095;8073.354131669467;8140.552269625168;8166;8212.630431630576;2269.3645779181816;2301.723793144825;2319.976800231993;2332.323626148415;2335.29941017694;2240.820734341257;2244.629636110048;2275.2036787124457;2283.908643654252;2289.473421113145;2297.9195728149516;2314.93055208344;2320.883955802203;2348.6946696929463;2357.363511851799;2232.3860938242033;2245.1692873636775;2250.527389248268;2254.3462395905167;2258.2096266306826;2267.104493724986;2276.681264622954;2276.931692049241;2277.81777457803;2285.919992800244;8222.753317400488;8308.667653293922;8330.916690833075;8337.749867503984;8348.499090054616;5141.305923700327;5313.203019547061;5343.358796944352;5352.571794256489;5352.839414817523;3319.7842140260805;3430.9656903430896;3496.667816557423;3514.0863375522295;3538.02704256329;1158.25871442277;1179.9056075514025;1183.4201241391743;1191.1780871198932;1210.5036934856755;10759.193060520414;11052.834207486894;11111.499982500807;11121.221514493907;11133.888661113366;4403.097365040159;4419.668524860648;4531.546845315442;4542.295944128666;4571.839985600488;9532.52337383128;9534.427934323963;9582.856257156149;9588.328816982883;9590.08894155054;5121.641485096007;5129.666571672829;5130.4356520782685;5139.922901156486;5192.091384007859;4184.28867092595;4681.6020638245445;4785.976070119627;4786.736729479912;4821.180399332052;3747.4191500317493;3768.9434658480145;3797.867074652429;3830.387138057953;3877.6897848172644;1233.5990802989065;1240.348816871132;1244.5581818454318;1251.2117366059506;1253.59258241072;940.67546696391;949.5862374762717;956.1538038835541;967.849983252597;969.6509256667593;5523.751431185607;5540.556755459554;5652.434756524397;5707.885842283131;5783.71081445926;447.4898615578243;455.7083466581391;456.3086923311186;456.4066713272732;464.79781295136723;3835.6547910688173;3897.025743564109;3900;3901.1612503311926;3933.370660694275;9939.701808945743;10388.065074143364;10428.739281517872;10455.895441045644;10464.162866970624;10076.29465937392;10095.192384609214;10273.794524109626;10291.742706432398;10319.896801031893;7867.2919437249775;7872.763817085496;7873.740201567722;7885.723999659985;7951.522908625501;5429.891402172014;5466.289382380265;5469.617126801086;5496.31296087989;5618.494335509824;9375.906240937777;9404.95297523508;9418.670346537838;9447.433154010781;9560.665376711782;9209.815803684023;9592.904070959481;9665.565049572926;9677.129058384779;9694.515274236119;6746.494012949147;7050.189228238818;7286.125664920243;7502.399808015455;7612.961935190288;7755.379569634529;7774.105977812624;7810.218978102144;7849.058113026474;7855.921440785748;7031;7199.568025918462;7209.4953353266865;7226.494145409771;7363.042804435389;6934.583924964519;6948.930510694829;7106.609136497335;7108.822279442848;7164.820879478055;6398.776042838665;6488.610683359014;6530.510211734044;6539.901901471577;6551.672416379257;4694.084653492536;4839.782209800638;4854.101991131652;4855.975720121377;4913.48408417111;4920.286558449076;4955.776990035385;4980.750962451791;4991.425986011655;5016.949830501794 11:43:22 INFO - PROCESS | 20928 | |4;prototype.html;313.88543181738675;316.642194320418;317.197490349416;327.89999050289657;333.1338519848393;5829.679367634779;6065.939340606593;6098.75604975801;6134.325224225332;6157.969210153954;5846.444587764156;5991.221141251631;6037.909431358533;6043.6373817570975;6046.758129674808;4571.7942692578745;4586.908261834753;4608.631309495249;4611.677182597219;4618.769061546926;4386.824527018932;4574.153781550423;4596.471405788327;4601.447826260854;4645.651576131787;4526.162659907911;4532.206863798839;4540.160070386973;4550.067236216568;4555.157295900252;4494.752788596626;4549.317602359656;4551.112533056055;4552.294394368878;4582.839600613963;3809.009657489045;3901.609839016104;3909.257241124177;3913.8630147944687;3942.7634341939574;5751.827445176651;5757.337906140764;5787.305523337226;5810.622309549865;5814.6511209327155;5207.505286997767;5221;5244.737763111829;5245.449227831099;5260.132078207092;5979.372165922602;6290.43386095249;6291.811245662638;6311.8737625247695;6359.523035772336;4305.246581848164;4306.44016277885;4309.978450107761;4326.740395576276;4345.782710864476;6286.308506064375;6512;6532.150820393318;6571.145751052381;6612.966935165341;4406.647468202536;4415;4424.269995450714;4428.446444194476;4437.06821567468;4484.744271603956;4491.832123647875;4494;4503.189425903303;4504.572065653758;5100.897982040413;5237.502437268454;5238.554722848525;5240.71176085319;5260.763265653055;6175.722092505848;6356.459700925473;6371.299157092716;6376.3623637635865;6378.298387177407;1550.3023639362107;1552.9301181446635;1565.4990403071135;1566.5848550134224;1566.7649852521986;1007.3754272351189;1024.4672770159475;1027.3630349183404;1039.0700323210683;1043.4626167523732;6109.602875813058;6112.786052488142;6129;6129.785457508966;6129.938700613026;6506.479481641457;6512.251091124486;6535.803925882231;6550.672466376662;6578.934210657832;5899.6405806311095;6078.6048906820915;6122.877542449126;6125.846853828601;6132.41742034506;3498.8425520851624;3505.5618047744033;3518.5601799775027;3532.293541291752;3544.929101417957;6602.240742314695;6751.662416879235;6769.8646027079185;6782.491313151533;6795.252522222551;6632.9336706633285;6674.83312917181;6684.331566843277;6721.798346049626;6747;6537.182852143482;6677.632730199788;6704.798856034229;6727.654469106198;6737.764178253738;6446.9355306448215;6469.547131700736;6476.125723027331;6478.384553467413;6490.772822951174;6327.651979141007;6445.935540644721;6455.903161452488;6474.449671777952;6514.902276465951;6736.360045795642;6759.324067593201;6766.86466270662;6782.355676210752;6789.15135608049;4312.598405518156;4325.4593175853015;4346.956530434782;4347.434833471629;4359.520452750132;6283.3402492737605;6365.331640177715;6422.976762319854;6544.312847151171;6602.933970660424;6359.236891573041;6377.96811015942;6425.839354016187;6459.224893012869;6464.450521705708;6166.876662466815;6383.36166383358;6395.648239346694;6417.614943103429;6426.3573642635365;6295.844742469948;6314;6322.861884860769;6333.65164915934;6336.398042185985;6468;6470.5147113965695;6471.2234531856475;6478.70845811949;6484.837879053061;6074.451014991149;6209.813705588839;6337.65142917144;6348.206474190726;6364.204474440695 11:43:22 INFO - PROCESS | 20928 | |5;yui.html;841.2807049972273;859.4198915731879;863.6200071968335;870.212457725758;873.9388242823005;13878.722425551496;14034.087784294014;14183.078099923498;14235.43058277669;14255.3585088671;12972.96216302696;13433.992450566198;13576;13622.795658065137;13653.453861845514;838.4801423117675;840.5377042626561;841.8316336732663;846.7840700621333;847.682119205298;826.8801023851538;842.2756429470651;842.4818736477084;843.7595285343679;843.797488602734;878.3807415771897;878.8901387326584;880.058337578791;881.1320848963766;881.6649673124236;876.5529579914225;879.7712594725353;880.5817236812495;881.18930583863;883.924866386358;639.5714871036416;639.8528338482129;640.123031446916;640.9871802563969;641.5156556799586;13249.73500529984;13317.467301307935;13334.933325333312;13359.666008349772;13363.465461381533;12432.564860229939;12592.81110783339;12783.680407989781;12858.67853303675;12885.226886386847;10902.563897444094;10911.181661375349;11034.337939723562;11103.666889993314;11318.547258109666;3736.047307936486;3760.2667479841443;3891.6692081173132;3979.303621866191;3991.2815693175216;47749;55402.72298638521;58304.708476457774;59983.70008149975;60490.76564640477;11625.941870290595;11629.651110466699;11713.062954963583;11731.47208375625;11741.412929353499;19059.61880762377;20471.38585842397;20549.48626284325;20627.38117856467;20646.690299645517;8571.400001999926;8582.356323275779;8680.8697869532;8792.60433280504;8865.867011994826;4746.976265118652;4878.731529802206;4979.800807967713;4982.800687972441;5016.724080175625;3349.949750753741;3406.829658517064;3434.261633748756;3435.2442462658173;3437;545.3374150407274;547.225675668924;551.6444780786101;556.3379578301808;556.5686592890543;651.0822510822511;654.358728446116;750.7334896111802;815.282551354804;829.2246749289434;9538.761530961643;9552.37909535878;9692.41845489273;9974.202063834875;10115.342502737298;599.1372423709844;693.7329128285545;764.3426653078349;773.5474747272908;785.8390220669975;4501.347304640809;4558.33904083906;4562.749048802348;4611.5619016193405;4658.1848176568965;63810.68094659497;64235.35764642387;64675;65039;65062;57940.420595793505;58072;58093;58127;58179.70910145507;48275.275870861966;48362.51637483651;48666.27000594994;49127;49752.75123624359;9388.483633399956;9532.52337383142;9684.95157524208;9767.462789546358;9799.363041402286;26833.060842870407;30854;30957.226069348446;31219.175823352787;31967.520487192247;41646.79176604097;44366;44435.777821110685;45004;45074.32388514109;12019;12065.155439119528;12077.879221207675;12168.878311216775;12183.025357971519;13671.043026988413;14068.648283792987;14104.435822566982;14140.15159090458;14489.420423182955;12290;12394.008479321814;12612.49550017989;12832.679183020498;13191.340432978504;13218.801717974045;13222.4049917752;13383.799243011168;13971.371288292254;13977.650558736113;12474.750504989668;13023.218606883618;13137.73724525485;13353.265570393722;13579.321033948065;10867;11065.612703555336;11338.376389298668;11366;11402.329079624851;10488.160947124365;10663.57345706194;10684.252102353072;10693.465326733787;10722.51748671296 11:43:22 INFO - PROCESS | 20928 | __end_tp_report 11:43:22 INFO - PROCESS | 20928 | __start_cc_report 11:43:22 INFO - PROCESS | 20928 | _x_x_mozilla_cycle_collect,324 11:43:22 INFO - PROCESS | 20928 | __end_cc_report 11:43:22 INFO - PROCESS | 20928 | __startTimestamp1461350602526__endTimestamp 11:43:22 INFO - PROCESS | 20928 | 11:43:22 INFO - PROCESS | 20928 | ------- Summary: start ------- 11:43:22 INFO - PROCESS | 20928 | Number of tests: 6 11:43:22 INFO - PROCESS | 20928 | 11:43:22 INFO - PROCESS | 20928 | [#0] dojo.html Cycles:165 Average:5267.22 Median:5499.51 stddev:690.14 (12.5%) stddev-sans-first:671.43 11:43:22 INFO - PROCESS | 20928 | Values: 3122.7 3165.5 3182.2 3193.9 3200.6 5339.6 5342.1 5357.6 5422.8 5455.8 5166.5 5286.9 5360.5 5413.8 5445.6 4728.4 4766.5 4807.7 4814.7 4869.3 744.6 4721.9 4789.4 4854.4 4896.2 4843.3 4849.3 4852.9 4864.1 4901.9 4816.1 4855.8 4858.2 4877.8 4931.7 4733.3 4842.8 4880.4 4884.5 4929.8 5201.5 5209.6 5222.2 5224.9 5243.7 5582.7 5649.9 5670.0 5685.6 5690.1 5696.7 5759.8 5766.5 5797.7 5833.5 5339.4 5350.0 5350.1 5355.5 5360.9 5756.7 5799.9 5836.5 5849.7 5856.9 5631.0 5635.5 5636.1 5637.2 5685.1 5691.9 5692.7 5695.8 5704.6 5706.9 5500.0 5563.6 5622.4 5661.4 5670.9 5577.2 5577.6 5581.3 5587.6 5634.5 4258.3 4267.7 4292.5 4302.8 4316.1 3795.8 3890.5 3891.0 3933.7 3963.1 5299.9 5400.6 5445.7 5458.2 5496.5 5659.5 5678.9 5695.2 5734.8 5742.6 5383.5 5433.7 5499.5 5543.9 5567.3 4911.9 4927.3 4931.7 4953.1 5005.6 5933.3 5940.0 5941.3 5943.9 5946.3 5516.7 5752.1 5760.2 5799.8 5803.7 5813.1 5877.8 5879.8 5880.7 5895.1 5511.6 5579.4 5584.1 5587.4 5633.5 5708.2 5791.0 5802.9 5827.9 5827.9 5561.5 5578.2 5585.8 5606.1 5606.7 5411.2 5522.2 5536.4 5555.8 5583.6 5418.9 5430.2 5431.6 5435.6 5461.6 5479.6 5494.7 5502.7 5520.1 5526.9 5423.8 5452.9 5495.6 5527.3 5568.9 11:43:22 INFO - PROCESS | 20928 | 11:43:22 INFO - PROCESS | 20928 | [#1] ext.html Cycles:180 Average:51689.55 Median:38438.12 stddev:102952.21 (267.8%) stddev-sans-first:103169.58 11:43:22 INFO - PROCESS | 20928 | Values: 610.2 643.2 656.4 658.5 677.5 35861.1 37486.0 37566.2 37620.2 37729.2 40955.8 41771.8 41773.4 41908.2 42008.2 8656.3 8812.3 8819.1 8821.0 8887.4 8706.1 8722.7 8776.8 8785.9 8803.6 8799.3 8812.2 8861.7 8878.3 8890.6 8720.6 8798.0 8799.6 8830.2 8859.0 8733.4 8801.9 8803.1 8825.6 8843.7 32258.4 38172.6 38404.2 38472.0 38775.6 3431.8 3456.0 3692.6 3980.7 4157.8 27687.7 27866.0 27989.4 28006.2 29234.0 4112.6 4128.7 4222.6 4302.3 4365.3 197473.0 198700.0 198929.0 200914.0 245063.0 34198.5 34477.3 35523.5 36489.6 36630.3 35115.3 35127.5 35180.6 35211.5 35267.8 14963.6 15104.5 15219.8 15229.5 15257.2 12715.6 12726.3 12739.2 12801.2 12832.7 8395.2 8471.7 8477.6 8481.2 8518.9 3286.3 3301.5 3320.6 3324.1 3409.2 1172.9 1174.8 1204.6 1212.4 1262.0 31169.7 31689.0 31723.0 31748.8 31885.5 1163.5 1189.4 1209.5 1215.2 1281.8 14702.4 14875.3 15266.8 15287.3 15426.8 470209.0 476477.0 477704.0 479563.0 480118.0 55463.4 56983.0 57059.1 57111.4 57170.4 1335.2 1422.8 1447.7 1448.9 1462.4 28932.6 29069.3 29351.4 30128.5 30467.7 47478.5 48110.5 48151.8 48353.5 48460.8 415198.0 420045.0 424658.0 424852.0 425536.0 27485.7 27592.0 27675.6 27804.2 27936.2 46992.3 47568.5 47568.8 48225.3 48420.5 39572.4 40363.4 40457.0 40497.0 41405.8 39445.0 40327.8 40613.4 40639.4 41617.8 39949.2 40025.0 40794.0 41143.4 41175.0 33587.0 36299.8 36543.5 36573.3 37104.8 28039.6 28040.7 28468.6 28477.6 28491.1 11:43:22 INFO - PROCESS | 20928 | 11:43:22 INFO - PROCESS | 20928 | [#2] jquery.html Cycles:180 Average:27886.88 Median:233652.45 stddev:79885.19 (34.2%) stddev-sans-first:80082.63 11:43:22 INFO - PROCESS | 20928 | Values: 401.6 404.5 406.4 407.3 414.6 13801.4 17324.2 17928.9 17985.0 18673.9 17391.1 17630.2 17927.8 18389.4 18436.1 4991.0 5460.9 5573.3 5595.9 5694.5 5627.4 5666.2 5670.1 5686.5 5702.5 5528.3 5680.9 5681.3 5683.4 5709.2 5636.3 5648.0 5649.9 5674.5 5689.7 4811.5 5079.9 5127.6 5128.2 5130.1 22283.3 22683.5 22717.4 22871.4 23189.9 2385.9 2391.3 2402.8 2596.8 2747.3 14324.9 14698.3 14728.2 14832.1 14859.8 1989.5 1995.3 2000.1 2044.1 2047.6 61303.0 67858.3 70972.3 78462.2 78565.2 9593.6 9603.6 10056.1 10322.6 10382.5 14896.5 14937.5 15017.9 15026.4 15038.0 7868.2 8016.7 8129.9 8166.7 8233.3 7952.1 7997.4 8070.5 8087.2 8112.9 6261.3 6261.7 6294.9 6321.0 6353.9 1801.5 1844.3 1860.9 1873.7 1877.5 439.2 452.1 454.8 463.5 1038.8 11481.3 11927.2 12020.8 12022.2 12162.8 451.6 454.2 466.9 470.4 481.0 6373.1 6464.6 6485.1 6512.0 6587.6 452493.0 452805.0 466838.0 518598.0 522815.0 88430.0 97908.5 103353.5 103772.0 104273.5 1082.2 1120.1 1142.7 1142.9 1151.6 16628.9 16694.0 16915.1 17436.0 17634.7 28276.0 38660.4 38834.8 39017.6 39506.6 49987.5 52851.2 52995.2 53862.5 54391.5 7915.4 8568.1 8638.2 8725.7 8791.0 8600.4 8881.2 9096.3 9400.6 9725.4 8142.2 8626.9 8650.4 8732.1 8903.7 4722.9 7073.3 8261.7 8349.0 8620.5 8531.1 8741.3 8808.0 9079.0 9138.6 12660.4 13060.5 13133.1 13215.8 13443.4 12814.7 13009.3 13135.1 13164.3 13190.7 11:43:22 INFO - PROCESS | 20928 | 11:43:22 INFO - PROCESS | 20928 | [#3] mootools.html Cycles:180 Average:5473.47 Median:4968.26 stddev:3027.78 (60.9%) stddev-sans-first:3021.83 11:43:22 INFO - PROCESS | 20928 | Values: 1537.9 1581.7 1746.2 1826.6 1855.1 7527.7 8011.7 8073.9 8398.9 8408.2 8015.7 8073.4 8140.6 8166.0 8212.6 2269.4 2301.7 2320.0 2332.3 2335.3 2240.8 2244.6 2275.2 2283.9 2289.5 2297.9 2314.9 2320.9 2348.7 2357.4 2232.4 2245.2 2250.5 2254.3 2258.2 2267.1 2276.7 2276.9 2277.8 2285.9 8222.8 8308.7 8330.9 8337.7 8348.5 5141.3 5313.2 5343.4 5352.6 5352.8 3319.8 3431.0 3496.7 3514.1 3538.0 1158.3 1179.9 1183.4 1191.2 1210.5 10759.2 11052.8 11111.5 11121.2 11133.9 4403.1 4419.7 4531.5 4542.3 4571.8 9532.5 9534.4 9582.9 9588.3 9590.1 5121.6 5129.7 5130.4 5139.9 5192.1 4184.3 4681.6 4786.0 4786.7 4821.2 3747.4 3768.9 3797.9 3830.4 3877.7 1233.6 1240.3 1244.6 1251.2 1253.6 940.7 949.6 956.2 967.8 969.7 5523.8 5540.6 5652.4 5707.9 5783.7 447.5 455.7 456.3 456.4 464.8 3835.7 3897.0 3900.0 3901.2 3933.4 9939.7 10388.1 10428.7 10455.9 10464.2 10076.3 10095.2 10273.8 10291.7 10319.9 7867.3 7872.8 7873.7 7885.7 7951.5 5429.9 5466.3 5469.6 5496.3 5618.5 9375.9 9405.0 9418.7 9447.4 9560.7 9209.8 9592.9 9665.6 9677.1 9694.5 6746.5 7050.2 7286.1 7502.4 7613.0 7755.4 7774.1 7810.2 7849.1 7855.9 7031.0 7199.6 7209.5 7226.5 7363.0 6934.6 6948.9 7106.6 7108.8 7164.8 6398.8 6488.6 6530.5 6539.9 6551.7 4694.1 4839.8 4854.1 4856.0 4913.5 4920.3 4955.8 4980.8 4991.4 5016.9 11:43:22 INFO - PROCESS | 20928 | 11:43:22 INFO - PROCESS | 20928 | [#4] prototype.html Cycles:180 Average:5286.68 Median:6088.68 stddev:1612.25 (26.5%) stddev-sans-first:1572.97 11:43:22 INFO - PROCESS | 20928 | Values: 313.9 316.6 317.2 327.9 333.1 5829.7 6065.9 6098.8 6134.3 6158.0 5846.4 5991.2 6037.9 6043.6 6046.8 4571.8 4586.9 4608.6 4611.7 4618.8 4386.8 4574.2 4596.5 4601.4 4645.7 4526.2 4532.2 4540.2 4550.1 4555.2 4494.8 4549.3 4551.1 4552.3 4582.8 3809.0 3901.6 3909.3 3913.9 3942.8 5751.8 5757.3 5787.3 5810.6 5814.7 5207.5 5221.0 5244.7 5245.4 5260.1 5979.4 6290.4 6291.8 6311.9 6359.5 4305.2 4306.4 4310.0 4326.7 4345.8 6286.3 6512.0 6532.2 6571.1 6613.0 4406.6 4415.0 4424.3 4428.4 4437.1 4484.7 4491.8 4494.0 4503.2 4504.6 5100.9 5237.5 5238.6 5240.7 5260.8 6175.7 6356.5 6371.3 6376.4 6378.3 1550.3 1552.9 1565.5 1566.6 1566.8 1007.4 1024.5 1027.4 1039.1 1043.5 6109.6 6112.8 6129.0 6129.8 6129.9 6506.5 6512.3 6535.8 6550.7 6578.9 5899.6 6078.6 6122.9 6125.8 6132.4 3498.8 3505.6 3518.6 3532.3 3544.9 6602.2 6751.7 6769.9 6782.5 6795.3 6632.9 6674.8 6684.3 6721.8 6747.0 6537.2 6677.6 6704.8 6727.7 6737.8 6446.9 6469.5 6476.1 6478.4 6490.8 6327.7 6445.9 6455.9 6474.4 6514.9 6736.4 6759.3 6766.9 6782.4 6789.2 4312.6 4325.5 4347.0 4347.4 4359.5 6283.3 6365.3 6423.0 6544.3 6602.9 6359.2 6378.0 6425.8 6459.2 6464.5 6166.9 6383.4 6395.6 6417.6 6426.4 6295.8 6314.0 6322.9 6333.7 6336.4 6468.0 6470.5 6471.2 6478.7 6484.8 6074.5 6209.8 6337.7 6348.2 6364.2 11:43:22 INFO - PROCESS | 20928 | 11:43:22 INFO - PROCESS | 20928 | [#5] yui.html Cycles:180 Average:14949.99 Median:24787.84 stddev:17358.28 (70.0%) stddev-sans-first:17374.64 11:43:22 INFO - PROCESS | 20928 | Values: 841.3 859.4 863.6 870.2 873.9 13878.7 14034.1 14183.1 14235.4 14255.4 12973.0 13434.0 13576.0 13622.8 13653.5 838.5 840.5 841.8 846.8 847.7 826.9 842.3 842.5 843.8 843.8 878.4 878.9 880.1 881.1 881.7 876.6 879.8 880.6 881.2 883.9 639.6 639.9 640.1 641.0 641.5 13249.7 13317.5 13334.9 13359.7 13363.5 12432.6 12592.8 12783.7 12858.7 12885.2 10902.6 10911.2 11034.3 11103.7 11318.5 3736.0 3760.3 3891.7 3979.3 3991.3 47749.0 55402.7 58304.7 59983.7 60490.8 11625.9 11629.7 11713.1 11731.5 11741.4 19059.6 20471.4 20549.5 20627.4 20646.7 8571.4 8582.4 8680.9 8792.6 8865.9 4747.0 4878.7 4979.8 4982.8 5016.7 3349.9 3406.8 3434.3 3435.2 3437.0 545.3 547.2 551.6 556.3 556.6 651.1 654.4 750.7 815.3 829.2 9538.8 9552.4 9692.4 9974.2 10115.3 599.1 693.7 764.3 773.5 785.8 4501.3 4558.3 4562.7 4611.6 4658.2 63810.7 64235.4 64675.0 65039.0 65062.0 57940.4 58072.0 58093.0 58127.0 58179.7 48275.3 48362.5 48666.3 49127.0 49752.8 9388.5 9532.5 9685.0 9767.5 9799.4 26833.1 30854.0 30957.2 31219.2 31967.5 41646.8 44366.0 44435.8 45004.0 45074.3 12019.0 12065.2 12077.9 12168.9 12183.0 13671.0 14068.6 14104.4 14140.2 14489.4 12290.0 12394.0 12612.5 12832.7 13191.3 13218.8 13222.4 13383.8 13971.4 13977.7 12474.8 13023.2 13137.7 13353.3 13579.3 10867.0 11065.6 11338.4 11366.0 11402.3 10488.2 10663.6 10684.3 10693.5 10722.5 11:43:22 INFO - PROCESS | 20928 | -------- Summary: end -------- 11:43:22 INFO - PROCESS | 20928 | 11:43:23 INFO - TEST-INFO | 20928: exit 0 11:43:23 INFO - TEST-OK | dromaeo_css | took 1109284ms 11:43:23 INFO - TEST-START | kraken 11:43:23 INFO - operating with platform_type : linux_ 11:43:23 INFO - Initialising browser for kraken test... 11:43:23 INFO - TEST-INFO | started process 21158 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplRpkBJ/profile http://localhost:46969/getInfo.html) 11:43:26 INFO - PROCESS | 21158 | 11:43:26 INFO - PROCESS | 21158 | (process:21228): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:43:27 INFO - PROCESS | 21158 | __metrics Screen width/height:1600/1200 11:43:27 INFO - PROCESS | 21158 | colorDepth:24 11:43:27 INFO - PROCESS | 21158 | Browser inner width/height: 1024/697 11:43:27 INFO - PROCESS | 21158 | __metrics 11:43:28 ERROR - PROCESS | 21158 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 11:43:28 INFO - TEST-INFO | 21158: exit 0 11:43:28 INFO - Browser initialized. 11:43:28 INFO - Running cycle 1/1 for kraken test... 11:43:28 INFO - TEST-INFO | started process 21279 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplRpkBJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:43:30 INFO - PROCESS | 21279 | 11:43:30 INFO - PROCESS | 21279 | (process:21340): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:43:40 INFO - PROCESS | 21279 | RSS: Main: 164626432 11:43:40 INFO - PROCESS | 21279 | 11:43:43 INFO - PROCESS | 21279 | Cycle 1(1): loaded http://localhost:46969/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46969/tests/kraken/driver.html?testName=audio-beat-detection) 11:43:44 INFO - PROCESS | 21279 | RSS: Main: 169558016 11:43:44 INFO - PROCESS | 21279 | 11:43:46 INFO - PROCESS | 21279 | Cycle 1(1): loaded http://localhost:46969/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46969/tests/kraken/driver.html?testName=audio-dft) 11:43:47 INFO - PROCESS | 21279 | RSS: Main: 172670976 11:43:47 INFO - PROCESS | 21279 | 11:43:50 INFO - PROCESS | 21279 | Cycle 1(1): loaded http://localhost:46969/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46969/tests/kraken/driver.html?testName=audio-fft) 11:43:50 INFO - PROCESS | 21279 | RSS: Main: 163622912 11:43:50 INFO - PROCESS | 21279 | 11:43:53 INFO - PROCESS | 21279 | Cycle 1(1): loaded http://localhost:46969/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46969/tests/kraken/driver.html?testName=audio-oscillator) 11:43:53 INFO - PROCESS | 21279 | RSS: Main: 164184064 11:43:53 INFO - PROCESS | 21279 | 11:43:56 INFO - PROCESS | 21279 | Cycle 1(1): loaded http://localhost:46969/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46969/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:43:56 INFO - PROCESS | 21279 | RSS: Main: 164777984 11:43:56 INFO - PROCESS | 21279 | 11:43:59 INFO - PROCESS | 21279 | Cycle 1(1): loaded http://localhost:46969/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46969/tests/kraken/driver.html?testName=imaging-darkroom) 11:44:00 INFO - PROCESS | 21279 | RSS: Main: 164966400 11:44:00 INFO - PROCESS | 21279 | 11:44:03 INFO - PROCESS | 21279 | Cycle 1(1): loaded http://localhost:46969/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46969/tests/kraken/driver.html?testName=imaging-desaturate) 11:44:04 INFO - PROCESS | 21279 | RSS: Main: 167247872 11:44:04 INFO - PROCESS | 21279 | 11:44:07 INFO - PROCESS | 21279 | Cycle 1(1): loaded http://localhost:46969/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46969/tests/kraken/driver.html?testName=json-parse-financial) 11:44:07 INFO - PROCESS | 21279 | RSS: Main: 167211008 11:44:07 INFO - PROCESS | 21279 | 11:44:09 INFO - PROCESS | 21279 | Cycle 1(1): loaded http://localhost:46969/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46969/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:44:09 INFO - PROCESS | 21279 | RSS: Main: 167378944 11:44:09 INFO - PROCESS | 21279 | 11:44:11 INFO - PROCESS | 21279 | Cycle 1(1): loaded http://localhost:46969/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46969/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:44:12 INFO - PROCESS | 21279 | RSS: Main: 167395328 11:44:12 INFO - PROCESS | 21279 | 11:44:14 INFO - PROCESS | 21279 | Cycle 1(1): loaded http://localhost:46969/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46969/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:44:15 INFO - PROCESS | 21279 | RSS: Main: 167985152 11:44:15 INFO - PROCESS | 21279 | 11:44:17 INFO - PROCESS | 21279 | Cycle 1(1): loaded http://localhost:46969/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46969/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:44:18 INFO - PROCESS | 21279 | RSS: Main: 168148992 11:44:18 INFO - PROCESS | 21279 | 11:44:21 INFO - PROCESS | 21279 | Cycle 1(1): loaded http://localhost:46969/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46969/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:44:21 INFO - PROCESS | 21279 | RSS: Main: 167251968 11:44:21 INFO - PROCESS | 21279 | 11:44:23 INFO - PROCESS | 21279 | Cycle 1(1): loaded http://localhost:46969/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46969/tests/kraken/driver.html?testName=ai-astar) 11:44:23 INFO - PROCESS | 21279 | RSS: Main: 169291776 11:44:23 INFO - PROCESS | 21279 | 11:44:23 INFO - PROCESS | 21279 | __start_tp_report 11:44:23 INFO - PROCESS | 21279 | _x_x_mozilla_page_load 11:44:23 INFO - PROCESS | 21279 | _x_x_mozilla_page_load_details 11:44:23 INFO - PROCESS | 21279 | |i|pagename|runs| 11:44:23 INFO - PROCESS | 21279 | |0;ai-astar;112;106;112;111;111;125;113;112;112;113 11:44:23 INFO - PROCESS | 21279 | |1;audio-beat-detection;157;129;154;177;129;159;155;128;196;136 11:44:23 INFO - PROCESS | 21279 | |2;audio-dft;161;163;161;163;163;162;172;163;165;161 11:44:23 INFO - PROCESS | 21279 | |3;audio-fft;74;77;75;163;76;73;73;76;161;75 11:44:23 INFO - PROCESS | 21279 | |4;audio-oscillator;93;93;148;92;92;93;145;93;92;158 11:44:23 INFO - PROCESS | 21279 | |5;imaging-gaussian-blur;117;117;118;117;118;119;118;118;118;117 11:44:23 INFO - PROCESS | 21279 | |6;imaging-darkroom;147;146;146;148;147;146;147;147;146;147 11:44:23 INFO - PROCESS | 21279 | |7;imaging-desaturate;96;96;96;95;95;95;96;95;96;94 11:44:23 INFO - PROCESS | 21279 | |8;json-parse-financial;56;58;56;60;61;56;61;70;55;55 11:44:23 INFO - PROCESS | 21279 | |9;json-stringify-tinderbox;61;62;61;61;61;60;60;61;60;61 11:44:23 INFO - PROCESS | 21279 | |10;stanford-crypto-aes;76;76;76;77;77;78;79;76;77;78 11:44:23 INFO - PROCESS | 21279 | |11;stanford-crypto-ccm;127;123;124;127;125;137;125;132;170;135 11:44:23 INFO - PROCESS | 21279 | |12;stanford-crypto-pbkdf2;174;174;167;170;164;172;167;167;171;164 11:44:23 INFO - PROCESS | 21279 | |13;stanford-crypto-sha256-iterative;67;70;66;69;72;68;68;68;65;68 11:44:23 INFO - PROCESS | 21279 | __end_tp_report 11:44:23 INFO - PROCESS | 21279 | __start_cc_report 11:44:23 INFO - PROCESS | 21279 | _x_x_mozilla_cycle_collect,824 11:44:23 INFO - PROCESS | 21279 | __end_cc_report 11:44:23 INFO - PROCESS | 21279 | __startTimestamp1461350663689__endTimestamp 11:44:23 INFO - PROCESS | 21279 | 11:44:23 INFO - PROCESS | 21279 | ------- Summary: start ------- 11:44:23 INFO - PROCESS | 21279 | Number of tests: 14 11:44:23 INFO - PROCESS | 21279 | 11:44:23 INFO - PROCESS | 21279 | [#0] ai-astar Cycles:10 Average:112.70 Median:112.00 stddev:4.76 (4.3%) stddev-sans-first:5.04 11:44:23 INFO - PROCESS | 21279 | Values: 112.0 106.0 112.0 111.0 111.0 125.0 113.0 112.0 112.0 113.0 11:44:23 INFO - PROCESS | 21279 | 11:44:23 INFO - PROCESS | 21279 | [#1] audio-beat-detection Cycles:10 Average:152.00 Median:156.00 stddev:22.45 (14.4%) stddev-sans-first:23.74 11:44:23 INFO - PROCESS | 21279 | Values: 157.0 129.0 154.0 177.0 129.0 159.0 155.0 128.0 196.0 136.0 11:44:23 INFO - PROCESS | 21279 | 11:44:23 INFO - PROCESS | 21279 | [#2] audio-dft Cycles:10 Average:163.40 Median:163.00 stddev:3.27 (2.0%) stddev-sans-first:3.35 11:44:23 INFO - PROCESS | 21279 | Values: 161.0 163.0 161.0 163.0 163.0 162.0 172.0 163.0 165.0 161.0 11:44:23 INFO - PROCESS | 21279 | 11:44:23 INFO - PROCESS | 21279 | [#3] audio-fft Cycles:10 Average:92.30 Median:75.00 stddev:36.76 (49.0%) stddev-sans-first:38.39 11:44:23 INFO - PROCESS | 21279 | Values: 74.0 77.0 75.0 163.0 76.0 73.0 73.0 76.0 161.0 75.0 11:44:23 INFO - PROCESS | 21279 | 11:44:23 INFO - PROCESS | 21279 | [#4] audio-oscillator Cycles:10 Average:109.90 Median:92.50 stddev:28.09 (30.4%) stddev-sans-first:29.12 11:44:23 INFO - PROCESS | 21279 | Values: 93.0 93.0 148.0 92.0 92.0 93.0 145.0 93.0 92.0 158.0 11:44:23 INFO - PROCESS | 21279 | 11:44:23 INFO - PROCESS | 21279 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.67 (0.6%) stddev-sans-first:0.67 11:44:23 INFO - PROCESS | 21279 | Values: 117.0 117.0 118.0 117.0 118.0 119.0 118.0 118.0 118.0 117.0 11:44:23 INFO - PROCESS | 21279 | 11:44:23 INFO - PROCESS | 21279 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 11:44:23 INFO - PROCESS | 21279 | Values: 147.0 146.0 146.0 148.0 147.0 146.0 147.0 147.0 146.0 147.0 11:44:23 INFO - PROCESS | 21279 | 11:44:23 INFO - PROCESS | 21279 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:96.00 stddev:0.70 (0.7%) stddev-sans-first:0.71 11:44:23 INFO - PROCESS | 21279 | Values: 96.0 96.0 96.0 95.0 95.0 95.0 96.0 95.0 96.0 94.0 11:44:23 INFO - PROCESS | 21279 | 11:44:23 INFO - PROCESS | 21279 | [#8] json-parse-financial Cycles:10 Average:58.80 Median:59.00 stddev:4.59 (7.8%) stddev-sans-first:4.76 11:44:23 INFO - PROCESS | 21279 | Values: 56.0 58.0 56.0 60.0 61.0 56.0 61.0 70.0 55.0 55.0 11:44:23 INFO - PROCESS | 21279 | 11:44:23 INFO - PROCESS | 21279 | [#9] json-stringify-tinderbox Cycles:10 Average:60.80 Median:61.00 stddev:0.63 (1.0%) stddev-sans-first:0.67 11:44:23 INFO - PROCESS | 21279 | Values: 61.0 62.0 61.0 61.0 61.0 60.0 60.0 61.0 60.0 61.0 11:44:23 INFO - PROCESS | 21279 | 11:44:23 INFO - PROCESS | 21279 | [#10] stanford-crypto-aes Cycles:10 Average:77.00 Median:77.00 stddev:1.05 (1.4%) stddev-sans-first:1.05 11:44:23 INFO - PROCESS | 21279 | Values: 76.0 76.0 76.0 77.0 77.0 78.0 79.0 76.0 77.0 78.0 11:44:23 INFO - PROCESS | 21279 | 11:44:23 INFO - PROCESS | 21279 | [#11] stanford-crypto-ccm Cycles:10 Average:132.50 Median:129.50 stddev:14.02 (10.8%) stddev-sans-first:14.73 11:44:23 INFO - PROCESS | 21279 | Values: 127.0 123.0 124.0 127.0 125.0 137.0 125.0 132.0 170.0 135.0 11:44:23 INFO - PROCESS | 21279 | 11:44:23 INFO - PROCESS | 21279 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.00 Median:170.50 stddev:3.74 (2.2%) stddev-sans-first:3.50 11:44:23 INFO - PROCESS | 21279 | Values: 174.0 174.0 167.0 170.0 164.0 172.0 167.0 167.0 171.0 164.0 11:44:23 INFO - PROCESS | 21279 | 11:44:23 INFO - PROCESS | 21279 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.10 Median:68.00 stddev:1.97 (2.9%) stddev-sans-first:2.05 11:44:23 INFO - PROCESS | 21279 | Values: 67.0 70.0 66.0 69.0 72.0 68.0 68.0 68.0 65.0 68.0 11:44:23 INFO - PROCESS | 21279 | -------- Summary: end -------- 11:44:23 INFO - PROCESS | 21279 | 11:44:24 INFO - TEST-INFO | 21279: exit 0 11:44:24 INFO - TEST-OK | kraken | took 61472ms 11:44:24 INFO - SUITE-END | took 1170s 11:44:24 INFO - Completed test suite (00:19:30) 11:44:24 INFO - javascript benchmark 11:44:24 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3122.718955294023, 3165.4776961801304, 3182.204448887778, 3193.8722451101944, 3200.5679233303513, 5339.599530035248, 5342.145256758915, 5357.598180136486, 5422.83731488055, 5455.772451198488, 5166.509181627749, 5286.947130528693, 5360.463953604638, 5413.83758487246, 5445.618806683524, 4728.432588089434, 4766.499517550659, 4807.687500312486, 4814.687045342059, 4869.318295438641, 744.5968949177015, 4721.881952951169, 4789.377380940473, 4854.441739199984, 4896.167651499236, 4843.346148269974, 4849.345338379327, 4852.8544143675745, 4864.0515099555605, 4901.852944411673, 4816.060868130716, 4855.83004594841, 4858.17411040124, 4877.756112194412, 4931.70409775411, 4733.266343716695, 4842.757862106916, 4880.365552478191, 4884.535969082932, 4929.778159982773, 5201.505856943622, 5209.635325527214, 5222.216667499867, 5224.8693782655355, 5243.659162154448, 5582.665040097607, 5649.943500565024, 5669.971650141764, 5685.602007859451, 5690.146478028329, 5696.743646535916, 5759.827205183809, 5766.481016708474, 5797.739101740432, 5833.533317334603, 5339.385970613391, 5350.0, 5350.090484617664, 5355.518003379714, 5360.865978350534, 5756.65460072397, 5799.94200057994, 5836.503897168704, 5849.6782676952325, 5856.912146317809, 5631.0, 5635.492805647511, 5636.126400407861, 5637.182608521742, 5685.147227915763, 5691.857703557362, 5692.658440493584, 5695.829125126253, 5704.572157088235, 5706.914396284059, 5500.037493438632, 5563.610547261734, 5622.409646987089, 5661.405552417019, 5670.858228544319, 5577.247071645357, 5577.581681373832, 5581.274434323512, 5587.608867379245, 5634.464725851038, 4258.254805409041, 4267.701260911768, 4292.5492823253735, 4302.82788688449, 4316.136772645484, 3795.8102094895144, 3890.494235749391, 3891.0466935600393, 3933.6853051755793, 3963.0884896473394, 5299.920501192485, 5400.621956463088, 5445.700486473203, 5458.181272809111, 5496.532794712494, 5659.462351076641, 5678.858028549319, 5695.1741997410145, 5734.799282025109, 5742.626729262584, 5383.461653834664, 5433.673979561239, 5499.50504454601, 5543.916841247385, 5567.276254086943, 4911.926321105187, 4927.28554359623, 4931.728754918514, 4953.1332016896895, 5005.624578156653, 5933.2880054393745, 5939.990201665727, 5941.316748573883, 5943.851403714855, 5946.256717910262, 5516.703574660032, 5752.13717942312, 5760.222369979999, 5799.82600521985, 5803.7388317524965, 5813.069908814569, 5877.823665290048, 5879.823605291848, 5880.735366908414, 5895.086261629454, 5511.641743286674, 5579.414161512983, 5584.078627026495, 5587.357453892854, 5633.549316054788, 5708.172315014383, 5790.9710451449155, 5802.912956305743, 5827.912581311199, 5827.9417205829095, 5561.4716601922755, 5578.163275508706, 5585.776568937359, 5606.131049687305, 5606.6636001840025, 5411.161270003156, 5522.22688823557, 5536.446355364593, 5555.805546805843, 5583.581231407742, 5418.864528386822, 5430.185472179205, 5431.619786614899, 5435.646682965595, 5461.644993075437, 5479.643823151482, 5494.670319780826, 5502.697351645698, 5520.089185284383, 5526.889462210653, 5423.83728488146, 5452.890942181213, 5495.642783219078, 5527.309086364205, 5568.888622227614], "value": 5223.405770435411, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [610.1610285856947, 643.2120652201054, 656.4157899469473, 658.4567731621413, 677.4986509982614, 35861.10347241317, 37486.0, 37566.24867502648, 37620.24759504812, 37729.24541509168, 40955.79522102385, 41771.79114104433, 41773.37339939896, 41908.16183676325, 42008.15983680324, 8656.2642175415, 8812.295016398673, 8819.118088191193, 8820.955895220515, 8887.422317549339, 8706.129387061306, 8722.738317850442, 8776.824463510726, 8785.868211976825, 8803.64785408583, 8799.340049496313, 8812.206901378875, 8861.689840855572, 8878.334124940622, 8890.59992300348, 8720.563971801384, 8797.956010219972, 8799.604017819214, 8830.24942879856, 8859.0, 8733.432326898732, 8801.911980880173, 8803.119688031209, 8825.602847871862, 8843.69047083349, 32258.354832903446, 38172.618273817185, 38404.231915361815, 38472.0, 38775.612243877484, 3431.811250381228, 3456.0, 3692.5753538343165, 3980.7213495055357, 4157.833686652531, 27687.723122768715, 27866.0, 27989.440211195866, 28006.159815205578, 29234.0, 4112.568180341051, 4128.710990230685, 4222.641075508554, 4302.311630139194, 4365.279728844736, 197473.0, 198700.0, 198929.0, 200914.0, 245062.99999999822, 34198.48702269418, 34477.310453790786, 35523.46714799228, 36489.628174168596, 36630.26739465196, 35115.29769404598, 35127.4730879037, 35180.648193517736, 35211.4718279226, 35267.823660882044, 14963.625909352353, 15104.471343502924, 15219.847801522064, 15229.543113706606, 15257.237138143048, 12715.554955576696, 12726.300053496961, 12739.235645861278, 12801.167924084904, 12832.743345133233, 8395.160483951557, 8471.66113355459, 8477.576121193915, 8481.194286542768, 8518.914810851813, 3286.260591366923, 3301.5377847101427, 3320.6181289151573, 3324.1024923270584, 3409.215880347534, 1172.9472173752201, 1174.753301806613, 1204.6325870609548, 1212.4483360071147, 1261.962141135749, 31169.68830311713, 31689.0, 31723.04830855078, 31748.841255794036, 31885.521717174262, 1163.528770847808, 1189.4290740444462, 1209.4859684633996, 1215.1797536662893, 1281.8205451236834, 14702.411903523953, 14875.33061012257, 15266.847331526542, 15287.312070956834, 15426.84573154254, 470209.0, 476477.0, 477704.0, 479563.0, 480118.0, 55463.44536554583, 56983.0, 57059.14411283834, 57111.42888571061, 57170.42829571734, 1335.218896945298, 1422.8292604887479, 1447.6959838433836, 1448.9420423183165, 1462.4150339864138, 28932.56601150942, 29069.27326816762, 29351.412971740017, 30128.54807177938, 30467.695323046486, 47478.52521474741, 48110.5188948106, 48151.75924120357, 48353.5164648349, 48460.757696211294, 415198.0, 420045.0, 424658.0, 424852.0, 425536.0, 27485.725142748317, 27592.0, 27675.58486622662, 27804.16587502378, 27936.161915142577, 46992.29511557261, 47568.52431475641, 47568.762156189, 48225.27662085001, 48420.5157948416, 39572.40641390439, 40363.3945490812, 40457.0, 40497.0, 41405.79297103616, 39445.0, 40327.798361008005, 40613.39079913744, 40639.39040914329, 41617.79191104025, 39949.2010159801, 40025.0, 40794.0, 41143.38284925669, 41175.0, 33587.0, 36299.81850090733, 36543.45184822283, 36573.26853462969, 37104.81447592745, 28039.579406308512, 28040.71959280381, 28468.572971405858, 28477.572836407056, 28491.145265642062], "value": 18082.01155873527, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [401.6144501278772, 404.4762033167048, 406.37621251379136, 407.309610210693, 414.6309784291981, 13801.447942082305, 17324.220410081543, 17928.910355448206, 17985.0, 18673.90663046683, 17391.130443477807, 17630.206640701166, 17927.820721792777, 18389.44831655049, 18436.078196090177, 4991.0, 5460.945390546103, 5573.303337082864, 5595.944040559583, 5694.487496125348, 5627.352854421732, 5666.150077488389, 5670.0927851543765, 5686.545076393879, 5702.54379649627, 5528.281323427969, 5680.857978550549, 5681.261436013312, 5683.403242659502, 5709.172170035343, 5636.2954630671165, 5648.0, 5649.887002259952, 5674.546036317085, 5689.743961521742, 4811.49479304675, 5079.898402031976, 5127.589792816566, 5128.153854613985, 5130.07658621448, 22283.331500055025, 22683.54632907349, 22717.43206419836, 22871.42821429461, 23189.88405057964, 2385.85684858909, 2391.3065211088765, 2402.771736685012, 2596.7533084357146, 2747.2582402751145, 14324.928375358057, 14698.33857476416, 14728.18994955277, 14832.110073395523, 14859.777103343458, 1989.4628450318478, 1995.2617531513433, 2000.0599718132455, 2044.1210279579775, 2047.6109539187507, 61302.999999999556, 67858.3214167857, 70972.2902770976, 78462.21537784606, 78565.21434785637, 9593.616255349847, 9603.567839447242, 10056.145227655732, 10322.638707645196, 10382.480875956171, 14896.478623248135, 14937.477188298357, 15017.924910375377, 15026.398944042116, 15038.0, 7868.173841746534, 8016.7194148204535, 8129.878051829227, 8166.714165004197, 8233.259006689426, 7952.085510166405, 7997.400194985399, 8070.475419097857, 8087.191280871866, 8112.918870811216, 6261.342559031327, 6261.655608941552, 6294.874102517924, 6321.0, 6353.904691429632, 1801.4595621313815, 1844.271512752482, 1860.944171674852, 1873.7421407204286, 1877.5270087694219, 439.1831193979196, 452.1431886574922, 454.8248924164154, 463.4947906781624, 1038.7766630174397, 11481.253718508271, 11927.224730392496, 12020.819687704692, 12022.158448908667, 12162.817557736642, 451.5552181101612, 454.23688203817244, 466.8996165824364, 470.37440204527894, 480.9879753006133, 6373.139626150411, 6464.644444555594, 6485.092087107809, 6511.967440162769, 6587.637679927554, 452493.0, 452805.0, 466838.0, 518598.0, 522815.0, 88430.0, 97908.51045744868, 103353.48323258336, 103772.0, 104273.47863260635, 1082.1505118481955, 1120.1263014848432, 1142.702897246722, 1142.948567314473, 1151.5624062856061, 16628.908472140596, 16694.0, 16915.069671168203, 17436.0, 17634.73547896757, 28276.0, 38660.42009369918, 38834.80582597069, 39017.609823901395, 39506.60493395029, 49987.50012499974, 52851.20723189078, 52995.20507192472, 53862.46137538574, 54391.45608543864, 7915.406344524068, 8568.143185681382, 8638.222559969381, 8725.694600688945, 8791.0, 8600.440971336842, 8881.200691937756, 9096.317776166947, 9400.623975040922, 9725.367851089657, 8142.226488483585, 8626.870596941177, 8650.43772154808, 8732.126787321216, 8903.73288801337, 4722.858314250578, 7073.257307982588, 8261.669533218845, 8349.0, 8620.52587107715, 8531.104234055334, 8741.256993155654, 8807.955960220157, 9079.046700096394, 9138.588763505792, 12660.430280637209, 13060.542880999119, 13133.146345487512, 13215.801762973755, 13443.395047222702, 12814.743705126031, 13009.349532523525, 13135.146215495963, 13164.275964822027, 13190.670233244246], "value": 8457.554426470357, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1537.8539038791312, 1581.7231984402727, 1746.196749495232, 1826.6438044581312, 1855.09100540735, 7527.661255243514, 8011.67953281868, 8073.87889181662, 8398.874016889751, 8408.159184081596, 8015.679372825095, 8073.354131669467, 8140.552269625168, 8166.0, 8212.630431630576, 2269.3645779181816, 2301.723793144825, 2319.976800231993, 2332.323626148415, 2335.29941017694, 2240.820734341257, 2244.629636110048, 2275.2036787124457, 2283.908643654252, 2289.473421113145, 2297.9195728149516, 2314.93055208344, 2320.883955802203, 2348.6946696929463, 2357.363511851799, 2232.3860938242033, 2245.1692873636775, 2250.527389248268, 2254.3462395905167, 2258.2096266306826, 2267.104493724986, 2276.681264622954, 2276.931692049241, 2277.81777457803, 2285.919992800244, 8222.753317400488, 8308.667653293922, 8330.916690833075, 8337.749867503984, 8348.499090054616, 5141.305923700327, 5313.203019547061, 5343.358796944352, 5352.571794256489, 5352.839414817523, 3319.7842140260805, 3430.9656903430896, 3496.667816557423, 3514.0863375522295, 3538.02704256329, 1158.25871442277, 1179.9056075514025, 1183.4201241391743, 1191.1780871198932, 1210.5036934856755, 10759.193060520414, 11052.834207486894, 11111.499982500807, 11121.221514493907, 11133.888661113366, 4403.097365040159, 4419.668524860648, 4531.546845315442, 4542.295944128666, 4571.839985600488, 9532.52337383128, 9534.427934323963, 9582.856257156149, 9588.328816982883, 9590.08894155054, 5121.641485096007, 5129.666571672829, 5130.4356520782685, 5139.922901156486, 5192.091384007859, 4184.28867092595, 4681.6020638245445, 4785.976070119627, 4786.736729479912, 4821.180399332052, 3747.4191500317493, 3768.9434658480145, 3797.867074652429, 3830.387138057953, 3877.6897848172644, 1233.5990802989065, 1240.348816871132, 1244.5581818454318, 1251.2117366059506, 1253.59258241072, 940.67546696391, 949.5862374762717, 956.1538038835541, 967.849983252597, 969.6509256667593, 5523.751431185607, 5540.556755459554, 5652.434756524397, 5707.885842283131, 5783.71081445926, 447.4898615578243, 455.7083466581391, 456.3086923311186, 456.4066713272732, 464.79781295136723, 3835.6547910688173, 3897.025743564109, 3900.0, 3901.1612503311926, 3933.370660694275, 9939.701808945743, 10388.065074143364, 10428.739281517872, 10455.895441045644, 10464.162866970624, 10076.29465937392, 10095.192384609214, 10273.794524109626, 10291.742706432398, 10319.896801031893, 7867.2919437249775, 7872.763817085496, 7873.740201567722, 7885.723999659985, 7951.522908625501, 5429.891402172014, 5466.289382380265, 5469.617126801086, 5496.31296087989, 5618.494335509824, 9375.906240937777, 9404.95297523508, 9418.670346537838, 9447.433154010781, 9560.665376711782, 9209.815803684023, 9592.904070959481, 9665.565049572926, 9677.129058384779, 9694.515274236119, 6746.494012949147, 7050.189228238818, 7286.125664920243, 7502.399808015455, 7612.961935190288, 7755.379569634529, 7774.105977812624, 7810.218978102144, 7849.058113026474, 7855.921440785748, 7031.0, 7199.568025918462, 7209.4953353266865, 7226.494145409771, 7363.042804435389, 6934.583924964519, 6948.930510694829, 7106.609136497335, 7108.822279442848, 7164.820879478055, 6398.776042838665, 6488.610683359014, 6530.510211734044, 6539.901901471577, 6551.672416379257, 4694.084653492536, 4839.782209800638, 4854.101991131652, 4855.975720121377, 4913.48408417111, 4920.286558449076, 4955.776990035385, 4980.750962451791, 4991.425986011655, 5016.949830501794], "value": 4377.528181645937, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [313.88543181738675, 316.642194320418, 317.197490349416, 327.89999050289657, 333.1338519848393, 5829.679367634779, 6065.939340606593, 6098.75604975801, 6134.325224225332, 6157.969210153954, 5846.444587764156, 5991.221141251631, 6037.909431358533, 6043.6373817570975, 6046.758129674808, 4571.7942692578745, 4586.908261834753, 4608.631309495249, 4611.677182597219, 4618.769061546926, 4386.824527018932, 4574.153781550423, 4596.471405788327, 4601.447826260854, 4645.651576131787, 4526.162659907911, 4532.206863798839, 4540.160070386973, 4550.067236216568, 4555.157295900252, 4494.752788596626, 4549.317602359656, 4551.112533056055, 4552.294394368878, 4582.839600613963, 3809.009657489045, 3901.609839016104, 3909.257241124177, 3913.8630147944687, 3942.7634341939574, 5751.827445176651, 5757.337906140764, 5787.305523337226, 5810.622309549865, 5814.6511209327155, 5207.505286997767, 5221.0, 5244.737763111829, 5245.449227831099, 5260.132078207092, 5979.372165922602, 6290.43386095249, 6291.811245662638, 6311.8737625247695, 6359.523035772336, 4305.246581848164, 4306.44016277885, 4309.978450107761, 4326.740395576276, 4345.782710864476, 6286.308506064375, 6512.0, 6532.150820393318, 6571.145751052381, 6612.966935165341, 4406.647468202536, 4415.0, 4424.269995450714, 4428.446444194476, 4437.06821567468, 4484.744271603956, 4491.832123647875, 4494.0, 4503.189425903303, 4504.572065653758, 5100.897982040413, 5237.502437268454, 5238.554722848525, 5240.71176085319, 5260.763265653055, 6175.722092505848, 6356.459700925473, 6371.299157092716, 6376.3623637635865, 6378.298387177407, 1550.3023639362107, 1552.9301181446635, 1565.4990403071135, 1566.5848550134224, 1566.7649852521986, 1007.3754272351189, 1024.4672770159475, 1027.3630349183404, 1039.0700323210683, 1043.4626167523732, 6109.602875813058, 6112.786052488142, 6129.0, 6129.785457508966, 6129.938700613026, 6506.479481641457, 6512.251091124486, 6535.803925882231, 6550.672466376662, 6578.934210657832, 5899.6405806311095, 6078.6048906820915, 6122.877542449126, 6125.846853828601, 6132.41742034506, 3498.8425520851624, 3505.5618047744033, 3518.5601799775027, 3532.293541291752, 3544.929101417957, 6602.240742314695, 6751.662416879235, 6769.8646027079185, 6782.491313151533, 6795.252522222551, 6632.9336706633285, 6674.83312917181, 6684.331566843277, 6721.798346049626, 6747.0, 6537.182852143482, 6677.632730199788, 6704.798856034229, 6727.654469106198, 6737.764178253738, 6446.9355306448215, 6469.547131700736, 6476.125723027331, 6478.384553467413, 6490.772822951174, 6327.651979141007, 6445.935540644721, 6455.903161452488, 6474.449671777952, 6514.902276465951, 6736.360045795642, 6759.324067593201, 6766.86466270662, 6782.355676210752, 6789.15135608049, 4312.598405518156, 4325.4593175853015, 4346.956530434782, 4347.434833471629, 4359.520452750132, 6283.3402492737605, 6365.331640177715, 6422.976762319854, 6544.312847151171, 6602.933970660424, 6359.236891573041, 6377.96811015942, 6425.839354016187, 6459.224893012869, 6464.450521705708, 6166.876662466815, 6383.36166383358, 6395.648239346694, 6417.614943103429, 6426.3573642635365, 6295.844742469948, 6314.0, 6322.861884860769, 6333.65164915934, 6336.398042185985, 6468.0, 6470.5147113965695, 6471.2234531856475, 6478.70845811949, 6484.837879053061, 6074.451014991149, 6209.813705588839, 6337.65142917144, 6348.206474190726, 6364.204474440695], "value": 4753.240380294395, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [841.2807049972273, 859.4198915731879, 863.6200071968335, 870.212457725758, 873.9388242823005, 13878.722425551496, 14034.087784294014, 14183.078099923498, 14235.43058277669, 14255.3585088671, 12972.96216302696, 13433.992450566198, 13576.0, 13622.795658065137, 13653.453861845514, 838.4801423117675, 840.5377042626561, 841.8316336732663, 846.7840700621333, 847.682119205298, 826.8801023851538, 842.2756429470651, 842.4818736477084, 843.7595285343679, 843.797488602734, 878.3807415771897, 878.8901387326584, 880.058337578791, 881.1320848963766, 881.6649673124236, 876.5529579914225, 879.7712594725353, 880.5817236812495, 881.18930583863, 883.924866386358, 639.5714871036416, 639.8528338482129, 640.123031446916, 640.9871802563969, 641.5156556799586, 13249.73500529984, 13317.467301307935, 13334.933325333312, 13359.666008349772, 13363.465461381533, 12432.564860229939, 12592.81110783339, 12783.680407989781, 12858.67853303675, 12885.226886386847, 10902.563897444094, 10911.181661375349, 11034.337939723562, 11103.666889993314, 11318.547258109666, 3736.047307936486, 3760.2667479841443, 3891.6692081173132, 3979.303621866191, 3991.2815693175216, 47749.0, 55402.72298638521, 58304.708476457774, 59983.70008149975, 60490.76564640477, 11625.941870290595, 11629.651110466699, 11713.062954963583, 11731.47208375625, 11741.412929353499, 19059.61880762377, 20471.38585842397, 20549.48626284325, 20627.38117856467, 20646.690299645517, 8571.400001999926, 8582.356323275779, 8680.8697869532, 8792.60433280504, 8865.867011994826, 4746.976265118652, 4878.731529802206, 4979.800807967713, 4982.800687972441, 5016.724080175625, 3349.949750753741, 3406.829658517064, 3434.261633748756, 3435.2442462658173, 3437.0, 545.3374150407274, 547.225675668924, 551.6444780786101, 556.3379578301808, 556.5686592890543, 651.0822510822511, 654.358728446116, 750.7334896111802, 815.282551354804, 829.2246749289434, 9538.761530961643, 9552.37909535878, 9692.41845489273, 9974.202063834875, 10115.342502737298, 599.1372423709844, 693.7329128285545, 764.3426653078349, 773.5474747272908, 785.8390220669975, 4501.347304640809, 4558.33904083906, 4562.749048802348, 4611.5619016193405, 4658.1848176568965, 63810.68094659497, 64235.35764642387, 64675.0, 65039.0, 65062.0, 57940.420595793505, 58072.0, 58093.0, 58127.0, 58179.70910145507, 48275.275870861966, 48362.51637483651, 48666.27000594994, 49127.0, 49752.75123624359, 9388.483633399956, 9532.52337383142, 9684.95157524208, 9767.462789546358, 9799.363041402286, 26833.060842870407, 30854.0, 30957.226069348446, 31219.175823352787, 31967.520487192247, 41646.79176604097, 44366.0, 44435.777821110685, 45004.0, 45074.32388514109, 12019.0, 12065.155439119528, 12077.879221207675, 12168.878311216775, 12183.025357971519, 13671.043026988413, 14068.648283792987, 14104.435822566982, 14140.15159090458, 14489.420423182955, 12290.0, 12394.008479321814, 12612.49550017989, 12832.679183020498, 13191.340432978504, 13218.801717974045, 13222.4049917752, 13383.799243011168, 13971.371288292254, 13977.650558736113, 12474.750504989668, 13023.218606883618, 13137.73724525485, 13353.265570393722, 13579.321033948065, 10867.0, 11065.612703555336, 11338.376389298668, 11366.0, 11402.329079624851, 10488.160947124365, 10663.57345706194, 10684.252102353072, 10693.465326733787, 10722.51748671296], "value": 6843.438270976509, "unit": "score"}], "name": "dromaeo_css", "value": 6960.85784086103, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 106.0, 112.0, 111.0, 111.0, 125.0, 113.0, 112.0, 112.0, 113.0], "value": 112.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 129.0, 154.0, 177.0, 129.0, 159.0, 155.0, 128.0, 196.0, 136.0], "value": 152.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 161.0, 163.0, 163.0, 162.0, 172.0, 163.0, 165.0, 161.0], "value": 163.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 77.0, 75.0, 163.0, 76.0, 73.0, 73.0, 76.0, 161.0, 75.0], "value": 92.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 148.0, 92.0, 92.0, 93.0, 145.0, 93.0, 92.0, 158.0], "value": 109.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 117.0, 118.0, 119.0, 118.0, 118.0, 118.0, 117.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 148.0, 147.0, 146.0, 147.0, 147.0, 146.0, 147.0], "value": 146.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 95.0, 95.0, 95.0, 96.0, 95.0, 96.0, 94.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 58.0, 56.0, 60.0, 61.0, 56.0, 61.0, 70.0, 55.0, 55.0], "value": 58.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 61.0, 61.0, 61.0, 60.0, 60.0, 61.0, 60.0, 61.0], "value": 60.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 77.0, 77.0, 78.0, 79.0, 76.0, 77.0, 78.0], "value": 77.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 123.0, 124.0, 127.0, 125.0, 137.0, 125.0, 132.0, 170.0, 135.0], "value": 132.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 174.0, 167.0, 170.0, 164.0, 172.0, 167.0, 167.0, 171.0, 164.0], "value": 169.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 70.0, 66.0, 69.0, 72.0, 68.0, 68.0, 68.0, 65.0, 68.0], "value": 68.1, "unit": "score"}], "name": "kraken", "value": 1556.3, "alertThreshold": 2.0}]} 11:44:24 INFO - Return code: 0 11:44:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 11:44:24 ERROR - # TBPL SUCCESS # 11:44:24 INFO - Running post-action listener: _resource_record_post_action 11:44:24 INFO - Running post-run listener: _resource_record_post_run 11:44:26 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 4096; Write bytes: 536752128; Read time: 12; Write time: 542308 11:44:26 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 244817920; Read time: 0; Write time: 345812 11:44:26 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 4096; Write bytes: 289705984; Read time: 12; Write time: 196276 11:44:26 INFO - Running post-run listener: _upload_blobber_files 11:44:26 INFO - Blob upload gear active. 11:44:26 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:44:26 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 11:44:26 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:44:26 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:44:26 INFO - (blobuploader) - INFO - Open directory for files ... 11:44:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:44:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:44:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:44:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:44:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:44:27 INFO - (blobuploader) - INFO - Done attempting. 11:44:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:44:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:44:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:44:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:44:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:44:28 INFO - (blobuploader) - INFO - Done attempting. 11:44:28 INFO - (blobuploader) - INFO - Iteration through files over. 11:44:28 INFO - Return code: 0 11:44:28 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:44:28 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:44:28 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2fb7d48ebdc5c1d136e6a6f33b00598d6f4023e3bf39a7579080565d15e8d4aa0a0e4becd085198037466f37e13609aea0d447f07219a3c5ea429ec92267c6d9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/24f3abc1b91fb042d0891de03510021942801313cf0d3885488491b4e6279d56a0cad1a9078fc1e7090a94072ebbe3a14cc34dcf27ff8d70fb789f2d8b8fab86"} 11:44:28 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:44:28 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:44:28 INFO - Contents: 11:44:28 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2fb7d48ebdc5c1d136e6a6f33b00598d6f4023e3bf39a7579080565d15e8d4aa0a0e4becd085198037466f37e13609aea0d447f07219a3c5ea429ec92267c6d9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/24f3abc1b91fb042d0891de03510021942801313cf0d3885488491b4e6279d56a0cad1a9078fc1e7090a94072ebbe3a14cc34dcf27ff8d70fb789f2d8b8fab86"} 11:44:28 INFO - Running post-run listener: copy_logs_to_upload_dir 11:44:28 INFO - Copying logs to upload dir... 11:44:28 INFO - mkdir: /builds/slave/test/build/upload/logs 11:44:28 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1227.519919 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 27 secs) (at 2016-04-22 11:44:28.076752) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-22 11:44:28.080107) ========= 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=523ca41ca1e0623de333ad52000001bf-1461349438.743498-1884361186 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/Fx-Team/sha512/2fb7d48ebdc5c1d136e6a6f33b00598d6f4023e3bf39a7579080565d15e8d4aa0a0e4becd085198037466f37e13609aea0d447f07219a3c5ea429ec92267c6d9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/24f3abc1b91fb042d0891de03510021942801313cf0d3885488491b4e6279d56a0cad1a9078fc1e7090a94072ebbe3a14cc34dcf27ff8d70fb789f2d8b8fab86"} build_url:https://queue.taskcluster.net/v1/task/Zx-wswNnS1qxZsl05YdR2Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011082 build_url: 'https://queue.taskcluster.net/v1/task/Zx-wswNnS1qxZsl05YdR2Q/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/Fx-Team/sha512/2fb7d48ebdc5c1d136e6a6f33b00598d6f4023e3bf39a7579080565d15e8d4aa0a0e4becd085198037466f37e13609aea0d447f07219a3c5ea429ec92267c6d9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/24f3abc1b91fb042d0891de03510021942801313cf0d3885488491b4e6279d56a0cad1a9078fc1e7090a94072ebbe3a14cc34dcf27ff8d70fb789f2d8b8fab86"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-22 11:44:28.104062) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 11:44:28.104354) ========= 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=523ca41ca1e0623de333ad52000001bf-1461349438.743498-1884361186 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004450 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 11:44:28.187070) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-22 11:44:28.187359) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-22 11:44:28.187658) ========= ========= Total master_lag: 0.15 =========