builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-040 starttime: 1461837099.24 results: success (0) buildid: 20160428015359 builduid: ee963c5e1f6447609dfe930dbda8b1b7 revision: 2157fe6b6efd14c217404bf3fe7d28699dc47ce4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-28 02:51:39.244065) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-28 02:51:39.244572) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-28 02:51:39.244890) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-28 02:51:39.261063) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 02:51:39.261376) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1461837099.146399-1328139825 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-28 02:51:39-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 228M=0s 2016-04-28 02:51:39 (228 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.142201 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 02:51:39.418962) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 02:51:39.419547) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1461837099.146399-1328139825 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017834 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 02:51:39.472519) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-28 02:51:39.473150) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 2157fe6b6efd14c217404bf3fe7d28699dc47ce4 --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 2157fe6b6efd14c217404bf3fe7d28699dc47ce4 --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=9e0dfe3369c33a1556e63f89000001d8-1461837099.146399-1328139825 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-28 02:51:40,083 truncating revision to first 12 chars 2016-04-28 02:51:40,083 Setting DEBUG logging. 2016-04-28 02:51:40,083 attempt 1/10 2016-04-28 02:51:40,083 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/2157fe6b6efd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-28 02:51:40,966 unpacking tar archive at: fx-team-2157fe6b6efd/testing/mozharness/ program finished with exit code 0 elapsedTime=1.140738 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-28 02:51:40.627833) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-28 02:51:40.628177) ========= script_repo_revision: 2157fe6b6efd14c217404bf3fe7d28699dc47ce4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-28 02:51:40.628594) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-28 02:51:40.628889) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-28 02:51:40.639860) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-04-28 02:51:40.640146) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9e0dfe3369c33a1556e63f89000001d8-1461837099.146399-1328139825 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:51:41 INFO - MultiFileLogger online at 20160428 02:51:41 in /builds/slave/test 02:51:41 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 02:51:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:51:41 INFO - {'append_to_log': False, 02:51:41 INFO - 'base_work_dir': '/builds/slave/test', 02:51:41 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 02:51:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:51:41 INFO - 'branch': 'Fx-Team-Non-PGO', 02:51:41 INFO - 'buildbot_json_path': 'buildprops.json', 02:51:41 INFO - 'config_files': ('talos/linux_config.py',), 02:51:41 INFO - 'default_actions': ('clobber', 02:51:41 INFO - 'read-buildbot-config', 02:51:41 INFO - 'download-and-extract', 02:51:41 INFO - 'populate-webroot', 02:51:41 INFO - 'create-virtualenv', 02:51:41 INFO - 'install', 02:51:41 INFO - 'run-tests'), 02:51:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:51:41 INFO - 'download_minidump_stackwalk': True, 02:51:41 INFO - 'download_symbols': 'ondemand', 02:51:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:51:41 INFO - 'tooltool.py': '/tools/tooltool.py', 02:51:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:51:41 INFO - '/tools/misc-python/virtualenv.py')}, 02:51:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:51:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:51:41 INFO - 'installer_path': 'installer.exe', 02:51:41 INFO - 'log_level': 'info', 02:51:41 INFO - 'log_name': 'talos', 02:51:41 INFO - 'log_to_console': True, 02:51:41 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:51:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:51:41 INFO - 'opt_config_files': (), 02:51:41 INFO - 'pip_index': False, 02:51:41 INFO - 'sps_profile': False, 02:51:41 INFO - 'sps_profile_interval': 0, 02:51:41 INFO - 'suite': 'dromaeojs-e10s', 02:51:41 INFO - 'system_bits': '32', 02:51:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:51:41 INFO - 'title': 'talos-linux64-ix-040', 02:51:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:51:41 INFO - 'use_talos_json': True, 02:51:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:51:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:51:41 INFO - 'work_dir': 'build'} 02:51:41 INFO - ##### 02:51:41 INFO - ##### Running clobber step. 02:51:41 INFO - ##### 02:51:41 INFO - Running pre-action listener: _resource_record_pre_action 02:51:41 INFO - Running main action method: clobber 02:51:41 INFO - rmtree: /builds/slave/test/build 02:51:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:51:41 INFO - Running post-action listener: _resource_record_post_action 02:51:41 INFO - ##### 02:51:41 INFO - ##### Running read-buildbot-config step. 02:51:41 INFO - ##### 02:51:41 INFO - Running pre-action listener: _resource_record_pre_action 02:51:41 INFO - Running main action method: read_buildbot_config 02:51:41 INFO - Using buildbot properties: 02:51:41 INFO - { 02:51:41 INFO - "project": "", 02:51:41 INFO - "product": "firefox", 02:51:41 INFO - "script_repo_revision": "production", 02:51:41 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 02:51:41 INFO - "repository": "", 02:51:41 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 02:51:41 INFO - "buildid": "20160428015359", 02:51:41 INFO - "pgo_build": "False", 02:51:41 INFO - "basedir": "/builds/slave/test", 02:51:41 INFO - "buildnumber": 1450, 02:51:41 INFO - "slavename": "talos-linux64-ix-040", 02:51:41 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 02:51:41 INFO - "platform": "ubuntu64_hw", 02:51:41 INFO - "scheduler": "tests-fx-team-linux64-talos", 02:51:41 INFO - "branch": "fx-team", 02:51:41 INFO - "repo_path": "integration/fx-team", 02:51:41 INFO - "revision": "2157fe6b6efd14c217404bf3fe7d28699dc47ce4", 02:51:41 INFO - "stage_platform": "linux64", 02:51:41 INFO - "builduid": "ee963c5e1f6447609dfe930dbda8b1b7", 02:51:41 INFO - "slavebuilddir": "test" 02:51:41 INFO - } 02:51:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/Q0Vhu-HzTe6qjq03Mj0Rqg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 02:51:41 INFO - Running post-action listener: _resource_record_post_action 02:51:41 INFO - ##### 02:51:41 INFO - ##### Running download-and-extract step. 02:51:41 INFO - ##### 02:51:41 INFO - Running pre-action listener: _resource_record_pre_action 02:51:41 INFO - Running main action method: download_and_extract 02:51:41 INFO - mkdir: /builds/slave/test/build/tests 02:51:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:51:41 INFO - https://queue.taskcluster.net/v1/task/Q0Vhu-HzTe6qjq03Mj0Rqg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 02:51:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q0Vhu-HzTe6qjq03Mj0Rqg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 02:51:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q0Vhu-HzTe6qjq03Mj0Rqg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 02:51:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q0Vhu-HzTe6qjq03Mj0Rqg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 02:51:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q0Vhu-HzTe6qjq03Mj0Rqg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 02:51:42 INFO - Downloaded 1361 bytes. 02:51:42 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 02:51:42 INFO - Using the following test package requirements: 02:51:42 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 02:51:42 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:51:42 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:51:42 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:51:42 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:51:42 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:51:42 INFO - u'jsshell-linux-x86_64.zip'], 02:51:42 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:51:42 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:51:42 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 02:51:42 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:51:42 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:51:42 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:51:42 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:51:42 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:51:42 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:51:42 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:51:42 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:51:42 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:51:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:51:42 INFO - https://queue.taskcluster.net/v1/task/Q0Vhu-HzTe6qjq03Mj0Rqg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:51:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q0Vhu-HzTe6qjq03Mj0Rqg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:51:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q0Vhu-HzTe6qjq03Mj0Rqg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:51:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q0Vhu-HzTe6qjq03Mj0Rqg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:51:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q0Vhu-HzTe6qjq03Mj0Rqg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:51:43 INFO - Downloaded 22293278 bytes. 02:51:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:51:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 02:51:44 INFO - Return code: 0 02:51:44 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 02:51:44 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')]} 02:51:44 INFO - https://queue.taskcluster.net/v1/task/Q0Vhu-HzTe6qjq03Mj0Rqg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:51:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q0Vhu-HzTe6qjq03Mj0Rqg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:51:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q0Vhu-HzTe6qjq03Mj0Rqg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:51:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q0Vhu-HzTe6qjq03Mj0Rqg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:51:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q0Vhu-HzTe6qjq03Mj0Rqg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:51:45 INFO - Downloaded 22293278 bytes. 02:51:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:51:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 02:51:47 INFO - Return code: 0 02:51:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:51:47 INFO - https://queue.taskcluster.net/v1/task/Q0Vhu-HzTe6qjq03Mj0Rqg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:51:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q0Vhu-HzTe6qjq03Mj0Rqg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 02:51:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q0Vhu-HzTe6qjq03Mj0Rqg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 02:51:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q0Vhu-HzTe6qjq03Mj0Rqg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 02:51:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q0Vhu-HzTe6qjq03Mj0Rqg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 02:51:48 INFO - Downloaded 10840145 bytes. 02:51:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:51:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 02:51:48 INFO - Return code: 0 02:51:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:51:48 INFO - https://queue.taskcluster.net/v1/task/Q0Vhu-HzTe6qjq03Mj0Rqg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:51:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q0Vhu-HzTe6qjq03Mj0Rqg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 02:51:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q0Vhu-HzTe6qjq03Mj0Rqg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 02:51:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q0Vhu-HzTe6qjq03Mj0Rqg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 02:51:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q0Vhu-HzTe6qjq03Mj0Rqg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 02:51:49 INFO - Downloaded 54839067 bytes. 02:51:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Q0Vhu-HzTe6qjq03Mj0Rqg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 02:51:49 INFO - mkdir: /builds/slave/test/properties 02:51:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:51:49 INFO - Writing to file /builds/slave/test/properties/build_url 02:51:49 INFO - Contents: 02:51:49 INFO - build_url:https://queue.taskcluster.net/v1/task/Q0Vhu-HzTe6qjq03Mj0Rqg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 02:51:50 INFO - Running post-action listener: _resource_record_post_action 02:51:50 INFO - Running post-action listener: set_extra_try_arguments 02:51:50 INFO - ##### 02:51:50 INFO - ##### Running populate-webroot step. 02:51:50 INFO - ##### 02:51:50 INFO - Running pre-action listener: _resource_record_pre_action 02:51:50 INFO - Running main action method: populate_webroot 02:51:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:51:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:51:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:51:50 INFO - '--tppagecycles', 02:51:50 INFO - '7'], 02:51:50 INFO - 'tests': ['tsvgm']}}, 02:51:50 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:51:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:51:50 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:51:50 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:51:50 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:51:50 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:51:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:51:50 INFO - 'talos_options': ['--disable-e10s'], 02:51:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:51:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:51:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:51:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:51:50 INFO - 'talos_options': ['--disable-e10s'], 02:51:50 INFO - 'tests': ['damp', 'tps']}, 02:51:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:51:50 INFO - 'tests': ['damp', 'tps']}, 02:51:50 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:51:50 INFO - 'tests': ['dromaeo_dom']}, 02:51:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:51:50 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:51:50 INFO - 'tests': ['a11yr', 02:51:50 INFO - 'ts_paint', 02:51:50 INFO - 'tpaint', 02:51:50 INFO - 'sessionrestore', 02:51:50 INFO - 'sessionrestore_no_auto_restore', 02:51:50 INFO - 'tabpaint']}, 02:51:50 INFO - 'other-e10s': {'tests': ['a11yr', 02:51:50 INFO - 'ts_paint', 02:51:50 INFO - 'tpaint', 02:51:50 INFO - 'sessionrestore', 02:51:50 INFO - 'sessionrestore_no_auto_restore', 02:51:50 INFO - 'tabpaint']}, 02:51:50 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:51:50 INFO - 'ts_paint', 02:51:50 INFO - 'tpaint', 02:51:50 INFO - 'sessionrestore', 02:51:50 INFO - 'sessionrestore_no_auto_restore', 02:51:50 INFO - 'tabpaint']}, 02:51:50 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:51:50 INFO - 'ts_paint', 02:51:50 INFO - 'tpaint', 02:51:50 INFO - 'sessionrestore', 02:51:50 INFO - 'sessionrestore_no_auto_restore', 02:51:50 INFO - 'tabpaint']}, 02:51:50 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:51:50 INFO - 'tests': ['a11yr', 02:51:50 INFO - 'ts_paint', 02:51:50 INFO - 'tpaint', 02:51:50 INFO - 'sessionrestore', 02:51:50 INFO - 'sessionrestore_no_auto_restore', 02:51:50 INFO - 'tabpaint']}, 02:51:50 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:51:50 INFO - 'tests': ['a11yr', 02:51:50 INFO - 'ts_paint', 02:51:50 INFO - 'tpaint', 02:51:50 INFO - 'sessionrestore', 02:51:50 INFO - 'sessionrestore_no_auto_restore', 02:51:50 INFO - 'tabpaint']}, 02:51:50 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:51:50 INFO - 'tests': ['tsvgx', 02:51:50 INFO - 'tsvgr_opacity', 02:51:50 INFO - 'tart', 02:51:50 INFO - 'tscrollx', 02:51:50 INFO - 'cart']}, 02:51:50 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:51:50 INFO - 'tsvgr_opacity', 02:51:50 INFO - 'tart', 02:51:50 INFO - 'tscrollx', 02:51:50 INFO - 'cart']}, 02:51:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:51:50 INFO - 'talos_options': ['--disable-e10s'], 02:51:50 INFO - 'tests': ['tp5o']}, 02:51:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:51:50 INFO - 'tests': ['tp5o']}, 02:51:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:51:50 INFO - 'talos_options': ['--disable-e10s', 02:51:50 INFO - '--xperf_path', 02:51:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:51:50 INFO - 'tests': ['tp5n']}, 02:51:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:51:50 INFO - 'talos_options': ['--xperf_path', 02:51:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:51:50 INFO - 'tests': ['tp5n']}}, 02:51:50 INFO - 'talos.zip': {'path': '', 02:51:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:51:50 INFO - Running post-action listener: _resource_record_post_action 02:51:50 INFO - ##### 02:51:50 INFO - ##### Running create-virtualenv step. 02:51:50 INFO - ##### 02:51:50 INFO - Running pre-action listener: _resource_record_pre_action 02:51:50 INFO - Running main action method: create_virtualenv 02:51:50 INFO - Creating virtualenv /builds/slave/test/build/venv 02:51:50 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 02:51:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:51:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:51:50 INFO - Using real prefix '/usr' 02:51:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:51:51 INFO - Installing distribute.............................................................................................................................................................................................done. 02:51:53 INFO - Installing pip.................done. 02:51:53 INFO - Return code: 0 02:51:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:51:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:51:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:51:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:51:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:51:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51:53 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 0x7fc083d2bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11795a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1208410>, '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 0x1209310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12097a0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1461837099.146399-1328139825', '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 02:51:53 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 02:51:53 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 02:51:53 INFO - Using env: {'DISPLAY': ':0', 02:51:53 INFO - 'HOME': '/home/cltbld', 02:51:53 INFO - 'LANG': 'en_US.UTF-8', 02:51:53 INFO - 'LANGUAGE': 'en_US:en', 02:51:53 INFO - 'LOGNAME': 'cltbld', 02:51:53 INFO - 'MAIL': '/var/mail/cltbld', 02:51:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:51:53 INFO - 'MOZ_NO_REMOTE': '1', 02:51:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:51:53 INFO - 'NO_EM_RESTART': '1', 02:51:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:51:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:51:53 INFO - 'PWD': '/builds/slave/test', 02:51:53 INFO - 'SHELL': '/bin/bash', 02:51:53 INFO - 'SHLVL': '1', 02:51:53 INFO - 'TERM': 'linux', 02:51:53 INFO - 'TMOUT': '86400', 02:51:53 INFO - 'USER': 'cltbld', 02:51:53 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1461837099.146399-1328139825', 02:51:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:51:53 INFO - '_': '/tools/buildbot/bin/python'} 02:51:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:51:53 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 02:51:53 INFO - Cleaning up... 02:51:53 INFO - Return code: 0 02:51:53 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 02:51:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:51:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:51:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:51:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:51:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51:53 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 0x7fc083d2bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11795a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1208410>, '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 0x1209310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12097a0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1461837099.146399-1328139825', '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 02:51:53 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 02:51:53 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 02:51:53 INFO - Using env: {'DISPLAY': ':0', 02:51:53 INFO - 'HOME': '/home/cltbld', 02:51:53 INFO - 'LANG': 'en_US.UTF-8', 02:51:53 INFO - 'LANGUAGE': 'en_US:en', 02:51:53 INFO - 'LOGNAME': 'cltbld', 02:51:53 INFO - 'MAIL': '/var/mail/cltbld', 02:51:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:51:53 INFO - 'MOZ_NO_REMOTE': '1', 02:51:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:51:53 INFO - 'NO_EM_RESTART': '1', 02:51:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:51:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:51:53 INFO - 'PWD': '/builds/slave/test', 02:51:53 INFO - 'SHELL': '/bin/bash', 02:51:53 INFO - 'SHLVL': '1', 02:51:53 INFO - 'TERM': 'linux', 02:51:53 INFO - 'TMOUT': '86400', 02:51:53 INFO - 'USER': 'cltbld', 02:51:53 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1461837099.146399-1328139825', 02:51:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:51:53 INFO - '_': '/tools/buildbot/bin/python'} 02:51:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:51:53 INFO - Downloading/unpacking psutil>=0.7.1 02:51:53 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 02:51:53 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 02:51:53 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 02:51:53 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 02:51:53 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 02:51:53 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 02:51:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:51:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:51:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:51:55 INFO - Installing collected packages: psutil 02:51:55 INFO - Running setup.py install for psutil 02:51:55 INFO - building 'psutil._psutil_linux' extension 02:51:55 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 02:51:56 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 02:51:56 INFO - building 'psutil._psutil_posix' extension 02:51:56 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 02:51:56 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 02:51:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:51:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:51:56 INFO - Successfully installed psutil 02:51:56 INFO - Cleaning up... 02:51:56 INFO - Return code: 0 02:51:56 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 02:51:56 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')]} 02:51:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:51:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51:56 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')]} 02:51:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:51:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51:56 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 0x7fc083d2bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11795a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1208410>, '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 0x1209310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12097a0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1461837099.146399-1328139825', '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 02:51:56 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 02:51:56 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 02:51:56 INFO - Using env: {'DISPLAY': ':0', 02:51:56 INFO - 'HOME': '/home/cltbld', 02:51:56 INFO - 'LANG': 'en_US.UTF-8', 02:51:56 INFO - 'LANGUAGE': 'en_US:en', 02:51:56 INFO - 'LOGNAME': 'cltbld', 02:51:56 INFO - 'MAIL': '/var/mail/cltbld', 02:51:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:51:56 INFO - 'MOZ_NO_REMOTE': '1', 02:51:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:51:56 INFO - 'NO_EM_RESTART': '1', 02:51:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:51:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:51:56 INFO - 'PWD': '/builds/slave/test', 02:51:56 INFO - 'SHELL': '/bin/bash', 02:51:56 INFO - 'SHLVL': '1', 02:51:56 INFO - 'TERM': 'linux', 02:51:56 INFO - 'TMOUT': '86400', 02:51:56 INFO - 'USER': 'cltbld', 02:51:56 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1461837099.146399-1328139825', 02:51:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:51:56 INFO - '_': '/tools/buildbot/bin/python'} 02:51:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:51:56 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02:51:56 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 02:51:56 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 02:51:56 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 02:51:56 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 02:51:56 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 02:51:56 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 02:51:58 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:51:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:51:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 02:51:58 INFO - Installing collected packages: mozsystemmonitor 02:51:58 INFO - Running setup.py install for mozsystemmonitor 02:51:58 INFO - Successfully installed mozsystemmonitor 02:51:58 INFO - Cleaning up... 02:51:58 INFO - Return code: 0 02:51:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:51:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:51:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:51:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:51:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:51:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51:58 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 0x7fc083d2bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11795a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1208410>, '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 0x1209310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12097a0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1461837099.146399-1328139825', '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 02:51:58 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 02:51:58 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 02:51:58 INFO - Using env: {'DISPLAY': ':0', 02:51:58 INFO - 'HOME': '/home/cltbld', 02:51:58 INFO - 'LANG': 'en_US.UTF-8', 02:51:58 INFO - 'LANGUAGE': 'en_US:en', 02:51:58 INFO - 'LOGNAME': 'cltbld', 02:51:58 INFO - 'MAIL': '/var/mail/cltbld', 02:51:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:51:58 INFO - 'MOZ_NO_REMOTE': '1', 02:51:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:51:58 INFO - 'NO_EM_RESTART': '1', 02:51:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:51:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:51:58 INFO - 'PWD': '/builds/slave/test', 02:51:58 INFO - 'SHELL': '/bin/bash', 02:51:58 INFO - 'SHLVL': '1', 02:51:58 INFO - 'TERM': 'linux', 02:51:58 INFO - 'TMOUT': '86400', 02:51:58 INFO - 'USER': 'cltbld', 02:51:58 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1461837099.146399-1328139825', 02:51:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:51:58 INFO - '_': '/tools/buildbot/bin/python'} 02:51:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:51:58 INFO - Downloading/unpacking blobuploader==1.2.4 02:51:58 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 02:51:58 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 02:51:58 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 02:51:58 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 02:51:58 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 02:51:58 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 02:52:00 INFO - Downloading blobuploader-1.2.4.tar.gz 02:52:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:52:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:52:01 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 02:52:01 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 02:52:01 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 02:52:01 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 02:52:01 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 02:52:01 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 02:52:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:52:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:52:01 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 02:52:01 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 02:52:01 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 02:52:01 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 02:52:01 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 02:52:01 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 02:52:01 INFO - Downloading docopt-0.6.1.tar.gz 02:52:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:52:01 INFO - Installing collected packages: blobuploader, requests, docopt 02:52:01 INFO - Running setup.py install for blobuploader 02:52:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:52:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:52:01 INFO - Running setup.py install for requests 02:52:02 INFO - Running setup.py install for docopt 02:52:02 INFO - Successfully installed blobuploader requests docopt 02:52:02 INFO - Cleaning up... 02:52:02 INFO - Return code: 0 02:52:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:52: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')]} 02:52:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:52:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:52: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')]} 02:52:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:52:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:52:02 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 0x7fc083d2bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11795a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1208410>, '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 0x1209310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12097a0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1461837099.146399-1328139825', '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 02:52:02 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 02:52:02 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 02:52:02 INFO - Using env: {'DISPLAY': ':0', 02:52:02 INFO - 'HOME': '/home/cltbld', 02:52:02 INFO - 'LANG': 'en_US.UTF-8', 02:52:02 INFO - 'LANGUAGE': 'en_US:en', 02:52:02 INFO - 'LOGNAME': 'cltbld', 02:52:02 INFO - 'MAIL': '/var/mail/cltbld', 02:52:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:52:02 INFO - 'MOZ_NO_REMOTE': '1', 02:52:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:52:02 INFO - 'NO_EM_RESTART': '1', 02:52:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:52:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:52:02 INFO - 'PWD': '/builds/slave/test', 02:52:02 INFO - 'SHELL': '/bin/bash', 02:52:02 INFO - 'SHLVL': '1', 02:52:02 INFO - 'TERM': 'linux', 02:52:02 INFO - 'TMOUT': '86400', 02:52:02 INFO - 'USER': 'cltbld', 02:52:02 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1461837099.146399-1328139825', 02:52:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:52:02 INFO - '_': '/tools/buildbot/bin/python'} 02:52:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:52:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:52:02 INFO - Running setup.py (path:/tmp/pip-Y4KvLH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:52:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:52:02 INFO - Running setup.py (path:/tmp/pip-J4w2OY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:52:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:52:02 INFO - Running setup.py (path:/tmp/pip-R8dmQS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:52:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:52:02 INFO - Running setup.py (path:/tmp/pip-cAVW1i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:52:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:52:02 INFO - Running setup.py (path:/tmp/pip-pPWCmZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:52:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:52:02 INFO - Running setup.py (path:/tmp/pip-4HbF5V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:52:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:52:02 INFO - Running setup.py (path:/tmp/pip-hR1zvn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:52:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:52:03 INFO - Running setup.py (path:/tmp/pip-g0JIyu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:52:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:52:03 INFO - Running setup.py (path:/tmp/pip-cyA4dE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:52:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:52:03 INFO - Running setup.py (path:/tmp/pip-5HtDjj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:52:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:52:03 INFO - Running setup.py (path:/tmp/pip-etYG8P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:52:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:52:03 INFO - Running setup.py (path:/tmp/pip-ZUG3rg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:52:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:52:03 INFO - Running setup.py (path:/tmp/pip-G5YBus-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:52:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:52:03 INFO - Running setup.py (path:/tmp/pip-c3rCYU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:52:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:52:03 INFO - Running setup.py (path:/tmp/pip-o_sTQh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:52:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:52:03 INFO - Running setup.py (path:/tmp/pip-ltvCCY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:52:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:52:03 INFO - Running setup.py (path:/tmp/pip-o1iRPX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:52:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:52:03 INFO - Running setup.py install for manifestparser 02:52:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:52:03 INFO - Running setup.py install for mozcrash 02:52:03 INFO - Running setup.py install for mozdebug 02:52:04 INFO - Running setup.py install for mozdevice 02:52:04 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:52:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:52:04 INFO - Running setup.py install for mozfile 02:52:04 INFO - Running setup.py install for mozhttpd 02:52:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:52:04 INFO - Running setup.py install for mozinfo 02:52:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:52:04 INFO - Running setup.py install for mozInstall 02:52:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:52:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:52:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:52:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:52:04 INFO - Running setup.py install for mozleak 02:52:04 INFO - Running setup.py install for mozlog 02:52:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:52:04 INFO - Running setup.py install for moznetwork 02:52:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:52:04 INFO - Running setup.py install for mozprocess 02:52:05 INFO - Running setup.py install for mozprofile 02:52:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:52:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:52:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:52:05 INFO - Running setup.py install for mozrunner 02:52:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:52:05 INFO - Running setup.py install for mozscreenshot 02:52:05 INFO - Running setup.py install for moztest 02:52:05 INFO - Running setup.py install for mozversion 02:52:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:52:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:52:05 INFO - Cleaning up... 02:52:05 INFO - Return code: 0 02:52:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:52:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:52:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:52:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:52:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:52:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:52:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:52:05 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 0x7fc083d2bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11795a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1208410>, '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 0x1209310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12097a0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1461837099.146399-1328139825', '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 02:52:05 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 02:52:05 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 02:52:05 INFO - Using env: {'DISPLAY': ':0', 02:52:05 INFO - 'HOME': '/home/cltbld', 02:52:05 INFO - 'LANG': 'en_US.UTF-8', 02:52:05 INFO - 'LANGUAGE': 'en_US:en', 02:52:05 INFO - 'LOGNAME': 'cltbld', 02:52:05 INFO - 'MAIL': '/var/mail/cltbld', 02:52:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:52:05 INFO - 'MOZ_NO_REMOTE': '1', 02:52:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:52:05 INFO - 'NO_EM_RESTART': '1', 02:52:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:52:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:52:05 INFO - 'PWD': '/builds/slave/test', 02:52:05 INFO - 'SHELL': '/bin/bash', 02:52:05 INFO - 'SHLVL': '1', 02:52:05 INFO - 'TERM': 'linux', 02:52:05 INFO - 'TMOUT': '86400', 02:52:05 INFO - 'USER': 'cltbld', 02:52:05 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1461837099.146399-1328139825', 02:52:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:52:05 INFO - '_': '/tools/buildbot/bin/python'} 02:52:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:52:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:52:05 INFO - Running setup.py (path:/tmp/pip-4KDRIX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:52:05 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)) 02:52:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:52:05 INFO - Running setup.py (path:/tmp/pip-2MOubs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:52:05 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)) 02:52:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:52:05 INFO - Running setup.py (path:/tmp/pip-9yWvUM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:52:05 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)) 02:52:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:52:05 INFO - Running setup.py (path:/tmp/pip-0qAeHh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:52:06 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)) 02:52:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:52:06 INFO - Running setup.py (path:/tmp/pip-jZOOco-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:52:06 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)) 02:52:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:52:06 INFO - Running setup.py (path:/tmp/pip-lDSmui-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:52:06 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)) 02:52:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:52:06 INFO - Running setup.py (path:/tmp/pip-qMOWgY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:52:06 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)) 02:52:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:52:06 INFO - Running setup.py (path:/tmp/pip-EmNCoz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:52:06 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)) 02:52:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:52:06 INFO - Running setup.py (path:/tmp/pip-JQ4_O2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:52:06 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)) 02:52:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:52:06 INFO - Running setup.py (path:/tmp/pip-5rA_Lg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:52:06 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)) 02:52:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:52:06 INFO - Running setup.py (path:/tmp/pip-J75qmN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:52:06 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)) 02:52:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:52:06 INFO - Running setup.py (path:/tmp/pip-NsMyag-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:52:06 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)) 02:52:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:52:06 INFO - Running setup.py (path:/tmp/pip-mkt7Nr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:52:06 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)) 02:52:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:52:06 INFO - Running setup.py (path:/tmp/pip-uuHLa4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:52:06 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)) 02:52:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:52:06 INFO - Running setup.py (path:/tmp/pip-AW7I8V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:52:06 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)) 02:52:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:52:06 INFO - Running setup.py (path:/tmp/pip-YtfzRJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:52:06 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)) 02:52:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:52:06 INFO - Running setup.py (path:/tmp/pip-dbgNJ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:52:07 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)) 02:52:07 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)) 02:52:07 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)) 02:52:07 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)) 02:52:07 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)) 02:52:07 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)) 02:52:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:52:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:52:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:52:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:52:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:52:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:52:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:52:08 INFO - Downloading blessings-1.6.tar.gz 02:52:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:52:08 INFO - Installing collected packages: blessings 02:52:08 INFO - Running setup.py install for blessings 02:52:09 INFO - Successfully installed blessings 02:52:09 INFO - Cleaning up... 02:52:09 INFO - Return code: 0 02:52:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:52:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:52:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:52:09 INFO - Reading from file tmpfile_stdout 02:52:09 INFO - Current package versions: 02:52:09 INFO - argparse == 1.2.1 02:52:09 INFO - blessings == 1.6 02:52:09 INFO - blobuploader == 1.2.4 02:52:09 INFO - docopt == 0.6.1 02:52:09 INFO - manifestparser == 1.1 02:52:09 INFO - mozInstall == 1.12 02:52:09 INFO - mozcrash == 0.17 02:52:09 INFO - mozdebug == 0.1 02:52:09 INFO - mozdevice == 0.48 02:52:09 INFO - mozfile == 1.2 02:52:09 INFO - mozhttpd == 0.7 02:52:09 INFO - mozinfo == 0.9 02:52:09 INFO - mozleak == 0.1 02:52:09 INFO - mozlog == 3.1 02:52:09 INFO - moznetwork == 0.27 02:52:09 INFO - mozprocess == 0.22 02:52:09 INFO - mozprofile == 0.28 02:52:09 INFO - mozrunner == 6.11 02:52:09 INFO - mozscreenshot == 0.1 02:52:09 INFO - mozsystemmonitor == 0.0 02:52:09 INFO - moztest == 0.7 02:52:09 INFO - mozversion == 1.4 02:52:09 INFO - psutil == 3.1.1 02:52:09 INFO - requests == 1.2.3 02:52:09 INFO - wsgiref == 0.1.2 02:52:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:52:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:52:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:52:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:52:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:52:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:52:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:52:09 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 0x7fc083d2bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11795a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1208410>, '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 0x1209310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12097a0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1461837099.146399-1328139825', '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 02:52:09 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 02:52:09 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 02:52:09 INFO - Using env: {'DISPLAY': ':0', 02:52:09 INFO - 'HOME': '/home/cltbld', 02:52:09 INFO - 'LANG': 'en_US.UTF-8', 02:52:09 INFO - 'LANGUAGE': 'en_US:en', 02:52:09 INFO - 'LOGNAME': 'cltbld', 02:52:09 INFO - 'MAIL': '/var/mail/cltbld', 02:52:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:52:09 INFO - 'MOZ_NO_REMOTE': '1', 02:52:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:52:09 INFO - 'NO_EM_RESTART': '1', 02:52:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:52:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:52:09 INFO - 'PWD': '/builds/slave/test', 02:52:09 INFO - 'SHELL': '/bin/bash', 02:52:09 INFO - 'SHLVL': '1', 02:52:09 INFO - 'TERM': 'linux', 02:52:09 INFO - 'TMOUT': '86400', 02:52:09 INFO - 'USER': 'cltbld', 02:52:09 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1461837099.146399-1328139825', 02:52:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:52:09 INFO - '_': '/tools/buildbot/bin/python'} 02:52:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:52:09 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)) 02:52:09 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)) 02:52:09 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)) 02:52:09 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)) 02:52:09 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)) 02:52:09 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)) 02:52:09 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)) 02:52:09 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)) 02:52:09 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)) 02:52:09 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)) 02:52:09 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)) 02:52:09 INFO - Cleaning up... 02:52:09 INFO - Return code: 0 02:52:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:52:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:52:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:52:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:52:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:52:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:52:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:52:09 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 0x7fc083d2bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11795a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1208410>, '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 0x1209310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12097a0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1461837099.146399-1328139825', '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 02:52:09 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 02:52:09 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 02:52:09 INFO - Using env: {'DISPLAY': ':0', 02:52:09 INFO - 'HOME': '/home/cltbld', 02:52:09 INFO - 'LANG': 'en_US.UTF-8', 02:52:09 INFO - 'LANGUAGE': 'en_US:en', 02:52:09 INFO - 'LOGNAME': 'cltbld', 02:52:09 INFO - 'MAIL': '/var/mail/cltbld', 02:52:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:52:09 INFO - 'MOZ_NO_REMOTE': '1', 02:52:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:52:09 INFO - 'NO_EM_RESTART': '1', 02:52:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:52:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:52:09 INFO - 'PWD': '/builds/slave/test', 02:52:09 INFO - 'SHELL': '/bin/bash', 02:52:09 INFO - 'SHLVL': '1', 02:52:09 INFO - 'TERM': 'linux', 02:52:09 INFO - 'TMOUT': '86400', 02:52:09 INFO - 'USER': 'cltbld', 02:52:09 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1461837099.146399-1328139825', 02:52:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:52:09 INFO - '_': '/tools/buildbot/bin/python'} 02:52:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:52:09 INFO - Downloading/unpacking jsonschema 02:52:09 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 02:52:09 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 02:52:09 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 02:52:09 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 02:52:09 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 02:52:09 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 02:52:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:52:11 INFO - Downloading/unpacking functools32 (from jsonschema) 02:52:11 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 02:52:11 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 02:52:11 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 02:52:11 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 02:52:11 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 02:52:11 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 02:52:12 INFO - Downloading functools32-3.2.3-2.tar.gz 02:52:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:52:12 INFO - warning: no files found matching '*.txt' 02:52:12 INFO - no previously-included directories found matching 'build' 02:52:12 INFO - no previously-included directories found matching 'dist' 02:52:12 INFO - no previously-included directories found matching '.git*' 02:52:12 INFO - Installing collected packages: jsonschema, functools32 02:52:12 INFO - Running setup.py install for functools32 02:52:12 INFO - warning: no files found matching '*.txt' 02:52:12 INFO - no previously-included directories found matching 'build' 02:52:12 INFO - no previously-included directories found matching 'dist' 02:52:12 INFO - no previously-included directories found matching '.git*' 02:52:12 INFO - Successfully installed jsonschema functools32 02:52:12 INFO - Cleaning up... 02:52:12 INFO - Return code: 0 02:52:12 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:52:12 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')]} 02:52:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:52:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:52:12 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')]} 02:52:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:52:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:52:12 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 0x7fc083d2bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11795a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1208410>, '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 0x1209310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12097a0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1461837099.146399-1328139825', '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 02:52:12 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 02:52:12 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 02:52:12 INFO - Using env: {'DISPLAY': ':0', 02:52:12 INFO - 'HOME': '/home/cltbld', 02:52:12 INFO - 'LANG': 'en_US.UTF-8', 02:52:12 INFO - 'LANGUAGE': 'en_US:en', 02:52:12 INFO - 'LOGNAME': 'cltbld', 02:52:12 INFO - 'MAIL': '/var/mail/cltbld', 02:52:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:52:12 INFO - 'MOZ_NO_REMOTE': '1', 02:52:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:52:12 INFO - 'NO_EM_RESTART': '1', 02:52:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:52:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:52:12 INFO - 'PWD': '/builds/slave/test', 02:52:12 INFO - 'SHELL': '/bin/bash', 02:52:12 INFO - 'SHLVL': '1', 02:52:12 INFO - 'TERM': 'linux', 02:52:12 INFO - 'TMOUT': '86400', 02:52:12 INFO - 'USER': 'cltbld', 02:52:12 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1461837099.146399-1328139825', 02:52:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:52:12 INFO - '_': '/tools/buildbot/bin/python'} 02:52:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:52:12 INFO - Downloading/unpacking flake8 02:52:12 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 02:52:12 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 02:52:12 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 02:52:12 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 02:52:12 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 02:52:12 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 02:52:14 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:52:14 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:52: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 02:52: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 02:52: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 02:52: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 02:52: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 02:52: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 02:52:14 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:52:14 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:52: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 02:52: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 02:52: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 02:52: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 02:52: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 02:52: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 02:52:14 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:52: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 02:52: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 02:52: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 02:52: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 02:52: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 02:52: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 02:52:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:52:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:52:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:52:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:52:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:52:15 INFO - no previously-included directories found matching 'docs/_build' 02:52:15 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:52:15 INFO - Running setup.py install for pep8 02:52:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:52:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:52:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:52:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:52:15 INFO - no previously-included directories found matching 'docs/_build' 02:52:15 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:52:15 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:52:15 INFO - Cleaning up... 02:52:15 INFO - Return code: 0 02:52:15 INFO - Running post-action listener: _resource_record_post_action 02:52:15 INFO - Running post-action listener: _start_resource_monitoring 02:52:15 INFO - Starting resource monitoring. 02:52:15 INFO - ##### 02:52:15 INFO - ##### Running install step. 02:52:15 INFO - ##### 02:52:15 INFO - Running pre-action listener: _resource_record_pre_action 02:52:15 INFO - Running main action method: install 02:52:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:52:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:52:15 INFO - Reading from file tmpfile_stdout 02:52:15 INFO - Detecting whether we're running mozinstall >=1.0... 02:52:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:52:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:52:15 INFO - Reading from file tmpfile_stdout 02:52:15 INFO - Output received: 02:52:15 INFO - Usage: mozinstall [options] installer 02:52:15 INFO - Options: 02:52:15 INFO - -h, --help show this help message and exit 02:52:15 INFO - -d DEST, --destination=DEST 02:52:15 INFO - Directory to install application into. [default: 02:52:15 INFO - "/builds/slave/test"] 02:52:15 INFO - --app=APP Application being installed. [default: firefox] 02:52:15 INFO - mkdir: /builds/slave/test/build/application 02:52:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 02:52:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 02:52:31 INFO - Reading from file tmpfile_stdout 02:52:31 INFO - Output received: 02:52:31 INFO - /builds/slave/test/build/application/firefox/firefox 02:52:31 INFO - Running post-action listener: _resource_record_post_action 02:52:31 INFO - ##### 02:52:31 INFO - ##### Running run-tests step. 02:52:31 INFO - ##### 02:52:31 INFO - Running pre-action listener: _resource_record_pre_action 02:52:31 INFO - Running main action method: run_tests 02:52:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:52:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:52:31 INFO - Python 2.7.3 02:52:31 INFO - Return code: 0 02:52:31 INFO - grabbing minidump binary from tooltool 02:52:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:52:31 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 0x1208410>, '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 0x1209310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12097a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:52:31 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 02:52:31 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 02:52:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:52:31 INFO - Return code: 0 02:52:31 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:52:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:52:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:52:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:52:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:52:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:52:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:52:32 INFO - Return code: 0 02:52:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Q0Vhu-HzTe6qjq03Mj0Rqg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-040', '--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 02:52:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Q0Vhu-HzTe6qjq03Mj0Rqg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-040 --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 02:52:32 INFO - Using env: {'DISPLAY': ':0', 02:52:32 INFO - 'HOME': '/home/cltbld', 02:52:32 INFO - 'LANG': 'en_US.UTF-8', 02:52:32 INFO - 'LANGUAGE': 'en_US:en', 02:52:32 INFO - 'LOGNAME': 'cltbld', 02:52:32 INFO - 'MAIL': '/var/mail/cltbld', 02:52:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:52:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:52:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:52:32 INFO - 'MOZ_NO_REMOTE': '1', 02:52:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:52:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:52:32 INFO - 'NO_EM_RESTART': '1', 02:52:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:52:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:52:32 INFO - 'PWD': '/builds/slave/test', 02:52:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:52:32 INFO - 'SHELL': '/bin/bash', 02:52:32 INFO - 'SHLVL': '1', 02:52:32 INFO - 'TERM': 'linux', 02:52:32 INFO - 'TMOUT': '86400', 02:52:32 INFO - 'USER': 'cltbld', 02:52:32 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1461837099.146399-1328139825', 02:52:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:52:32 INFO - '_': '/tools/buildbot/bin/python'} 02:52:32 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Q0Vhu-HzTe6qjq03Mj0Rqg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-040', '--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 02:52:32 INFO - mozversion application_buildid: 20160428015359 02:52:32 INFO - mozversion application_changeset: 2157fe6b6efd14c217404bf3fe7d28699dc47ce4 02:52:32 INFO - mozversion application_display_name: Nightly 02:52:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:52:32 INFO - mozversion application_name: Firefox 02:52:32 INFO - mozversion application_remotingname: firefox 02:52:32 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 02:52:32 INFO - mozversion application_vendor: Mozilla 02:52:32 INFO - mozversion application_version: 49.0a1 02:52:32 INFO - mozversion platform_buildid: 20160428015359 02:52:32 INFO - mozversion platform_changeset: 2157fe6b6efd14c217404bf3fe7d28699dc47ce4 02:52:32 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 02:52:32 INFO - mozversion platform_version: 49.0a1 02:52:32 INFO - using testdate: 1461837152 02:52:32 INFO - actual date: 1461837152 02:52:32 INFO - starting webserver on 'localhost:39831' 02:52:32 INFO - SUITE-START | Running 2 tests 02:52:32 INFO - TEST-START | dromaeo_css 02:52:32 INFO - operating with platform_type : linux_ 02:52:32 INFO - Initialising browser for dromaeo_css test... 02:52:32 INFO - TEST-INFO | started process 25122 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDOXbyf/profile http://localhost:39831/getInfo.html) 02:52:36 INFO - PROCESS | 25122 | 02:52:36 INFO - PROCESS | 25122 | (process:25191): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 02:52:37 INFO - PROCESS | 25122 | __metrics Screen width/height:1600/1200 02:52:37 INFO - PROCESS | 25122 | colorDepth:24 02:52:37 INFO - PROCESS | 25122 | Browser inner width/height: 1024/697 02:52:37 INFO - PROCESS | 25122 | __metrics 02:52:38 ERROR - PROCESS | 25122 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 02:52:39 INFO - TEST-INFO | 25122: exit 0 02:52:39 INFO - Browser initialized. 02:52:39 INFO - Running cycle 1/1 for dromaeo_css test... 02:52:39 INFO - TEST-INFO | started process 25242 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDOXbyf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:52:41 INFO - PROCESS | 25242 | 02:52:41 INFO - PROCESS | 25242 | (process:25303): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 02:52:51 INFO - PROCESS | 25242 | RSS: Main: 166387712 02:52:51 INFO - PROCESS | 25242 | 02:53:40 INFO - PROCESS | 25242 | 1461837220682 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] 02:55:52 INFO - PROCESS | 25242 | Cycle 1(1): loaded http://localhost:39831/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39831/tests/dromaeo/cssquery-ext.html) 02:55:53 INFO - PROCESS | 25242 | RSS: Main: 170717184 02:55:53 INFO - PROCESS | 25242 | 02:58:55 INFO - PROCESS | 25242 | Cycle 1(1): loaded http://localhost:39831/tests/dromaeo/cssquery-ext.html (next: http://localhost:39831/tests/dromaeo/cssquery-jquery.html) 02:58:56 INFO - PROCESS | 25242 | RSS: Main: 167219200 02:58:56 INFO - PROCESS | 25242 | 03:01:58 INFO - PROCESS | 25242 | Cycle 1(1): loaded http://localhost:39831/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39831/tests/dromaeo/cssquery-mootools.html) 03:01:58 INFO - PROCESS | 25242 | RSS: Main: 168235008 03:01:58 INFO - PROCESS | 25242 | 03:05:00 INFO - PROCESS | 25242 | Cycle 1(1): loaded http://localhost:39831/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39831/tests/dromaeo/cssquery-prototype.html) 03:05:01 INFO - PROCESS | 25242 | RSS: Main: 166301696 03:05:01 INFO - PROCESS | 25242 | 03:08:03 INFO - PROCESS | 25242 | Cycle 1(1): loaded http://localhost:39831/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39831/tests/dromaeo/cssquery-yui.html) 03:08:04 INFO - PROCESS | 25242 | RSS: Main: 167403520 03:08:04 INFO - PROCESS | 25242 | 03:11:06 INFO - PROCESS | 25242 | Cycle 1(1): loaded http://localhost:39831/tests/dromaeo/cssquery-yui.html (next: http://localhost:39831/tests/dromaeo/cssquery-dojo.html) 03:11:07 INFO - PROCESS | 25242 | RSS: Main: 169598976 03:11:07 INFO - PROCESS | 25242 | 03:11:07 INFO - PROCESS | 25242 | __start_tp_report 03:11:07 INFO - PROCESS | 25242 | _x_x_mozilla_page_load 03:11:07 INFO - PROCESS | 25242 | _x_x_mozilla_page_load_details 03:11:07 INFO - PROCESS | 25242 | |i|pagename|runs| 03:11:07 INFO - PROCESS | 25242 | |0;dojo.html;2651.8011149163813;2719.238613188307;2726.7818574514017;2761.3648860762023;2770.8060435769494;4661.557152070556;4750.239961606144;4763.333133361328;4768.976155119224;4804.25534042224;4653.604443622287;4693.225617773063;4715.528447155283;4775.570198682118;4782.497837727032;4333.2416827055295;4418.1384629997165;4422.270325396305;4426.004149066466;4441.844535441261;650.6072015891666;4170.35359519275;4307.461567304087;4337.696361254713;4344.500382456026;4313.956860431418;4338.674599405057;4356.607905288539;4364.476262848479;4419.867403977886;4342.804573794187;4353.1293741251875;4360.302351623756;4372.759498227596;4393.209222339978;4304.483461984551;4352.477702675667;4368.279233926399;4390.056137930328;4408.448943882015;4619.260918253063;4628.3288923105965;4629.0279041401345;4642.303654451825;4668.393108895856;4919.950800491985;5000.224965130411;5022.347094877642;5033.723145227011;5046.09170349337;5128.794848206067;5143.588512918957;5152.381714194284;5153.2785410042625;5191;4746.21687421575;4788.664793464493;4791.688540244873;4792.592629626451;4825.324454576362;4957.752112394366;5215.217717342429;5266.394364648115;5294.285271488377;5348.465153484621;5022.773975171126;5041.168207245837;5049.924251136236;5054.848354549369;5076.974615126975;5133.230015497706;5137.460566640524;5145.099607568661;5145.897082058338;5186.844394668166;4875.0493653737185;5001.89996200074;5084.720340381315;5098.898022039612;5129.563987061141;5035.597152227813;5041.143005689041;5047.116754567936;5052.343195384577;5124.180131178993;3990.541087774885;3993.880183594497;3995.900102497461;4006.338954072604;4031.395290706359;3447.1382154461385;3460.671236232554;3520.507129001942;3591.497190393347;3650.7261955353456;4501.842435514741;4515.616172625298;4529.411176547093;4549.0447006128425;4561.566651168134;5110.7955681773055;5126.948975460096;5130.97434512825;5131.948680513222;5138.177891537411;4422.557744225552;4474.664400170001;4512.616427603625;4529.773511324421;4531.886702832389;4668.276417155346;4672.275797251432;4676.579107880307;4677.925571663455;4732.219183834698;4733.905321893474;4928.457869634337;4948.628852836052;4956.132676781621;5013.724245166478;5112.821051263188;5119.078565858182;5173.81891633791;5178.663386879841;5182.32629758129;4908.705477671351;4934.062528119646;4943.678660887031;4947.431045429677;4991.625628077836;4909.975450122726;5011.674241174312;5021.7343839939895;5022;5028.59771218309;5040.042391945519;5061.645684802029;5062.772175252197;5064.949350506447;5105.617078719185;4886.780094895667;4904.313396124474;4905.141600219876;4927.827526036572;4950.851474455772;4768.094062128184;4911.165101932608;4911.901761964812;4954.108260512998;4990.201567749288;4844.685095468783;4847.297141914473;4869.488703686204;4889.119958407521;4906.484819093944;4898;4900.093482705711;4904.117258893433;4933.112039832865;4952.8761780955765;4723.220668589644;4839.2983017462975;4855.465898751064;4893.681910675795;4897.9020419592125 03:11:07 INFO - PROCESS | 25242 | |1;ext.html;567.937526872044;615.0558892100626;627.5952010952935;632.2760439297004;641.8908785506463;33003.174920626996;33952.83023584885;34087.31825363491;34114.82942585283;34194;35006.29987400251;35453.75911843086;35621.643783562155;35627.64372356276;35825.46261806075;7537.095548534184;7641.885371719429;7642.694292228304;7715.267049630276;7721.961390193042;7642.656080476364;7814.374850012014;7829.217078292182;7837.921620783776;7839.451238413313;7789.260020298063;7833.882491762628;7838.764837054898;7851.332636725857;7865.331446827026;7779.7666070017995;7786.961065194694;7807.843843123134;7819.765407037798;7834.843303133963;7686.308232259067;7738.961305193494;7767.53394796314;7789.260020298063;7796.4932279401655;25470;34684.47973280403;35192;35210;35303;2860.3850172212865;2882.20739296693;3009.0822299198735;3324.6176689680756;3623.184783423735;24139.879300603385;24907.128250511327;24907.875460622763;25095.121670741435;25260.49479010428;3176.5235214717745;3245.464498357768;3255.3489302139665;3263.0863358259726;3304.6364899860996;167059;167652;168358;168645;169953;31288.21779455532;31617.367652647277;31678.841605791822;31726;31790.682093178773;33032.66967330344;49956.500434995185;51069.23396149061;51129.74435127801;51346.74326628343;14638.121712697272;14829.925850370895;14850.777238341434;14883.181425021729;14935.925320373328;11398.886011139948;11422.657320280405;11429.371384573762;11441.656750297505;11453.885461145448;17559.912200438917;17560.824391756174;17612.823871761375;17645.558861028578;17668;6737.258901520829;6855.965720171367;7045;7078.858422831515;7129.287071292829;775.8836174573746;903.1781079217881;995.2137811129271;1003.4681618742078;1035.7928414317166;26553.601695974576;26761.197164085108;27242.318942026606;27261.591076133478;27844.860775696397;918.5866360137965;964.609333220047;990.2028866762181;1013.852991316255;1031.0720351683544;13183;13481;13719.725605487834;13910.165390076629;14044.508442204473;261513;264897;265753;266416;268196;46321.768391158505;47145.29282060772;47175.52824471711;47177.29234061492;47198.292025619645;1214.8602910665386;1270.2695949828885;1297.5199176304827;1305.9934700326628;1313.8029295605545;25085.623715643917;26247.868760656074;26326.341841454116;26476;27054.458910822068;40156.59843401646;40915.18169636531;40972.79513602413;40993.79503102465;40995.38506922458;246656;247335;248174;249237;249397;24339.513209735353;33049;33620.327593448485;33686.83156584201;34110.48834267537;36220.4566931491;39605.60394396019;40069;40850.387244190766;40926.795366022976;33548.66451335455;34304;34342;34860.30279394347;35161.824190878884;33510.832445837616;33890.830545847115;34008.65991340154;34396.31207375888;34745.826270868485;28092.43815123727;30979.535306969963;31653.525197121602;33910.83044584761;34726.82636586801;27948;28897.988570399935;28945.56581651235;28999.710002900545;29082.854585726935;23547;24534.50930981406;24646.599200747503;24832.751672483046;24945.625815613144 03:11:07 INFO - PROCESS | 25242 | |2;jquery.html;386.7660065660277;391.30543285667943;394.51080659981596;395.34372940918075;397.0906623831426;12258.387080645976;14994.850051499481;15125.09249445034;15746.606334841621;15749.527514174579;15038.849611503882;15264.16047117408;15464.922675386635;15806.209689515536;15854.524364269091;4962.826301079463;5066.088104141253;5082.3138876251605;5096.133657278272;5124.128898087334;4989.950100498985;5146.099432599281;5188.948110518884;5203.947960520384;5217.34783152106;5153.2785410042625;5157.819476318329;5158.638895277332;5162.664426812264;5163.173892177252;5008.3238762767105;5115.411727651312;5126.820561280338;5171.172612382001;5175.870603234912;4619.86140415788;4633.49031606523;4633.582977532038;4647.930281045787;4648.093621743761;18620.44138675842;18964.24143034277;19672.901635491875;19775.40673779789;19784.505387365287;1698.524413164316;1859.1633764805892;1959.5297128689012;2100.8634438761433;2340.5552944940405;8815.647374105092;8943.821123577492;9006.099390061006;9135.132162444557;9348.95325523368;1813.727940808876;1833.468294194682;1861.292708770672;1863.7670291213599;1867.085128287143;53352.466475335525;56448.717756411366;56740.716296418665;56796.716016419654;57343.713281433746;9794.069563391466;9976.401415915068;10002.149817265468;10192.949035254776;10314.638987635397;11926.582569610195;12794;14092.436302547783;14176.574702758933;14189.716205675828;6914.965425172842;7109.715611375591;7116.750913717995;7186.10173728284;7245.637718114179;6476.902846457307;6496.545241833121;6530.575512591667;6856.725730970706;6911.619860907598;4315.525292217853;4404.955950440519;4430.224710675619;4512.593866552026;4543.363929049936;1889.5653999580175;1911.5412301047927;1941.8155275248828;1959.0890236040025;1972.7435433393566;868.8870446841996;880.7489865388334;892.1390857822232;986.413084214891;1014.3913651808856;15345.46290879814;15888.443904463289;16277.430289939795;16323.428679996381;16663;903.584351198456;937.2221056523069;939.8825146856643;940.5438362394233;953.4517652349926;8984.304708587397;9304.534773261445;9314;9359.532023398802;9506.287028472754;385870;386149;386685;387905;398918;64628.35371646317;64750.352496474436;64778.35221647723;65085.67457162684;65546.34453655499;931.2177770672532;932.9020452852353;947.9810403791886;952.6189524190379;952.7475219066953;13713.45146194181;14517;14526.457869872518;14876.181810000553;14902.77645835335;25341.74658253394;28629.28426789347;30158;30213.244668883453;31419.371612568077;37424.631783139645;37971.62028379681;38553.2289354217;39355;39530.60469395269;7203.495755297079;7266.564006159648;7339.559626422431;7528.510646808159;7577.0907491101425;10032.899671003197;10945.671629851116;11061.944690276498;11302.773944521228;11433.771324573629;10076.345037572535;10124.89875101269;10129.848052279369;10228.948855255676;10465.215108867018;10201.336913100624;10205.744856378353;10365.429901355497;10497.79004419892;10563.735906602396;10257.74355641115;10413.84379234297;10452.895471045496;10540.209484288862;10572.84140737905;7030.9296907030275;7435.591042492715;7700.499467534592;7718.498297610638;7913.208679132271;8848.46909185451;9547.952260238655;9598.232141428529;9669.468179250209;9716.75708107303 03:11:07 INFO - PROCESS | 25242 | |3;mootools.html;1436.3177490691924;1456.519348614957;1562.7343351630223;1730.420309196419;1730.8874923129988;6731.158605174353;7049.471289653271;7296.744613938513;7305.45209109317;7454.180040195574;7469.439792015593;7513.286237807413;7526.548407095578;7575.621218939044;7597.92402075979;2230.275160572812;2244.0911430870524;2245.303955773707;2246.8539544929527;2252.4368907773055;2155.1164022750677;2189.7591264960843;2191.583599116163;2198.9780102199015;2211.889405529717;2227.8551894126913;2229.063793206857;2258.954820903581;2268.852524585905;2277.9202727904444;2146.1415433826437;2152.3220185641553;2152.9031193596247;2175.9564808703894;2176.706144670473;2195.7365116186;2206.6359050756605;2214.900329485177;2218.6006518826603;2220.622494175978;7598.886016709754;7696.807579810494;7697.653605587706;7698.4226183035935;7706.229377062305;4689.39037925071;4807.062622788558;4831.782569784333;4847.272909063633;4873.220284754458;2850;3073.738732207765;3073.938521229563;3143.905682829519;3150.637676667167;905.9184673379361;927.4157280913049;945.1380779863657;954.5513608603945;981.2346369831542;10214.28500005;10244;10248.846267305997;10255.794884102275;10260.486975651187;4338.522762496123;4362.192994296065;4405.471343438808;4468.4414448193975;4468.955310446919;8841.823163536821;8855.203031727047;8858.911410885808;8860.069692682304;8898.955505222433;4799.256115302133;4805.3512775775525;4813.663043586916;4817.325574419584;4847.854564363075;3695.8336874840697;4243.151369726005;4249.1501699659575;4298.849540266076;4390.670699697535;3634.327649384872;3691.557013158438;3728.1984373359314;3783.3000894834545;3860.1121741999495;1220.9389530523615;1251.6245126462206;1260.0549587809144;1270.4600544768437;1270.790319597256;789.7117552093559;896.7668406214301;911.6672414568635;918.8697901581093;933.0902370189146;5354.196870469461;5370.785168593213;5490.6431081979545;5557.333120025542;5645.858853528694;429.65627498001476;436.70522397382274;442.6547293111378;442.82729735403217;448.3275087368947;3703.129764505339;3718.8698395556025;3740.121071548184;3745.7752534847996;3788.5643151037434;8644.22202001823;8957.507337096393;8979.640814367483;9008.909910900938;9009.684661036832;8731.25784308341;8909.643614255487;8922.86615700765;8924.241439477717;8960.327975401871;6897.793066208022;6958.512904096766;6965.477589180831;7071.974563688339;7114.679839407136;5209.505097015777;5212.061828870839;5232.424433312256;5320.627556071038;5329.813456529003;8205.83588328242;8272.214139656722;8397.916020839713;8426.452280601741;8431.030431500456;8250.54621995796;8277.668893244203;8306.127856574973;8622.78443038929;8696.304295656459;6062.878742425215;6250.124982502362;6467.773627923;6712.798616041527;6858.142732158481;6979.720811167496;7007.649617519206;7028.367446929801;7052.929470705228;7056.15326160864;6083.847903802263;6166.907496387468;6284.465820405134;6377.426031656987;6441.613503189824;6382.074599183;6517.674116294261;6549.901751473636;6556.868862622816;6576.934230657632;6084.7566097357385;6169.259688837368;6194.876102478015;6206.596571222856;6215.533834962305;4406.955930440655;4576.908461830678;4586.151561961048;4605.40129783126;4607.493175750732;4549.431321084864;4609.769511524343;4630.189716799614;4670.626349892068;4687.156311863897 03:11:07 INFO - PROCESS | 25242 | |4;prototype.html;287.5672113469229;294.47730278755205;294.56845721018703;301.44684503935275;308.79465155671477;4843.200871856144;4868.196747536656;4871.366722326097;4890.266460030997;4914.680545764523;4823.469418363986;4829.323894654751;4829.985703002365;4853.384228749577;4854.611631069515;3639.5996440391536;3717.107894105409;3829.636184562476;3845.173542567286;3847.3267178243836;3813.2564149990762;3826.8660596879113;3840.5967373425806;3861.80690965452;3869.2648396804516;3782.5460944686674;3820.465134881119;3830.2148059647707;3830.8467661293653;3839.0978120141745;3561.8753343632848;3769.981150094259;3786.583475817658;3792.8862134135884;3809.29528037314;3289.227031647561;3317.8672853085845;3327.3678001179696;3327.683870032343;3345.531625572422;4619.538046195387;4634.976825115853;4638.234691275969;4646.281925073802;4652.906941861143;4309.288967320388;4324.437823083011;4332.090261045184;4333.241682705514;4333.848315308949;4984.8753781155765;5041.445441001487;5058.494150584949;5080.77136528857;5102.36220472441;3586.1751797086554;3598.3702852000797;3599.2981368633127;3604.3151801157696;3608.548931383577;5253.842384728464;5317.973410132963;5332.626716129873;5360.437154098841;5362.839114826562;3576.499290099388;3698.4822124902535;3698.7595806272507;3784.7539909905768;3797.6012518685693;3823.2735780201674;3824.9043773905873;3831.310364134427;3892.4355968384994;3895.6493915547735;4389.495208051115;4408.272635015187;4421;4427.180971520214;4428.114377124523;4818.253170758538;5094.898102037939;5161.509656582619;5164.244156986642;5167.896642067138;1383.688670049251;1391.422559637739;1394.6583087143715;1397.6785339372002;1397.6994946086436;897.7441429192779;955.5508910811907;958.1041725986225;986.0878687214298;997.6109317366233;4468.955310446919;4602.815887364468;4633.443986721615;4637.837675681335;4646.907061858744;5260.658057226268;5291.841244762663;5292.285541451932;5292.380271765501;5311.123664595299;4563.566461186182;4647.95352046482;4652.930206046912;4657.67396282257;4659.9767001165455;2987.2979849735293;3011.0515187716237;3014.4423281692957;3018.6679465258803;3030.636323641133;5452.972735136378;5456.945430545723;5478.424765399655;5502.504774570308;5506;5555.2778138841695;5764.971175144181;5776.96014717355;5781.814727980754;5786.768529258867;5458.426865179178;5467.234587157801;5470;5472.671639701631;5486.753096110685;5560.27716396882;5563.221149039218;5580.497755202051;5595.832125036255;5672.744726487235;5377.1448850146635;5510.3938566758425;5559.305086864142;5570.136628822539;5578.219049333178;5335.519803217729;5384.811531596375;5431.701256430776;5463.699496527729;5484.1773733938635;3990.4413382125945;3993.1813978133832;4000.319945609195;4006.419069234886;4010.8970033241094;5015.470281564158;5215.947840521546;5317.867053323698;5323.866903327448;5328.280682107866;5069.340985671839;5102.79588816458;5104.132297509506;5142.6914385137015;5146.922796157985;4832.767644250694;5096.1336572781975;5130.435652078194;5135.306733590917;5155.742212889416;5051.318072060225;5057.280524621647;5091.134507133722;5096.974515127401;5107.923381149211;4878.317035614946;4959.925601116059;5171.534561889448;5192.584593232456;5207.1147904857025;4935.703857768545;5037.974810125926;5050.141475949171;5057.216131499624;5061.443241243386 03:11:07 INFO - PROCESS | 25242 | |5;yui.html;672.815953081507;708.4686485136144;711.8505113926075;760.4638729695565;798.1140933563745;11960.461779219935;12273.938630306859;12320.93839530801;12349.07381946353;12357.876421235775;11253.09975201984;11289.548418063268;11297.774044519105;11312.830307545373;11315.094792416607;624.6720471752321;775.8991331126946;802.1897883138014;807.0315621254489;807.3823525003377;798.9280964713174;806.1535387842771;807.6728924785472;809.720646376999;810.092696180279;854.9529775862325;856.9657213711444;858.5063588436643;860.979739009276;863.7797361672796;857.588357588358;857.8541647919868;858.2747578296361;860.5869182792233;860.7891066688638;624.7657128576784;625.3152797686525;625.5808608232495;625.7059182184366;629.965351905645;11754.235974661706;11846.526138954432;11849.881501184964;11917.046636269077;11928.70178245542;12636.11547191697;12827.935860320733;12875.227486350755;12920.547780827626;13076.607701768962;9725.124738773544;9744.31789774716;9928.95035524825;10089.394636321771;10436.739081522946;3305.1571849178545;3415.624281329052;3426.3661222673636;3523.964760352415;3546.2552863898613;44828;45336.093278134584;45391.31913021307;45583.54416455826;45737.77131114323;10322.554961733214;10332.53503592325;10386.584536618602;10518.789624207473;10583.153347732163;16040.919795401182;18136.45590632283;18151.546211344557;18330.266789328278;18375.632487350445;6186.381361863868;6303.275123360872;6340;6390.488760899117;6527.967360163168;3895.8831235062994;3915.9056278694543;3970.3845903884944;3974.16542526067;4030.496187976503;2820.252633052243;2916.052283008031;2916.693747156518;2921.328094538268;2925.18094933419;526.8867193553405;534.060054304427;540.1384791257938;545.7544105152697;547.4170008940465;509.80882169186555;571.4770984549091;616.3066550131102;621.8569728962364;628.3527966194827;8185.918140818635;8328.375371847136;8588.52763098023;8638.481691098554;8845.601947912359;615.301632646949;620.3765215958024;626.9028300613412;633.5343522510951;642.2293248102296;3728.3475391806323;3844.3464611016193;4005.8798236052967;4100.384942258685;4162.313218318944;49312;49955.75022124866;50007.499925001015;50464;50851.237231441555;45116.54883451123;45362;46067.539324606994;46491.76754116208;46732.5326746735;42368;42415;42623.93440164083;42689.14621707548;43315.56684433115;7433.479656423999;7823.452358334862;7838.098618658927;7883.724069657764;7988.320992715452;28270;28335.2916177089;28860.278493037003;29723.85138074296;30186.547201791553;36729.26541469209;37526.2494750098;37638.435423469215;37791.62208377881;37809.62190378061;9614.375065620712;9745.80508389814;9995.400275983464;10071.949640251752;10099.646512372032;10908.400037997986;10928.453577321261;11842.11184161174;11922.701932451759;12047.578334758242;10771.51528181218;11046.226764126433;11221.60724374643;11436.885631143914;11560.826587601361;10496.842547361948;10644.308119972176;10800.513976871216;11909.702257443632;12079.637610871689;10669;10938.343699378063;11041.33751974884;11138.164637652046;11922.344271065174;9663.758406039906;9930.304878658424;9963.053509916546;9977.800443991226;10216.489175541044;9332.626694932127;9430.57562409707;9632.988536203879;9663.323567350219;9913.157381622643 03:11:07 INFO - PROCESS | 25242 | __end_tp_report 03:11:07 INFO - PROCESS | 25242 | __start_cc_report 03:11:07 INFO - PROCESS | 25242 | _x_x_mozilla_cycle_collect,368 03:11:07 INFO - PROCESS | 25242 | __end_cc_report 03:11:07 INFO - PROCESS | 25242 | __startTimestamp1461838267089__endTimestamp 03:11:07 INFO - PROCESS | 25242 | 03:11:07 INFO - PROCESS | 25242 | ------- Summary: start ------- 03:11:07 INFO - PROCESS | 25242 | Number of tests: 6 03:11:07 INFO - PROCESS | 25242 | 03:11:07 INFO - PROCESS | 25242 | [#0] dojo.html Cycles:165 Average:4674.74 Median:4875.05 stddev:598.91 (12.3%) stddev-sans-first:579.34 03:11:07 INFO - PROCESS | 25242 | Values: 2651.8 2719.2 2726.8 2761.4 2770.8 4661.6 4750.2 4763.3 4769.0 4804.3 4653.6 4693.2 4715.5 4775.6 4782.5 4333.2 4418.1 4422.3 4426.0 4441.8 650.6 4170.4 4307.5 4337.7 4344.5 4314.0 4338.7 4356.6 4364.5 4419.9 4342.8 4353.1 4360.3 4372.8 4393.2 4304.5 4352.5 4368.3 4390.1 4408.4 4619.3 4628.3 4629.0 4642.3 4668.4 4920.0 5000.2 5022.3 5033.7 5046.1 5128.8 5143.6 5152.4 5153.3 5191.0 4746.2 4788.7 4791.7 4792.6 4825.3 4957.8 5215.2 5266.4 5294.3 5348.5 5022.8 5041.2 5049.9 5054.8 5077.0 5133.2 5137.5 5145.1 5145.9 5186.8 4875.0 5001.9 5084.7 5098.9 5129.6 5035.6 5041.1 5047.1 5052.3 5124.2 3990.5 3993.9 3995.9 4006.3 4031.4 3447.1 3460.7 3520.5 3591.5 3650.7 4501.8 4515.6 4529.4 4549.0 4561.6 5110.8 5126.9 5131.0 5131.9 5138.2 4422.6 4474.7 4512.6 4529.8 4531.9 4668.3 4672.3 4676.6 4677.9 4732.2 4733.9 4928.5 4948.6 4956.1 5013.7 5112.8 5119.1 5173.8 5178.7 5182.3 4908.7 4934.1 4943.7 4947.4 4991.6 4910.0 5011.7 5021.7 5022.0 5028.6 5040.0 5061.6 5062.8 5064.9 5105.6 4886.8 4904.3 4905.1 4927.8 4950.9 4768.1 4911.2 4911.9 4954.1 4990.2 4844.7 4847.3 4869.5 4889.1 4906.5 4898.0 4900.1 4904.1 4933.1 4952.9 4723.2 4839.3 4855.5 4893.7 4897.9 03:11:07 INFO - PROCESS | 25242 | 03:11:07 INFO - PROCESS | 25242 | [#1] ext.html Cycles:180 Average:37997.89 Median:18417.73 stddev:60191.37 (326.8%) stddev-sans-first:60294.62 03:11:07 INFO - PROCESS | 25242 | Values: 567.9 615.1 627.6 632.3 641.9 33003.2 33952.8 34087.3 34114.8 34194.0 35006.3 35453.8 35621.6 35627.6 35825.5 7537.1 7641.9 7642.7 7715.3 7722.0 7642.7 7814.4 7829.2 7837.9 7839.5 7789.3 7833.9 7838.8 7851.3 7865.3 7779.8 7787.0 7807.8 7819.8 7834.8 7686.3 7739.0 7767.5 7789.3 7796.5 25470.0 34684.5 35192.0 35210.0 35303.0 2860.4 2882.2 3009.1 3324.6 3623.2 24139.9 24907.1 24907.9 25095.1 25260.5 3176.5 3245.5 3255.3 3263.1 3304.6 167059.0 167652.0 168358.0 168645.0 169953.0 31288.2 31617.4 31678.8 31726.0 31790.7 33032.7 49956.5 51069.2 51129.7 51346.7 14638.1 14829.9 14850.8 14883.2 14935.9 11398.9 11422.7 11429.4 11441.7 11453.9 17559.9 17560.8 17612.8 17645.6 17668.0 6737.3 6856.0 7045.0 7078.9 7129.3 775.9 903.2 995.2 1003.5 1035.8 26553.6 26761.2 27242.3 27261.6 27844.9 918.6 964.6 990.2 1013.9 1031.1 13183.0 13481.0 13719.7 13910.2 14044.5 261513.0 264897.0 265753.0 266416.0 268196.0 46321.8 47145.3 47175.5 47177.3 47198.3 1214.9 1270.3 1297.5 1306.0 1313.8 25085.6 26247.9 26326.3 26476.0 27054.5 40156.6 40915.2 40972.8 40993.8 40995.4 246656.0 247335.0 248174.0 249237.0 249397.0 24339.5 33049.0 33620.3 33686.8 34110.5 36220.5 39605.6 40069.0 40850.4 40926.8 33548.7 34304.0 34342.0 34860.3 35161.8 33510.8 33890.8 34008.7 34396.3 34745.8 28092.4 30979.5 31653.5 33910.8 34726.8 27948.0 28898.0 28945.6 28999.7 29082.9 23547.0 24534.5 24646.6 24832.8 24945.6 03:11:07 INFO - PROCESS | 25242 | 03:11:07 INFO - PROCESS | 25242 | [#2] jquery.html Cycles:180 Average:22741.53 Median:4417.59 stddev:63680.93 (1441.5%) stddev-sans-first:63837.45 03:11:07 INFO - PROCESS | 25242 | Values: 386.8 391.3 394.5 395.3 397.1 12258.4 14994.9 15125.1 15746.6 15749.5 15038.8 15264.2 15464.9 15806.2 15854.5 4962.8 5066.1 5082.3 5096.1 5124.1 4990.0 5146.1 5188.9 5203.9 5217.3 5153.3 5157.8 5158.6 5162.7 5163.2 5008.3 5115.4 5126.8 5171.2 5175.9 4619.9 4633.5 4633.6 4647.9 4648.1 18620.4 18964.2 19672.9 19775.4 19784.5 1698.5 1859.2 1959.5 2100.9 2340.6 8815.6 8943.8 9006.1 9135.1 9349.0 1813.7 1833.5 1861.3 1863.8 1867.1 53352.5 56448.7 56740.7 56796.7 57343.7 9794.1 9976.4 10002.1 10192.9 10314.6 11926.6 12794.0 14092.4 14176.6 14189.7 6915.0 7109.7 7116.8 7186.1 7245.6 6476.9 6496.5 6530.6 6856.7 6911.6 4315.5 4405.0 4430.2 4512.6 4543.4 1889.6 1911.5 1941.8 1959.1 1972.7 868.9 880.7 892.1 986.4 1014.4 15345.5 15888.4 16277.4 16323.4 16663.0 903.6 937.2 939.9 940.5 953.5 8984.3 9304.5 9314.0 9359.5 9506.3 385870.0 386149.0 386685.0 387905.0 398918.0 64628.4 64750.4 64778.4 65085.7 65546.3 931.2 932.9 948.0 952.6 952.7 13713.5 14517.0 14526.5 14876.2 14902.8 25341.7 28629.3 30158.0 30213.2 31419.4 37424.6 37971.6 38553.2 39355.0 39530.6 7203.5 7266.6 7339.6 7528.5 7577.1 10032.9 10945.7 11061.9 11302.8 11433.8 10076.3 10124.9 10129.8 10228.9 10465.2 10201.3 10205.7 10365.4 10497.8 10563.7 10257.7 10413.8 10452.9 10540.2 10572.8 7030.9 7435.6 7700.5 7718.5 7913.2 8848.5 9548.0 9598.2 9669.5 9716.8 03:11:07 INFO - PROCESS | 25242 | 03:11:07 INFO - PROCESS | 25242 | [#3] mootools.html Cycles:180 Average:5010.68 Median:5210.78 stddev:2682.26 (51.5%) stddev-sans-first:2676.33 03:11:07 INFO - PROCESS | 25242 | Values: 1436.3 1456.5 1562.7 1730.4 1730.9 6731.2 7049.5 7296.7 7305.5 7454.2 7469.4 7513.3 7526.5 7575.6 7597.9 2230.3 2244.1 2245.3 2246.9 2252.4 2155.1 2189.8 2191.6 2199.0 2211.9 2227.9 2229.1 2259.0 2268.9 2277.9 2146.1 2152.3 2152.9 2176.0 2176.7 2195.7 2206.6 2214.9 2218.6 2220.6 7598.9 7696.8 7697.7 7698.4 7706.2 4689.4 4807.1 4831.8 4847.3 4873.2 2850.0 3073.7 3073.9 3143.9 3150.6 905.9 927.4 945.1 954.6 981.2 10214.3 10244.0 10248.8 10255.8 10260.5 4338.5 4362.2 4405.5 4468.4 4469.0 8841.8 8855.2 8858.9 8860.1 8899.0 4799.3 4805.4 4813.7 4817.3 4847.9 3695.8 4243.2 4249.2 4298.8 4390.7 3634.3 3691.6 3728.2 3783.3 3860.1 1220.9 1251.6 1260.1 1270.5 1270.8 789.7 896.8 911.7 918.9 933.1 5354.2 5370.8 5490.6 5557.3 5645.9 429.7 436.7 442.7 442.8 448.3 3703.1 3718.9 3740.1 3745.8 3788.6 8644.2 8957.5 8979.6 9008.9 9009.7 8731.3 8909.6 8922.9 8924.2 8960.3 6897.8 6958.5 6965.5 7072.0 7114.7 5209.5 5212.1 5232.4 5320.6 5329.8 8205.8 8272.2 8397.9 8426.5 8431.0 8250.5 8277.7 8306.1 8622.8 8696.3 6062.9 6250.1 6467.8 6712.8 6858.1 6979.7 7007.6 7028.4 7052.9 7056.2 6083.8 6166.9 6284.5 6377.4 6441.6 6382.1 6517.7 6549.9 6556.9 6576.9 6084.8 6169.3 6194.9 6206.6 6215.5 4407.0 4576.9 4586.2 4605.4 4607.5 4549.4 4609.8 4630.2 4670.6 4687.2 03:11:07 INFO - PROCESS | 25242 | 03:11:07 INFO - PROCESS | 25242 | [#4] prototype.html Cycles:180 Average:4340.07 Median:4848.29 stddev:1270.09 (26.2%) stddev-sans-first:1236.70 03:11:07 INFO - PROCESS | 25242 | Values: 287.6 294.5 294.6 301.4 308.8 4843.2 4868.2 4871.4 4890.3 4914.7 4823.5 4829.3 4830.0 4853.4 4854.6 3639.6 3717.1 3829.6 3845.2 3847.3 3813.3 3826.9 3840.6 3861.8 3869.3 3782.5 3820.5 3830.2 3830.8 3839.1 3561.9 3770.0 3786.6 3792.9 3809.3 3289.2 3317.9 3327.4 3327.7 3345.5 4619.5 4635.0 4638.2 4646.3 4652.9 4309.3 4324.4 4332.1 4333.2 4333.8 4984.9 5041.4 5058.5 5080.8 5102.4 3586.2 3598.4 3599.3 3604.3 3608.5 5253.8 5318.0 5332.6 5360.4 5362.8 3576.5 3698.5 3698.8 3784.8 3797.6 3823.3 3824.9 3831.3 3892.4 3895.6 4389.5 4408.3 4421.0 4427.2 4428.1 4818.3 5094.9 5161.5 5164.2 5167.9 1383.7 1391.4 1394.7 1397.7 1397.7 897.7 955.6 958.1 986.1 997.6 4469.0 4602.8 4633.4 4637.8 4646.9 5260.7 5291.8 5292.3 5292.4 5311.1 4563.6 4648.0 4652.9 4657.7 4660.0 2987.3 3011.1 3014.4 3018.7 3030.6 5453.0 5456.9 5478.4 5502.5 5506.0 5555.3 5765.0 5777.0 5781.8 5786.8 5458.4 5467.2 5470.0 5472.7 5486.8 5560.3 5563.2 5580.5 5595.8 5672.7 5377.1 5510.4 5559.3 5570.1 5578.2 5335.5 5384.8 5431.7 5463.7 5484.2 3990.4 3993.2 4000.3 4006.4 4010.9 5015.5 5215.9 5317.9 5323.9 5328.3 5069.3 5102.8 5104.1 5142.7 5146.9 4832.8 5096.1 5130.4 5135.3 5155.7 5051.3 5057.3 5091.1 5097.0 5107.9 4878.3 4959.9 5171.5 5192.6 5207.1 4935.7 5038.0 5050.1 5057.2 5061.4 03:11:07 INFO - PROCESS | 25242 | 03:11:07 INFO - PROCESS | 25242 | [#5] yui.html Cycles:180 Average:12640.08 Median:44972.27 stddev:14126.49 (31.4%) stddev-sans-first:14137.53 03:11:07 INFO - PROCESS | 25242 | Values: 672.8 708.5 711.9 760.5 798.1 11960.5 12273.9 12320.9 12349.1 12357.9 11253.1 11289.5 11297.8 11312.8 11315.1 624.7 775.9 802.2 807.0 807.4 798.9 806.2 807.7 809.7 810.1 855.0 857.0 858.5 861.0 863.8 857.6 857.9 858.3 860.6 860.8 624.8 625.3 625.6 625.7 630.0 11754.2 11846.5 11849.9 11917.0 11928.7 12636.1 12827.9 12875.2 12920.5 13076.6 9725.1 9744.3 9929.0 10089.4 10436.7 3305.2 3415.6 3426.4 3524.0 3546.3 44828.0 45336.1 45391.3 45583.5 45737.8 10322.6 10332.5 10386.6 10518.8 10583.2 16040.9 18136.5 18151.5 18330.3 18375.6 6186.4 6303.3 6340.0 6390.5 6528.0 3895.9 3915.9 3970.4 3974.2 4030.5 2820.3 2916.1 2916.7 2921.3 2925.2 526.9 534.1 540.1 545.8 547.4 509.8 571.5 616.3 621.9 628.4 8185.9 8328.4 8588.5 8638.5 8845.6 615.3 620.4 626.9 633.5 642.2 3728.3 3844.3 4005.9 4100.4 4162.3 49312.0 49955.8 50007.5 50464.0 50851.2 45116.5 45362.0 46067.5 46491.8 46732.5 42368.0 42415.0 42623.9 42689.1 43315.6 7433.5 7823.5 7838.1 7883.7 7988.3 28270.0 28335.3 28860.3 29723.9 30186.5 36729.3 37526.2 37638.4 37791.6 37809.6 9614.4 9745.8 9995.4 10071.9 10099.6 10908.4 10928.5 11842.1 11922.7 12047.6 10771.5 11046.2 11221.6 11436.9 11560.8 10496.8 10644.3 10800.5 11909.7 12079.6 10669.0 10938.3 11041.3 11138.2 11922.3 9663.8 9930.3 9963.1 9977.8 10216.5 9332.6 9430.6 9633.0 9663.3 9913.2 03:11:07 INFO - PROCESS | 25242 | -------- Summary: end -------- 03:11:07 INFO - PROCESS | 25242 | 03:11:07 INFO - TEST-INFO | 25242: exit 0 03:11:07 INFO - TEST-OK | dromaeo_css | took 1115133ms 03:11:07 INFO - TEST-START | kraken 03:11:07 INFO - operating with platform_type : linux_ 03:11:07 INFO - Initialising browser for kraken test... 03:11:07 INFO - TEST-INFO | started process 25473 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3PARvF/profile http://localhost:39831/getInfo.html) 03:11:11 INFO - PROCESS | 25473 | 03:11:11 INFO - PROCESS | 25473 | (process:25541): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:11:12 INFO - PROCESS | 25473 | __metrics Screen width/height:1600/1200 03:11:12 INFO - PROCESS | 25473 | colorDepth:24 03:11:12 INFO - PROCESS | 25473 | Browser inner width/height: 1024/697 03:11:12 INFO - PROCESS | 25473 | __metrics 03:11:13 ERROR - PROCESS | 25473 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 03:11:14 INFO - TEST-INFO | 25473: exit 0 03:11:14 INFO - Browser initialized. 03:11:14 INFO - Running cycle 1/1 for kraken test... 03:11:14 INFO - TEST-INFO | started process 25592 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3PARvF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:11:16 INFO - PROCESS | 25592 | 03:11:16 INFO - PROCESS | 25592 | (process:25654): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:11:26 INFO - PROCESS | 25592 | RSS: Main: 166141952 03:11:26 INFO - PROCESS | 25592 | 03:11:28 INFO - PROCESS | 25592 | Cycle 1(1): loaded http://localhost:39831/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39831/tests/kraken/driver.html?testName=audio-beat-detection) 03:11:29 INFO - PROCESS | 25592 | RSS: Main: 170631168 03:11:29 INFO - PROCESS | 25592 | 03:11:32 INFO - PROCESS | 25592 | Cycle 1(1): loaded http://localhost:39831/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39831/tests/kraken/driver.html?testName=audio-dft) 03:11:33 INFO - PROCESS | 25592 | RSS: Main: 173977600 03:11:33 INFO - PROCESS | 25592 | 03:11:36 INFO - PROCESS | 25592 | Cycle 1(1): loaded http://localhost:39831/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39831/tests/kraken/driver.html?testName=audio-fft) 03:11:36 INFO - PROCESS | 25592 | RSS: Main: 164265984 03:11:36 INFO - PROCESS | 25592 | 03:11:38 INFO - PROCESS | 25592 | Cycle 1(1): loaded http://localhost:39831/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39831/tests/kraken/driver.html?testName=audio-oscillator) 03:11:39 INFO - PROCESS | 25592 | RSS: Main: 164700160 03:11:39 INFO - PROCESS | 25592 | 03:11:41 INFO - PROCESS | 25592 | Cycle 1(1): loaded http://localhost:39831/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39831/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:11:42 INFO - PROCESS | 25592 | RSS: Main: 166174720 03:11:42 INFO - PROCESS | 25592 | 03:11:45 INFO - PROCESS | 25592 | Cycle 1(1): loaded http://localhost:39831/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39831/tests/kraken/driver.html?testName=imaging-darkroom) 03:11:46 INFO - PROCESS | 25592 | RSS: Main: 166449152 03:11:46 INFO - PROCESS | 25592 | 03:11:49 INFO - PROCESS | 25592 | Cycle 1(1): loaded http://localhost:39831/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39831/tests/kraken/driver.html?testName=imaging-desaturate) 03:11:50 INFO - PROCESS | 25592 | RSS: Main: 166424576 03:11:50 INFO - PROCESS | 25592 | 03:11:53 INFO - PROCESS | 25592 | Cycle 1(1): loaded http://localhost:39831/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39831/tests/kraken/driver.html?testName=json-parse-financial) 03:11:54 INFO - PROCESS | 25592 | RSS: Main: 166383616 03:11:54 INFO - PROCESS | 25592 | 03:11:55 INFO - PROCESS | 25592 | Cycle 1(1): loaded http://localhost:39831/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39831/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:11:56 INFO - PROCESS | 25592 | RSS: Main: 166903808 03:11:56 INFO - PROCESS | 25592 | 03:11:58 INFO - PROCESS | 25592 | Cycle 1(1): loaded http://localhost:39831/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39831/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:11:58 INFO - PROCESS | 25592 | RSS: Main: 166862848 03:11:58 INFO - PROCESS | 25592 | 03:12:01 INFO - PROCESS | 25592 | Cycle 1(1): loaded http://localhost:39831/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39831/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:12:01 INFO - PROCESS | 25592 | RSS: Main: 167624704 03:12:01 INFO - PROCESS | 25592 | 03:12:04 INFO - PROCESS | 25592 | Cycle 1(1): loaded http://localhost:39831/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39831/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:12:05 INFO - PROCESS | 25592 | RSS: Main: 167243776 03:12:05 INFO - PROCESS | 25592 | 03:12:08 INFO - PROCESS | 25592 | Cycle 1(1): loaded http://localhost:39831/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39831/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:12:09 INFO - PROCESS | 25592 | RSS: Main: 165040128 03:12:09 INFO - PROCESS | 25592 | 03:12:11 INFO - PROCESS | 25592 | Cycle 1(1): loaded http://localhost:39831/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39831/tests/kraken/driver.html?testName=ai-astar) 03:12:11 INFO - PROCESS | 25592 | RSS: Main: 166670336 03:12:11 INFO - PROCESS | 25592 | 03:12:11 INFO - PROCESS | 25592 | __start_tp_report 03:12:11 INFO - PROCESS | 25592 | _x_x_mozilla_page_load 03:12:11 INFO - PROCESS | 25592 | _x_x_mozilla_page_load_details 03:12:11 INFO - PROCESS | 25592 | |i|pagename|runs| 03:12:11 INFO - PROCESS | 25592 | |0;ai-astar;113;107;112;115;114;126;113;113;114;111 03:12:11 INFO - PROCESS | 25592 | |1;audio-beat-detection;165;132;162;193;141;162;164;134;184;137 03:12:11 INFO - PROCESS | 25592 | |2;audio-dft;163;163;165;167;169;161;163;164;171;162 03:12:11 INFO - PROCESS | 25592 | |3;audio-fft;77;78;76;158;76;74;73;73;162;77 03:12:11 INFO - PROCESS | 25592 | |4;audio-oscillator;96;93;154;95;94;95;139;95;94;145 03:12:11 INFO - PROCESS | 25592 | |5;imaging-gaussian-blur;117;117;117;118;117;117;118;117;118;118 03:12:11 INFO - PROCESS | 25592 | |6;imaging-darkroom;147;147;147;149;147;148;147;148;147;148 03:12:11 INFO - PROCESS | 25592 | |7;imaging-desaturate;95;95;96;95;95;97;95;96;95;96 03:12:11 INFO - PROCESS | 25592 | |8;json-parse-financial;66;66;67;70;66;65;70;81;64;62 03:12:11 INFO - PROCESS | 25592 | |9;json-stringify-tinderbox;64;65;65;65;64;65;65;65;64;66 03:12:11 INFO - PROCESS | 25592 | |10;stanford-crypto-aes;79;78;80;80;81;89;82;80;80;90 03:12:11 INFO - PROCESS | 25592 | |11;stanford-crypto-ccm;146;136;137;139;135;135;142;141;175;139 03:12:11 INFO - PROCESS | 25592 | |12;stanford-crypto-pbkdf2;223;221;222;218;216;212;222;230;219;215 03:12:11 INFO - PROCESS | 25592 | |13;stanford-crypto-sha256-iterative;79;76;74;74;77;76;75;76;75;80 03:12:11 INFO - PROCESS | 25592 | __end_tp_report 03:12:11 INFO - PROCESS | 25592 | __start_cc_report 03:12:11 INFO - PROCESS | 25592 | _x_x_mozilla_cycle_collect,920 03:12:11 INFO - PROCESS | 25592 | __end_cc_report 03:12:11 INFO - PROCESS | 25592 | __startTimestamp1461838331504__endTimestamp 03:12:11 INFO - PROCESS | 25592 | 03:12:11 INFO - PROCESS | 25592 | ------- Summary: start ------- 03:12:11 INFO - PROCESS | 25592 | Number of tests: 14 03:12:11 INFO - PROCESS | 25592 | 03:12:11 INFO - PROCESS | 25592 | [#0] ai-astar Cycles:10 Average:113.80 Median:113.50 stddev:4.83 (4.3%) stddev-sans-first:5.11 03:12:11 INFO - PROCESS | 25592 | Values: 113.0 107.0 112.0 115.0 114.0 126.0 113.0 113.0 114.0 111.0 03:12:11 INFO - PROCESS | 25592 | 03:12:11 INFO - PROCESS | 25592 | [#1] audio-beat-detection Cycles:10 Average:157.40 Median:163.00 stddev:21.07 (12.9%) stddev-sans-first:22.17 03:12:11 INFO - PROCESS | 25592 | Values: 165.0 132.0 162.0 193.0 141.0 162.0 164.0 134.0 184.0 137.0 03:12:11 INFO - PROCESS | 25592 | 03:12:11 INFO - PROCESS | 25592 | [#2] audio-dft Cycles:10 Average:164.80 Median:164.50 stddev:3.22 (2.0%) stddev-sans-first:3.35 03:12:11 INFO - PROCESS | 25592 | Values: 163.0 163.0 165.0 167.0 169.0 161.0 163.0 164.0 171.0 162.0 03:12:11 INFO - PROCESS | 25592 | 03:12:11 INFO - PROCESS | 25592 | [#3] audio-fft Cycles:10 Average:92.40 Median:76.00 stddev:35.68 (46.9%) stddev-sans-first:37.41 03:12:11 INFO - PROCESS | 25592 | Values: 77.0 78.0 76.0 158.0 76.0 74.0 73.0 73.0 162.0 77.0 03:12:11 INFO - PROCESS | 25592 | 03:12:11 INFO - PROCESS | 25592 | [#4] audio-oscillator Cycles:10 Average:110.00 Median:94.50 stddev:25.11 (26.6%) stddev-sans-first:26.12 03:12:11 INFO - PROCESS | 25592 | Values: 96.0 93.0 154.0 95.0 94.0 95.0 139.0 95.0 94.0 145.0 03:12:11 INFO - PROCESS | 25592 | 03:12:11 INFO - PROCESS | 25592 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 03:12:11 INFO - PROCESS | 25592 | Values: 117.0 117.0 117.0 118.0 117.0 117.0 118.0 117.0 118.0 118.0 03:12:11 INFO - PROCESS | 25592 | 03:12:11 INFO - PROCESS | 25592 | [#6] imaging-darkroom Cycles:10 Average:147.50 Median:147.50 stddev:0.71 (0.5%) stddev-sans-first:0.73 03:12:11 INFO - PROCESS | 25592 | Values: 147.0 147.0 147.0 149.0 147.0 148.0 147.0 148.0 147.0 148.0 03:12:11 INFO - PROCESS | 25592 | 03:12:11 INFO - PROCESS | 25592 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:95.50 stddev:0.71 (0.7%) stddev-sans-first:0.73 03:12:11 INFO - PROCESS | 25592 | Values: 95.0 95.0 96.0 95.0 95.0 97.0 95.0 96.0 95.0 96.0 03:12:11 INFO - PROCESS | 25592 | 03:12:11 INFO - PROCESS | 25592 | [#8] json-parse-financial Cycles:10 Average:67.70 Median:66.50 stddev:5.27 (7.9%) stddev-sans-first:5.56 03:12:11 INFO - PROCESS | 25592 | Values: 66.0 66.0 67.0 70.0 66.0 65.0 70.0 81.0 64.0 62.0 03:12:11 INFO - PROCESS | 25592 | 03:12:11 INFO - PROCESS | 25592 | [#9] json-stringify-tinderbox Cycles:10 Average:64.80 Median:65.00 stddev:0.63 (1.0%) stddev-sans-first:0.60 03:12:11 INFO - PROCESS | 25592 | Values: 64.0 65.0 65.0 65.0 64.0 65.0 65.0 65.0 64.0 66.0 03:12:11 INFO - PROCESS | 25592 | 03:12:11 INFO - PROCESS | 25592 | [#10] stanford-crypto-aes Cycles:10 Average:81.90 Median:80.50 stddev:4.15 (5.2%) stddev-sans-first:4.27 03:12:11 INFO - PROCESS | 25592 | Values: 79.0 78.0 80.0 80.0 81.0 89.0 82.0 80.0 80.0 90.0 03:12:11 INFO - PROCESS | 25592 | 03:12:11 INFO - PROCESS | 25592 | [#11] stanford-crypto-ccm Cycles:10 Average:142.50 Median:140.00 stddev:11.93 (8.5%) stddev-sans-first:12.58 03:12:11 INFO - PROCESS | 25592 | Values: 146.0 136.0 137.0 139.0 135.0 135.0 142.0 141.0 175.0 139.0 03:12:11 INFO - PROCESS | 25592 | 03:12:11 INFO - PROCESS | 25592 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:219.80 Median:221.50 stddev:5.03 (2.3%) stddev-sans-first:5.20 03:12:11 INFO - PROCESS | 25592 | Values: 223.0 221.0 222.0 218.0 216.0 212.0 222.0 230.0 219.0 215.0 03:12:11 INFO - PROCESS | 25592 | 03:12:11 INFO - PROCESS | 25592 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:76.20 Median:76.00 stddev:1.99 (2.6%) stddev-sans-first:1.83 03:12:11 INFO - PROCESS | 25592 | Values: 79.0 76.0 74.0 74.0 77.0 76.0 75.0 76.0 75.0 80.0 03:12:11 INFO - PROCESS | 25592 | -------- Summary: end -------- 03:12:11 INFO - PROCESS | 25592 | 03:12:12 INFO - TEST-INFO | 25592: exit 0 03:12:12 INFO - TEST-OK | kraken | took 64854ms 03:12:12 INFO - SUITE-END | took 1179s 03:12:12 INFO - Completed test suite (00:19:39) 03:12:12 INFO - javascript benchmark 03:12:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2651.8011149163813, 2719.238613188307, 2726.7818574514017, 2761.3648860762023, 2770.8060435769494, 4661.557152070556, 4750.239961606144, 4763.333133361328, 4768.976155119224, 4804.25534042224, 4653.604443622287, 4693.225617773063, 4715.528447155283, 4775.570198682118, 4782.497837727032, 4333.2416827055295, 4418.1384629997165, 4422.270325396305, 4426.004149066466, 4441.844535441261, 650.6072015891666, 4170.35359519275, 4307.461567304087, 4337.696361254713, 4344.500382456026, 4313.956860431418, 4338.674599405057, 4356.607905288539, 4364.476262848479, 4419.867403977886, 4342.804573794187, 4353.1293741251875, 4360.302351623756, 4372.759498227596, 4393.209222339978, 4304.483461984551, 4352.477702675667, 4368.279233926399, 4390.056137930328, 4408.448943882015, 4619.260918253063, 4628.3288923105965, 4629.0279041401345, 4642.303654451825, 4668.393108895856, 4919.950800491985, 5000.224965130411, 5022.347094877642, 5033.723145227011, 5046.09170349337, 5128.794848206067, 5143.588512918957, 5152.381714194284, 5153.2785410042625, 5191.0, 4746.21687421575, 4788.664793464493, 4791.688540244873, 4792.592629626451, 4825.324454576362, 4957.752112394366, 5215.217717342429, 5266.394364648115, 5294.285271488377, 5348.465153484621, 5022.773975171126, 5041.168207245837, 5049.924251136236, 5054.848354549369, 5076.974615126975, 5133.230015497706, 5137.460566640524, 5145.099607568661, 5145.897082058338, 5186.844394668166, 4875.0493653737185, 5001.89996200074, 5084.720340381315, 5098.898022039612, 5129.563987061141, 5035.597152227813, 5041.143005689041, 5047.116754567936, 5052.343195384577, 5124.180131178993, 3990.541087774885, 3993.880183594497, 3995.900102497461, 4006.338954072604, 4031.395290706359, 3447.1382154461385, 3460.671236232554, 3520.507129001942, 3591.497190393347, 3650.7261955353456, 4501.842435514741, 4515.616172625298, 4529.411176547093, 4549.0447006128425, 4561.566651168134, 5110.7955681773055, 5126.948975460096, 5130.97434512825, 5131.948680513222, 5138.177891537411, 4422.557744225552, 4474.664400170001, 4512.616427603625, 4529.773511324421, 4531.886702832389, 4668.276417155346, 4672.275797251432, 4676.579107880307, 4677.925571663455, 4732.219183834698, 4733.905321893474, 4928.457869634337, 4948.628852836052, 4956.132676781621, 5013.724245166478, 5112.821051263188, 5119.078565858182, 5173.81891633791, 5178.663386879841, 5182.32629758129, 4908.705477671351, 4934.062528119646, 4943.678660887031, 4947.431045429677, 4991.625628077836, 4909.975450122726, 5011.674241174312, 5021.7343839939895, 5022.0, 5028.59771218309, 5040.042391945519, 5061.645684802029, 5062.772175252197, 5064.949350506447, 5105.617078719185, 4886.780094895667, 4904.313396124474, 4905.141600219876, 4927.827526036572, 4950.851474455772, 4768.094062128184, 4911.165101932608, 4911.901761964812, 4954.108260512998, 4990.201567749288, 4844.685095468783, 4847.297141914473, 4869.488703686204, 4889.119958407521, 4906.484819093944, 4898.0, 4900.093482705711, 4904.117258893433, 4933.112039832865, 4952.8761780955765, 4723.220668589644, 4839.2983017462975, 4855.465898751064, 4893.681910675795, 4897.9020419592125], "value": 4637.430631160115, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [567.937526872044, 615.0558892100626, 627.5952010952935, 632.2760439297004, 641.8908785506463, 33003.174920626996, 33952.83023584885, 34087.31825363491, 34114.82942585283, 34194.0, 35006.29987400251, 35453.75911843086, 35621.643783562155, 35627.64372356276, 35825.46261806075, 7537.095548534184, 7641.885371719429, 7642.694292228304, 7715.267049630276, 7721.961390193042, 7642.656080476364, 7814.374850012014, 7829.217078292182, 7837.921620783776, 7839.451238413313, 7789.260020298063, 7833.882491762628, 7838.764837054898, 7851.332636725857, 7865.331446827026, 7779.7666070017995, 7786.961065194694, 7807.843843123134, 7819.765407037798, 7834.843303133963, 7686.308232259067, 7738.961305193494, 7767.53394796314, 7789.260020298063, 7796.4932279401655, 25470.0, 34684.47973280403, 35192.0, 35210.0, 35303.0, 2860.3850172212865, 2882.20739296693, 3009.0822299198735, 3324.6176689680756, 3623.184783423735, 24139.879300603385, 24907.128250511327, 24907.875460622763, 25095.121670741435, 25260.49479010428, 3176.5235214717745, 3245.464498357768, 3255.3489302139665, 3263.0863358259726, 3304.6364899860996, 167059.0, 167652.0, 168358.0, 168645.0, 169953.0, 31288.21779455532, 31617.367652647277, 31678.841605791822, 31726.0, 31790.682093178773, 33032.66967330344, 49956.500434995185, 51069.23396149061, 51129.74435127801, 51346.74326628343, 14638.121712697272, 14829.925850370895, 14850.777238341434, 14883.181425021729, 14935.925320373328, 11398.886011139948, 11422.657320280405, 11429.371384573762, 11441.656750297505, 11453.885461145448, 17559.912200438917, 17560.824391756174, 17612.823871761375, 17645.558861028578, 17668.0, 6737.258901520829, 6855.965720171367, 7045.0, 7078.858422831515, 7129.287071292829, 775.8836174573746, 903.1781079217881, 995.2137811129271, 1003.4681618742078, 1035.7928414317166, 26553.601695974576, 26761.197164085108, 27242.318942026606, 27261.591076133478, 27844.860775696397, 918.5866360137965, 964.609333220047, 990.2028866762181, 1013.852991316255, 1031.0720351683544, 13183.0, 13481.0, 13719.725605487834, 13910.165390076629, 14044.508442204473, 261513.0, 264897.0, 265753.0, 266416.0, 268196.0, 46321.768391158505, 47145.29282060772, 47175.52824471711, 47177.29234061492, 47198.292025619645, 1214.8602910665386, 1270.2695949828885, 1297.5199176304827, 1305.9934700326628, 1313.8029295605545, 25085.623715643917, 26247.868760656074, 26326.341841454116, 26476.0, 27054.458910822068, 40156.59843401646, 40915.18169636531, 40972.79513602413, 40993.79503102465, 40995.38506922458, 246656.0, 247335.0, 248174.0, 249237.0, 249397.0, 24339.513209735353, 33049.0, 33620.327593448485, 33686.83156584201, 34110.48834267537, 36220.4566931491, 39605.60394396019, 40069.0, 40850.387244190766, 40926.795366022976, 33548.66451335455, 34304.0, 34342.0, 34860.30279394347, 35161.824190878884, 33510.832445837616, 33890.830545847115, 34008.65991340154, 34396.31207375888, 34745.826270868485, 28092.43815123727, 30979.535306969963, 31653.525197121602, 33910.83044584761, 34726.82636586801, 27948.0, 28897.988570399935, 28945.56581651235, 28999.710002900545, 29082.854585726935, 23547.0, 24534.50930981406, 24646.599200747503, 24832.751672483046, 24945.625815613144], "value": 16314.440483464437, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [386.7660065660277, 391.30543285667943, 394.51080659981596, 395.34372940918075, 397.0906623831426, 12258.387080645976, 14994.850051499481, 15125.09249445034, 15746.606334841621, 15749.527514174579, 15038.849611503882, 15264.16047117408, 15464.922675386635, 15806.209689515536, 15854.524364269091, 4962.826301079463, 5066.088104141253, 5082.3138876251605, 5096.133657278272, 5124.128898087334, 4989.950100498985, 5146.099432599281, 5188.948110518884, 5203.947960520384, 5217.34783152106, 5153.2785410042625, 5157.819476318329, 5158.638895277332, 5162.664426812264, 5163.173892177252, 5008.3238762767105, 5115.411727651312, 5126.820561280338, 5171.172612382001, 5175.870603234912, 4619.86140415788, 4633.49031606523, 4633.582977532038, 4647.930281045787, 4648.093621743761, 18620.44138675842, 18964.24143034277, 19672.901635491875, 19775.40673779789, 19784.505387365287, 1698.524413164316, 1859.1633764805892, 1959.5297128689012, 2100.8634438761433, 2340.5552944940405, 8815.647374105092, 8943.821123577492, 9006.099390061006, 9135.132162444557, 9348.95325523368, 1813.727940808876, 1833.468294194682, 1861.292708770672, 1863.7670291213599, 1867.085128287143, 53352.466475335525, 56448.717756411366, 56740.716296418665, 56796.716016419654, 57343.713281433746, 9794.069563391466, 9976.401415915068, 10002.149817265468, 10192.949035254776, 10314.638987635397, 11926.582569610195, 12794.0, 14092.436302547783, 14176.574702758933, 14189.716205675828, 6914.965425172842, 7109.715611375591, 7116.750913717995, 7186.10173728284, 7245.637718114179, 6476.902846457307, 6496.545241833121, 6530.575512591667, 6856.725730970706, 6911.619860907598, 4315.525292217853, 4404.955950440519, 4430.224710675619, 4512.593866552026, 4543.363929049936, 1889.5653999580175, 1911.5412301047927, 1941.8155275248828, 1959.0890236040025, 1972.7435433393566, 868.8870446841996, 880.7489865388334, 892.1390857822232, 986.413084214891, 1014.3913651808856, 15345.46290879814, 15888.443904463289, 16277.430289939795, 16323.428679996381, 16663.0, 903.584351198456, 937.2221056523069, 939.8825146856643, 940.5438362394233, 953.4517652349926, 8984.304708587397, 9304.534773261445, 9314.0, 9359.532023398802, 9506.287028472754, 385870.0, 386149.0, 386685.0, 387905.0, 398918.0, 64628.35371646317, 64750.352496474436, 64778.35221647723, 65085.67457162684, 65546.34453655499, 931.2177770672532, 932.9020452852353, 947.9810403791886, 952.6189524190379, 952.7475219066953, 13713.45146194181, 14517.0, 14526.457869872518, 14876.181810000553, 14902.77645835335, 25341.74658253394, 28629.28426789347, 30158.0, 30213.244668883453, 31419.371612568077, 37424.631783139645, 37971.62028379681, 38553.2289354217, 39355.0, 39530.60469395269, 7203.495755297079, 7266.564006159648, 7339.559626422431, 7528.510646808159, 7577.0907491101425, 10032.899671003197, 10945.671629851116, 11061.944690276498, 11302.773944521228, 11433.771324573629, 10076.345037572535, 10124.89875101269, 10129.848052279369, 10228.948855255676, 10465.215108867018, 10201.336913100624, 10205.744856378353, 10365.429901355497, 10497.79004419892, 10563.735906602396, 10257.74355641115, 10413.84379234297, 10452.895471045496, 10540.209484288862, 10572.84140737905, 7030.9296907030275, 7435.591042492715, 7700.499467534592, 7718.498297610638, 7913.208679132271, 8848.46909185451, 9547.952260238655, 9598.232141428529, 9669.468179250209, 9716.75708107303], "value": 7877.353640471956, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1436.3177490691924, 1456.519348614957, 1562.7343351630223, 1730.420309196419, 1730.8874923129988, 6731.158605174353, 7049.471289653271, 7296.744613938513, 7305.45209109317, 7454.180040195574, 7469.439792015593, 7513.286237807413, 7526.548407095578, 7575.621218939044, 7597.92402075979, 2230.275160572812, 2244.0911430870524, 2245.303955773707, 2246.8539544929527, 2252.4368907773055, 2155.1164022750677, 2189.7591264960843, 2191.583599116163, 2198.9780102199015, 2211.889405529717, 2227.8551894126913, 2229.063793206857, 2258.954820903581, 2268.852524585905, 2277.9202727904444, 2146.1415433826437, 2152.3220185641553, 2152.9031193596247, 2175.9564808703894, 2176.706144670473, 2195.7365116186, 2206.6359050756605, 2214.900329485177, 2218.6006518826603, 2220.622494175978, 7598.886016709754, 7696.807579810494, 7697.653605587706, 7698.4226183035935, 7706.229377062305, 4689.39037925071, 4807.062622788558, 4831.782569784333, 4847.272909063633, 4873.220284754458, 2850.0, 3073.738732207765, 3073.938521229563, 3143.905682829519, 3150.637676667167, 905.9184673379361, 927.4157280913049, 945.1380779863657, 954.5513608603945, 981.2346369831542, 10214.28500005, 10244.0, 10248.846267305997, 10255.794884102275, 10260.486975651187, 4338.522762496123, 4362.192994296065, 4405.471343438808, 4468.4414448193975, 4468.955310446919, 8841.823163536821, 8855.203031727047, 8858.911410885808, 8860.069692682304, 8898.955505222433, 4799.256115302133, 4805.3512775775525, 4813.663043586916, 4817.325574419584, 4847.854564363075, 3695.8336874840697, 4243.151369726005, 4249.1501699659575, 4298.849540266076, 4390.670699697535, 3634.327649384872, 3691.557013158438, 3728.1984373359314, 3783.3000894834545, 3860.1121741999495, 1220.9389530523615, 1251.6245126462206, 1260.0549587809144, 1270.4600544768437, 1270.790319597256, 789.7117552093559, 896.7668406214301, 911.6672414568635, 918.8697901581093, 933.0902370189146, 5354.196870469461, 5370.785168593213, 5490.6431081979545, 5557.333120025542, 5645.858853528694, 429.65627498001476, 436.70522397382274, 442.6547293111378, 442.82729735403217, 448.3275087368947, 3703.129764505339, 3718.8698395556025, 3740.121071548184, 3745.7752534847996, 3788.5643151037434, 8644.22202001823, 8957.507337096393, 8979.640814367483, 9008.909910900938, 9009.684661036832, 8731.25784308341, 8909.643614255487, 8922.86615700765, 8924.241439477717, 8960.327975401871, 6897.793066208022, 6958.512904096766, 6965.477589180831, 7071.974563688339, 7114.679839407136, 5209.505097015777, 5212.061828870839, 5232.424433312256, 5320.627556071038, 5329.813456529003, 8205.83588328242, 8272.214139656722, 8397.916020839713, 8426.452280601741, 8431.030431500456, 8250.54621995796, 8277.668893244203, 8306.127856574973, 8622.78443038929, 8696.304295656459, 6062.878742425215, 6250.124982502362, 6467.773627923, 6712.798616041527, 6858.142732158481, 6979.720811167496, 7007.649617519206, 7028.367446929801, 7052.929470705228, 7056.15326160864, 6083.847903802263, 6166.907496387468, 6284.465820405134, 6377.426031656987, 6441.613503189824, 6382.074599183, 6517.674116294261, 6549.901751473636, 6556.868862622816, 6576.934230657632, 6084.7566097357385, 6169.259688837368, 6194.876102478015, 6206.596571222856, 6215.533834962305, 4406.955930440655, 4576.908461830678, 4586.151561961048, 4605.40129783126, 4607.493175750732, 4549.431321084864, 4609.769511524343, 4630.189716799614, 4670.626349892068, 4687.156311863897], "value": 4048.5993137501105, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [287.5672113469229, 294.47730278755205, 294.56845721018703, 301.44684503935275, 308.79465155671477, 4843.200871856144, 4868.196747536656, 4871.366722326097, 4890.266460030997, 4914.680545764523, 4823.469418363986, 4829.323894654751, 4829.985703002365, 4853.384228749577, 4854.611631069515, 3639.5996440391536, 3717.107894105409, 3829.636184562476, 3845.173542567286, 3847.3267178243836, 3813.2564149990762, 3826.8660596879113, 3840.5967373425806, 3861.80690965452, 3869.2648396804516, 3782.5460944686674, 3820.465134881119, 3830.2148059647707, 3830.8467661293653, 3839.0978120141745, 3561.8753343632848, 3769.981150094259, 3786.583475817658, 3792.8862134135884, 3809.29528037314, 3289.227031647561, 3317.8672853085845, 3327.3678001179696, 3327.683870032343, 3345.531625572422, 4619.538046195387, 4634.976825115853, 4638.234691275969, 4646.281925073802, 4652.906941861143, 4309.288967320388, 4324.437823083011, 4332.090261045184, 4333.241682705514, 4333.848315308949, 4984.8753781155765, 5041.445441001487, 5058.494150584949, 5080.77136528857, 5102.36220472441, 3586.1751797086554, 3598.3702852000797, 3599.2981368633127, 3604.3151801157696, 3608.548931383577, 5253.842384728464, 5317.973410132963, 5332.626716129873, 5360.437154098841, 5362.839114826562, 3576.499290099388, 3698.4822124902535, 3698.7595806272507, 3784.7539909905768, 3797.6012518685693, 3823.2735780201674, 3824.9043773905873, 3831.310364134427, 3892.4355968384994, 3895.6493915547735, 4389.495208051115, 4408.272635015187, 4421.0, 4427.180971520214, 4428.114377124523, 4818.253170758538, 5094.898102037939, 5161.509656582619, 5164.244156986642, 5167.896642067138, 1383.688670049251, 1391.422559637739, 1394.6583087143715, 1397.6785339372002, 1397.6994946086436, 897.7441429192779, 955.5508910811907, 958.1041725986225, 986.0878687214298, 997.6109317366233, 4468.955310446919, 4602.815887364468, 4633.443986721615, 4637.837675681335, 4646.907061858744, 5260.658057226268, 5291.841244762663, 5292.285541451932, 5292.380271765501, 5311.123664595299, 4563.566461186182, 4647.95352046482, 4652.930206046912, 4657.67396282257, 4659.9767001165455, 2987.2979849735293, 3011.0515187716237, 3014.4423281692957, 3018.6679465258803, 3030.636323641133, 5452.972735136378, 5456.945430545723, 5478.424765399655, 5502.504774570308, 5506.0, 5555.2778138841695, 5764.971175144181, 5776.96014717355, 5781.814727980754, 5786.768529258867, 5458.426865179178, 5467.234587157801, 5470.0, 5472.671639701631, 5486.753096110685, 5560.27716396882, 5563.221149039218, 5580.497755202051, 5595.832125036255, 5672.744726487235, 5377.1448850146635, 5510.3938566758425, 5559.305086864142, 5570.136628822539, 5578.219049333178, 5335.519803217729, 5384.811531596375, 5431.701256430776, 5463.699496527729, 5484.1773733938635, 3990.4413382125945, 3993.1813978133832, 4000.319945609195, 4006.419069234886, 4010.8970033241094, 5015.470281564158, 5215.947840521546, 5317.867053323698, 5323.866903327448, 5328.280682107866, 5069.340985671839, 5102.79588816458, 5104.132297509506, 5142.6914385137015, 5146.922796157985, 4832.767644250694, 5096.1336572781975, 5130.435652078194, 5135.306733590917, 5155.742212889416, 5051.318072060225, 5057.280524621647, 5091.134507133722, 5096.974515127401, 5107.923381149211, 4878.317035614946, 4959.925601116059, 5171.534561889448, 5192.584593232456, 5207.1147904857025, 4935.703857768545, 5037.974810125926, 5050.141475949171, 5057.216131499624, 5061.443241243386], "value": 3941.861306712868, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [672.815953081507, 708.4686485136144, 711.8505113926075, 760.4638729695565, 798.1140933563745, 11960.461779219935, 12273.938630306859, 12320.93839530801, 12349.07381946353, 12357.876421235775, 11253.09975201984, 11289.548418063268, 11297.774044519105, 11312.830307545373, 11315.094792416607, 624.6720471752321, 775.8991331126946, 802.1897883138014, 807.0315621254489, 807.3823525003377, 798.9280964713174, 806.1535387842771, 807.6728924785472, 809.720646376999, 810.092696180279, 854.9529775862325, 856.9657213711444, 858.5063588436643, 860.979739009276, 863.7797361672796, 857.588357588358, 857.8541647919868, 858.2747578296361, 860.5869182792233, 860.7891066688638, 624.7657128576784, 625.3152797686525, 625.5808608232495, 625.7059182184366, 629.965351905645, 11754.235974661706, 11846.526138954432, 11849.881501184964, 11917.046636269077, 11928.70178245542, 12636.11547191697, 12827.935860320733, 12875.227486350755, 12920.547780827626, 13076.607701768962, 9725.124738773544, 9744.31789774716, 9928.95035524825, 10089.394636321771, 10436.739081522946, 3305.1571849178545, 3415.624281329052, 3426.3661222673636, 3523.964760352415, 3546.2552863898613, 44828.0, 45336.093278134584, 45391.31913021307, 45583.54416455826, 45737.77131114323, 10322.554961733214, 10332.53503592325, 10386.584536618602, 10518.789624207473, 10583.153347732163, 16040.919795401182, 18136.45590632283, 18151.546211344557, 18330.266789328278, 18375.632487350445, 6186.381361863868, 6303.275123360872, 6340.0, 6390.488760899117, 6527.967360163168, 3895.8831235062994, 3915.9056278694543, 3970.3845903884944, 3974.16542526067, 4030.496187976503, 2820.252633052243, 2916.052283008031, 2916.693747156518, 2921.328094538268, 2925.18094933419, 526.8867193553405, 534.060054304427, 540.1384791257938, 545.7544105152697, 547.4170008940465, 509.80882169186555, 571.4770984549091, 616.3066550131102, 621.8569728962364, 628.3527966194827, 8185.918140818635, 8328.375371847136, 8588.52763098023, 8638.481691098554, 8845.601947912359, 615.301632646949, 620.3765215958024, 626.9028300613412, 633.5343522510951, 642.2293248102296, 3728.3475391806323, 3844.3464611016193, 4005.8798236052967, 4100.384942258685, 4162.313218318944, 49312.0, 49955.75022124866, 50007.499925001015, 50464.0, 50851.237231441555, 45116.54883451123, 45362.0, 46067.539324606994, 46491.76754116208, 46732.5326746735, 42368.0, 42415.0, 42623.93440164083, 42689.14621707548, 43315.56684433115, 7433.479656423999, 7823.452358334862, 7838.098618658927, 7883.724069657764, 7988.320992715452, 28270.0, 28335.2916177089, 28860.278493037003, 29723.85138074296, 30186.547201791553, 36729.26541469209, 37526.2494750098, 37638.435423469215, 37791.62208377881, 37809.62190378061, 9614.375065620712, 9745.80508389814, 9995.400275983464, 10071.949640251752, 10099.646512372032, 10908.400037997986, 10928.453577321261, 11842.11184161174, 11922.701932451759, 12047.578334758242, 10771.51528181218, 11046.226764126433, 11221.60724374643, 11436.885631143914, 11560.826587601361, 10496.842547361948, 10644.308119972176, 10800.513976871216, 11909.702257443632, 12079.637610871689, 10669.0, 10938.343699378063, 11041.33751974884, 11138.164637652046, 11922.344271065174, 9663.758406039906, 9930.304878658424, 9963.053509916546, 9977.800443991226, 10216.489175541044, 9332.626694932127, 9430.57562409707, 9632.988536203879, 9663.323567350219, 9913.157381622643], "value": 5958.247427987487, "unit": "score"}], "name": "dromaeo_css", "value": 6197.739498584683, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 107.0, 112.0, 115.0, 114.0, 126.0, 113.0, 113.0, 114.0, 111.0], "value": 113.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 132.0, 162.0, 193.0, 141.0, 162.0, 164.0, 134.0, 184.0, 137.0], "value": 157.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 165.0, 167.0, 169.0, 161.0, 163.0, 164.0, 171.0, 162.0], "value": 164.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 78.0, 76.0, 158.0, 76.0, 74.0, 73.0, 73.0, 162.0, 77.0], "value": 92.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 93.0, 154.0, 95.0, 94.0, 95.0, 139.0, 95.0, 94.0, 145.0], "value": 110.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 118.0, 117.0, 118.0, 118.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 149.0, 147.0, 148.0, 147.0, 148.0, 147.0, 148.0], "value": 147.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 95.0, 95.0, 97.0, 95.0, 96.0, 95.0, 96.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 67.0, 70.0, 66.0, 65.0, 70.0, 81.0, 64.0, 62.0], "value": 67.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 65.0, 65.0, 64.0, 65.0, 65.0, 65.0, 64.0, 66.0], "value": 64.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 80.0, 80.0, 81.0, 89.0, 82.0, 80.0, 80.0, 90.0], "value": 81.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 136.0, 137.0, 139.0, 135.0, 135.0, 142.0, 141.0, 175.0, 139.0], "value": 142.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [223.0, 221.0, 222.0, 218.0, 216.0, 212.0, 222.0, 230.0, 219.0, 215.0], "value": 219.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 76.0, 74.0, 74.0, 77.0, 76.0, 75.0, 76.0, 75.0, 80.0], "value": 76.2, "unit": "score"}], "name": "kraken", "value": 1651.7, "alertThreshold": 2.0}]} 03:12:12 INFO - Return code: 0 03:12:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:12:12 ERROR - # TBPL SUCCESS # 03:12:12 INFO - Running post-action listener: _resource_record_post_action 03:12:12 INFO - Running post-run listener: _resource_record_post_run 03:12:13 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 4096; Write bytes: 534925312; Read time: 172; Write time: 456240 03:12:13 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 230420480; Read time: 0; Write time: 241172 03:12:13 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 4096; Write bytes: 293900288; Read time: 172; Write time: 212540 03:12:13 INFO - Running post-run listener: _upload_blobber_files 03:12:13 INFO - Blob upload gear active. 03:12:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:12:13 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 03:12:13 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:12:13 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:12:14 INFO - (blobuploader) - INFO - Open directory for files ... 03:12:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:12:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:12:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:12:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:12:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:12:15 INFO - (blobuploader) - INFO - Done attempting. 03:12:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:12:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:12:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:12:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:12:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:12:15 INFO - (blobuploader) - INFO - Done attempting. 03:12:15 INFO - (blobuploader) - INFO - Iteration through files over. 03:12:15 INFO - Return code: 0 03:12:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:12:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:12:15 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6f2f875f1c5d47ac9b12baeea6d415c2d12a94bb1d1e83ad007aede1f5668fb336161ffd6bafd5be4943bde7abf724a838e97fecd36e202230ba6f45df8b0b2c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/96c3e897259a767b4f2a2b4aa5c5c375691a8c0f3949e1392d09e84b393b7d56bf1c80494ed4f90adce3722b0400664293b25b57443081c68ce5e39ec821d17c"} 03:12:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:12:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:12:15 INFO - Contents: 03:12:15 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6f2f875f1c5d47ac9b12baeea6d415c2d12a94bb1d1e83ad007aede1f5668fb336161ffd6bafd5be4943bde7abf724a838e97fecd36e202230ba6f45df8b0b2c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/96c3e897259a767b4f2a2b4aa5c5c375691a8c0f3949e1392d09e84b393b7d56bf1c80494ed4f90adce3722b0400664293b25b57443081c68ce5e39ec821d17c"} 03:12:15 INFO - Running post-run listener: copy_logs_to_upload_dir 03:12:15 INFO - Copying logs to upload dir... 03:12:15 INFO - mkdir: /builds/slave/test/build/upload/logs 03:12:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.760859 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-04-28 03:12:15.431634) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-28 03:12:15.439190) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1461837099.146399-1328139825 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-Non-PGO/sha512/6f2f875f1c5d47ac9b12baeea6d415c2d12a94bb1d1e83ad007aede1f5668fb336161ffd6bafd5be4943bde7abf724a838e97fecd36e202230ba6f45df8b0b2c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/96c3e897259a767b4f2a2b4aa5c5c375691a8c0f3949e1392d09e84b393b7d56bf1c80494ed4f90adce3722b0400664293b25b57443081c68ce5e39ec821d17c"} build_url:https://queue.taskcluster.net/v1/task/Q0Vhu-HzTe6qjq03Mj0Rqg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011241 build_url: 'https://queue.taskcluster.net/v1/task/Q0Vhu-HzTe6qjq03Mj0Rqg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6f2f875f1c5d47ac9b12baeea6d415c2d12a94bb1d1e83ad007aede1f5668fb336161ffd6bafd5be4943bde7abf724a838e97fecd36e202230ba6f45df8b0b2c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/96c3e897259a767b4f2a2b4aa5c5c375691a8c0f3949e1392d09e84b393b7d56bf1c80494ed4f90adce3722b0400664293b25b57443081c68ce5e39ec821d17c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-28 03:12:15.466372) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 03:12:15.466715) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1461837099.146399-1328139825 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004414 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 03:12:15.549454) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-28 03:12:15.552797) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-28 03:12:15.553106) ========= ========= Total master_lag: 0.19 =========