builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-013 starttime: 1460087179.05 results: success (0) buildid: 20160407194941 builduid: 0b96af5b942a4076b4d2cba1be4a19df revision: 8a47b4f44a5a7899b13ab7aeb5b8ac4489ea81d8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-07 20:46:19.052341) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-07 20:46:19.052807) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-07 20:46:19.053099) ========= bash -c pwd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] 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=9c3a94c35cc88655b05d2c08000001b2-1460086771.369701-532901744 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006393 basedir: '/builds/slave/test' ========= master_lag: 0.08 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-07 20:46:19.143818) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-07 20:46:19.144098) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-07 20:46:19.572939) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 20:46:19.573192) ========= rm -rf properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', '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=9c3a94c35cc88655b05d2c08000001b2-1460086771.369701-532901744 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004708 ========= master_lag: 0.12 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 20:46:19.696851) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-07 20:46:19.697130) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-07 20:46:19.697485) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 20:46:19.697761) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1460086771.369701-532901744 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-07 20:46:20-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 89.2M=0s 2016-04-07 20:46:20 (89.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.327313 ========= master_lag: 0.09 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 20:46:20.112478) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 20:46:20.112761) ========= rm -rf scripts in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] 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=9c3a94c35cc88655b05d2c08000001b2-1460086771.369701-532901744 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014250 ========= master_lag: 0.23 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 20:46:20.352762) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 20:46:20.353620) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 8a47b4f44a5a7899b13ab7aeb5b8ac4489ea81d8 --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 8a47b4f44a5a7899b13ab7aeb5b8ac4489ea81d8 --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=9c3a94c35cc88655b05d2c08000001b2-1460086771.369701-532901744 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-07 20:46:20,918 truncating revision to first 12 chars 2016-04-07 20:46:20,918 Setting DEBUG logging. 2016-04-07 20:46:20,918 attempt 1/10 2016-04-07 20:46:20,918 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/8a47b4f44a5a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-07 20:46:21,555 unpacking tar archive at: fx-team-8a47b4f44a5a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.904916 ========= master_lag: 0.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 20:46:21.321701) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-07 20:46:21.322087) ========= echo 8a47b4f44a5a7899b13ab7aeb5b8ac4489ea81d8 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'8a47b4f44a5a7899b13ab7aeb5b8ac4489ea81d8'] 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=9c3a94c35cc88655b05d2c08000001b2-1460086771.369701-532901744 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 8a47b4f44a5a7899b13ab7aeb5b8ac4489ea81d8 program finished with exit code 0 elapsedTime=0.004796 script_repo_revision: '8a47b4f44a5a7899b13ab7aeb5b8ac4489ea81d8' ========= master_lag: 0.19 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-07 20:46:21.512570) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-07 20:46:21.513312) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-07 20:46:21.660703) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-04-07 20:46:21.661279) ========= /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=9c3a94c35cc88655b05d2c08000001b2-1460086771.369701-532901744 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:46:22 INFO - MultiFileLogger online at 20160407 20:46:22 in /builds/slave/test 20:46:22 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 20:46:22 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:46:22 INFO - {'append_to_log': False, 20:46:22 INFO - 'base_work_dir': '/builds/slave/test', 20:46:22 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 20:46:22 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:46:22 INFO - 'branch': 'Fx-Team-Non-PGO', 20:46:22 INFO - 'buildbot_json_path': 'buildprops.json', 20:46:22 INFO - 'config_files': ('talos/linux_config.py',), 20:46:22 INFO - 'default_actions': ('clobber', 20:46:22 INFO - 'read-buildbot-config', 20:46:22 INFO - 'download-and-extract', 20:46:22 INFO - 'populate-webroot', 20:46:22 INFO - 'create-virtualenv', 20:46:22 INFO - 'install', 20:46:22 INFO - 'run-tests'), 20:46:22 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:46:22 INFO - 'download_minidump_stackwalk': True, 20:46:22 INFO - 'download_symbols': 'ondemand', 20:46:22 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:46:22 INFO - 'tooltool.py': '/tools/tooltool.py', 20:46:22 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:46:22 INFO - '/tools/misc-python/virtualenv.py')}, 20:46:22 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:46:22 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:46:22 INFO - 'installer_path': 'installer.exe', 20:46:22 INFO - 'log_level': 'info', 20:46:22 INFO - 'log_name': 'talos', 20:46:22 INFO - 'log_to_console': True, 20:46:22 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:46:22 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:46:22 INFO - 'opt_config_files': (), 20:46:22 INFO - 'pip_index': False, 20:46:22 INFO - 'sps_profile': False, 20:46:22 INFO - 'sps_profile_interval': 0, 20:46:22 INFO - 'suite': 'dromaeojs-e10s', 20:46:22 INFO - 'system_bits': '32', 20:46:22 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:46:22 INFO - 'title': 'talos-linux64-ix-013', 20:46:22 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:46:22 INFO - 'use_talos_json': True, 20:46:22 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:46:22 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:46:22 INFO - 'work_dir': 'build'} 20:46:22 INFO - ##### 20:46:22 INFO - ##### Running clobber step. 20:46:22 INFO - ##### 20:46:22 INFO - Running pre-action listener: _resource_record_pre_action 20:46:22 INFO - Running main action method: clobber 20:46:22 INFO - rmtree: /builds/slave/test/build 20:46:22 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:46:22 INFO - Running post-action listener: _resource_record_post_action 20:46:22 INFO - ##### 20:46:22 INFO - ##### Running read-buildbot-config step. 20:46:22 INFO - ##### 20:46:22 INFO - Running pre-action listener: _resource_record_pre_action 20:46:22 INFO - Running main action method: read_buildbot_config 20:46:22 INFO - Using buildbot properties: 20:46:22 INFO - { 20:46:22 INFO - "project": "", 20:46:22 INFO - "product": "firefox", 20:46:22 INFO - "script_repo_revision": "production", 20:46:22 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 20:46:22 INFO - "repository": "", 20:46:22 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 20:46:22 INFO - "buildid": "20160407194941", 20:46:22 INFO - "pgo_build": "False", 20:46:22 INFO - "basedir": "/builds/slave/test", 20:46:22 INFO - "buildnumber": 1114, 20:46:22 INFO - "slavename": "talos-linux64-ix-013", 20:46:22 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 20:46:22 INFO - "platform": "ubuntu64_hw", 20:46:22 INFO - "scheduler": "tests-fx-team-linux64-talos", 20:46:22 INFO - "branch": "fx-team", 20:46:22 INFO - "repo_path": "integration/fx-team", 20:46:22 INFO - "revision": "8a47b4f44a5a7899b13ab7aeb5b8ac4489ea81d8", 20:46:22 INFO - "stage_platform": "linux64", 20:46:22 INFO - "builduid": "0b96af5b942a4076b4d2cba1be4a19df", 20:46:22 INFO - "slavebuilddir": "test" 20:46:22 INFO - } 20:46:22 INFO - Found installer url https://queue.taskcluster.net/v1/task/F9p3J0xnTNmJoBYMObrXAQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 20:46:22 INFO - Running post-action listener: _resource_record_post_action 20:46:22 INFO - ##### 20:46:22 INFO - ##### Running download-and-extract step. 20:46:22 INFO - ##### 20:46:22 INFO - Running pre-action listener: _resource_record_pre_action 20:46:22 INFO - Running main action method: download_and_extract 20:46:22 INFO - mkdir: /builds/slave/test/build/tests 20:46:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:46:22 INFO - https://queue.taskcluster.net/v1/task/F9p3J0xnTNmJoBYMObrXAQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 20:46:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F9p3J0xnTNmJoBYMObrXAQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 20:46:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F9p3J0xnTNmJoBYMObrXAQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 20:46:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F9p3J0xnTNmJoBYMObrXAQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 20:46:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F9p3J0xnTNmJoBYMObrXAQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 20:46:28 INFO - Downloaded 1361 bytes. 20:46:28 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 20:46:28 INFO - Using the following test package requirements: 20:46:28 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 20:46:28 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 20:46:28 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:46:28 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 20:46:28 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 20:46:28 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 20:46:28 INFO - u'jsshell-linux-x86_64.zip'], 20:46:28 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 20:46:28 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:46:28 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 20:46:28 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 20:46:28 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:46:28 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 20:46:28 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:46:28 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 20:46:28 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:46:28 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 20:46:28 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:46:28 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:46:28 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')]} 20:46:28 INFO - https://queue.taskcluster.net/v1/task/F9p3J0xnTNmJoBYMObrXAQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:46:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F9p3J0xnTNmJoBYMObrXAQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 20:46:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F9p3J0xnTNmJoBYMObrXAQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 20:46:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F9p3J0xnTNmJoBYMObrXAQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 20:46:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F9p3J0xnTNmJoBYMObrXAQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:46:33 INFO - Downloaded 22186272 bytes. 20:46:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:46:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 20:46:34 INFO - Return code: 0 20:46:34 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 20:46:34 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')]} 20:46:34 INFO - https://queue.taskcluster.net/v1/task/F9p3J0xnTNmJoBYMObrXAQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:46:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F9p3J0xnTNmJoBYMObrXAQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 20:46:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F9p3J0xnTNmJoBYMObrXAQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 20:46:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F9p3J0xnTNmJoBYMObrXAQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 20:46:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F9p3J0xnTNmJoBYMObrXAQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:46:36 INFO - Downloaded 22186272 bytes. 20:46:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:46:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 20:46:38 INFO - Return code: 0 20:46:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:46:38 INFO - https://queue.taskcluster.net/v1/task/F9p3J0xnTNmJoBYMObrXAQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 20:46:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F9p3J0xnTNmJoBYMObrXAQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 20:46:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F9p3J0xnTNmJoBYMObrXAQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 20:46:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F9p3J0xnTNmJoBYMObrXAQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 20:46:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F9p3J0xnTNmJoBYMObrXAQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 20:46:39 INFO - Downloaded 10847693 bytes. 20:46:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:46:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 20:46:39 INFO - Return code: 0 20:46:39 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')]} 20:46:39 INFO - https://queue.taskcluster.net/v1/task/F9p3J0xnTNmJoBYMObrXAQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 20:46:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F9p3J0xnTNmJoBYMObrXAQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 20:46:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F9p3J0xnTNmJoBYMObrXAQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 20:46:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F9p3J0xnTNmJoBYMObrXAQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 20:46:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F9p3J0xnTNmJoBYMObrXAQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 20:46:45 INFO - Downloaded 54050334 bytes. 20:46:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/F9p3J0xnTNmJoBYMObrXAQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 20:46:45 INFO - mkdir: /builds/slave/test/properties 20:46:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:46:45 INFO - Writing to file /builds/slave/test/properties/build_url 20:46:45 INFO - Contents: 20:46:45 INFO - build_url:https://queue.taskcluster.net/v1/task/F9p3J0xnTNmJoBYMObrXAQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 20:46:46 INFO - Running post-action listener: _resource_record_post_action 20:46:46 INFO - Running post-action listener: set_extra_try_arguments 20:46:46 INFO - ##### 20:46:46 INFO - ##### Running populate-webroot step. 20:46:46 INFO - ##### 20:46:46 INFO - Running pre-action listener: _resource_record_pre_action 20:46:46 INFO - Running main action method: populate_webroot 20:46:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:46:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:46:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:46:46 INFO - '--tppagecycles', 20:46:46 INFO - '7'], 20:46:46 INFO - 'tests': ['tsvgm']}}, 20:46:46 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:46:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:46:46 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:46:46 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:46:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:46:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:46:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:46:46 INFO - 'talos_options': ['--disable-e10s'], 20:46:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:46:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:46:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:46:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:46:46 INFO - 'talos_options': ['--disable-e10s'], 20:46:46 INFO - 'tests': ['damp', 'tps']}, 20:46:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:46:46 INFO - 'tests': ['damp', 'tps']}, 20:46:46 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:46:46 INFO - 'tests': ['dromaeo_dom']}, 20:46:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:46:46 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:46:46 INFO - 'tests': ['a11yr', 20:46:46 INFO - 'ts_paint', 20:46:46 INFO - 'tpaint', 20:46:46 INFO - 'sessionrestore', 20:46:46 INFO - 'sessionrestore_no_auto_restore', 20:46:46 INFO - 'tabpaint']}, 20:46:46 INFO - 'other-e10s': {'tests': ['a11yr', 20:46:46 INFO - 'ts_paint', 20:46:46 INFO - 'tpaint', 20:46:46 INFO - 'sessionrestore', 20:46:46 INFO - 'sessionrestore_no_auto_restore', 20:46:46 INFO - 'tabpaint']}, 20:46:46 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:46:46 INFO - 'ts_paint', 20:46:46 INFO - 'tpaint', 20:46:46 INFO - 'sessionrestore', 20:46:46 INFO - 'sessionrestore_no_auto_restore', 20:46:46 INFO - 'tabpaint']}, 20:46:46 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:46:46 INFO - 'ts_paint', 20:46:46 INFO - 'tpaint', 20:46:46 INFO - 'sessionrestore', 20:46:46 INFO - 'sessionrestore_no_auto_restore', 20:46:46 INFO - 'tabpaint']}, 20:46:46 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:46:46 INFO - 'tests': ['a11yr', 20:46:46 INFO - 'ts_paint', 20:46:46 INFO - 'tpaint', 20:46:46 INFO - 'sessionrestore', 20:46:46 INFO - 'sessionrestore_no_auto_restore', 20:46:46 INFO - 'tabpaint']}, 20:46:46 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:46:46 INFO - 'tests': ['a11yr', 20:46:46 INFO - 'ts_paint', 20:46:46 INFO - 'tpaint', 20:46:46 INFO - 'sessionrestore', 20:46:46 INFO - 'sessionrestore_no_auto_restore', 20:46:46 INFO - 'tabpaint']}, 20:46:46 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:46:46 INFO - 'tests': ['tsvgx', 20:46:46 INFO - 'tsvgr_opacity', 20:46:46 INFO - 'tart', 20:46:46 INFO - 'tscrollx', 20:46:46 INFO - 'cart']}, 20:46:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:46:46 INFO - 'tsvgr_opacity', 20:46:46 INFO - 'tart', 20:46:46 INFO - 'tscrollx', 20:46:46 INFO - 'cart']}, 20:46:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:46:46 INFO - 'talos_options': ['--disable-e10s'], 20:46:46 INFO - 'tests': ['tp5o']}, 20:46:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:46:46 INFO - 'tests': ['tp5o']}, 20:46:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:46:46 INFO - 'talos_options': ['--disable-e10s', 20:46:46 INFO - '--xperf_path', 20:46:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:46:46 INFO - 'tests': ['tp5n']}, 20:46:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:46:46 INFO - 'talos_options': ['--xperf_path', 20:46:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:46:46 INFO - 'tests': ['tp5n']}}, 20:46:46 INFO - 'talos.zip': {'path': '', 20:46:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:46:46 INFO - Running post-action listener: _resource_record_post_action 20:46:46 INFO - ##### 20:46:46 INFO - ##### Running create-virtualenv step. 20:46:46 INFO - ##### 20:46:46 INFO - Running pre-action listener: _resource_record_pre_action 20:46:46 INFO - Running main action method: create_virtualenv 20:46:46 INFO - Creating virtualenv /builds/slave/test/build/venv 20:46:46 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 20:46:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:46:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:46:46 INFO - Using real prefix '/usr' 20:46:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:46:46 INFO - Installing distribute.............................................................................................................................................................................................done. 20:46:48 INFO - Installing pip.................done. 20:46:48 INFO - Return code: 0 20:46:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:46: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')]} 20:46:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:46:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:46: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')]} 20:46:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:46:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:46:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa4fcca3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28915a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2920410>, '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 0x2921310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29217a0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1460086771.369701-532901744', '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 20:46:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 20:46:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 20:46:48 INFO - Using env: {'DISPLAY': ':0', 20:46:48 INFO - 'HOME': '/home/cltbld', 20:46:48 INFO - 'LANG': 'en_US.UTF-8', 20:46:48 INFO - 'LANGUAGE': 'en_US:en', 20:46:48 INFO - 'LOGNAME': 'cltbld', 20:46:48 INFO - 'MAIL': '/var/mail/cltbld', 20:46:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:46:48 INFO - 'MOZ_NO_REMOTE': '1', 20:46:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:46:48 INFO - 'NO_EM_RESTART': '1', 20:46:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:46:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:46:48 INFO - 'PWD': '/builds/slave/test', 20:46:48 INFO - 'SHELL': '/bin/bash', 20:46:48 INFO - 'SHLVL': '1', 20:46:48 INFO - 'TERM': 'linux', 20:46:48 INFO - 'TMOUT': '86400', 20:46:48 INFO - 'USER': 'cltbld', 20:46:48 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1460086771.369701-532901744', 20:46:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:46:48 INFO - '_': '/tools/buildbot/bin/python'} 20:46:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:46:48 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 20:46:48 INFO - Cleaning up... 20:46:48 INFO - Return code: 0 20:46:48 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 20:46: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')]} 20:46:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:46:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:46: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')]} 20:46:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:46:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:46:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fa4fcca3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28915a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2920410>, '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 0x2921310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29217a0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1460086771.369701-532901744', '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 20:46:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 20:46:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 20:46:48 INFO - Using env: {'DISPLAY': ':0', 20:46:48 INFO - 'HOME': '/home/cltbld', 20:46:48 INFO - 'LANG': 'en_US.UTF-8', 20:46:48 INFO - 'LANGUAGE': 'en_US:en', 20:46:48 INFO - 'LOGNAME': 'cltbld', 20:46:48 INFO - 'MAIL': '/var/mail/cltbld', 20:46:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:46:48 INFO - 'MOZ_NO_REMOTE': '1', 20:46:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:46:48 INFO - 'NO_EM_RESTART': '1', 20:46:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:46:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:46:48 INFO - 'PWD': '/builds/slave/test', 20:46:48 INFO - 'SHELL': '/bin/bash', 20:46:48 INFO - 'SHLVL': '1', 20:46:48 INFO - 'TERM': 'linux', 20:46:48 INFO - 'TMOUT': '86400', 20:46:48 INFO - 'USER': 'cltbld', 20:46:48 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1460086771.369701-532901744', 20:46:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:46:48 INFO - '_': '/tools/buildbot/bin/python'} 20:46:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:46:49 INFO - Downloading/unpacking psutil>=0.7.1 20:46:49 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 20:46:49 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 20:46:49 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 20:46:49 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 20:46:49 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 20:46:49 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 20:46:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:46:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:46:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:46:51 INFO - Installing collected packages: psutil 20:46:51 INFO - Running setup.py install for psutil 20:46:51 INFO - building 'psutil._psutil_linux' extension 20:46:51 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 20:46:51 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 20:46:51 INFO - building 'psutil._psutil_posix' extension 20:46:51 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 20:46:51 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 20:46:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:46:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:46:51 INFO - Successfully installed psutil 20:46:51 INFO - Cleaning up... 20:46:52 INFO - Return code: 0 20:46:52 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 20:46:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:46:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:46:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:46:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:46:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:46:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:46:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fa4fcca3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28915a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2920410>, '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 0x2921310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29217a0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1460086771.369701-532901744', '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 20:46:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 20:46:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 20:46:52 INFO - Using env: {'DISPLAY': ':0', 20:46:52 INFO - 'HOME': '/home/cltbld', 20:46:52 INFO - 'LANG': 'en_US.UTF-8', 20:46:52 INFO - 'LANGUAGE': 'en_US:en', 20:46:52 INFO - 'LOGNAME': 'cltbld', 20:46:52 INFO - 'MAIL': '/var/mail/cltbld', 20:46:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:46:52 INFO - 'MOZ_NO_REMOTE': '1', 20:46:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:46:52 INFO - 'NO_EM_RESTART': '1', 20:46:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:46:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:46:52 INFO - 'PWD': '/builds/slave/test', 20:46:52 INFO - 'SHELL': '/bin/bash', 20:46:52 INFO - 'SHLVL': '1', 20:46:52 INFO - 'TERM': 'linux', 20:46:52 INFO - 'TMOUT': '86400', 20:46:52 INFO - 'USER': 'cltbld', 20:46:52 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1460086771.369701-532901744', 20:46:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:46:52 INFO - '_': '/tools/buildbot/bin/python'} 20:46:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:46:52 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 20:46:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:46:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:46:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:46:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:46:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:46:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:46:54 INFO - Downloading mozsystemmonitor-0.0.tar.gz 20:46:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:46:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 20:46:54 INFO - Installing collected packages: mozsystemmonitor 20:46:54 INFO - Running setup.py install for mozsystemmonitor 20:46:54 INFO - Successfully installed mozsystemmonitor 20:46:54 INFO - Cleaning up... 20:46:54 INFO - Return code: 0 20:46:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:46:54 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')]} 20:46:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:46:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:46:54 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')]} 20:46:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:46:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:46:54 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 0x7fa4fcca3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28915a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2920410>, '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 0x2921310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29217a0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1460086771.369701-532901744', '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 20:46:54 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 20:46:54 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 20:46:54 INFO - Using env: {'DISPLAY': ':0', 20:46:54 INFO - 'HOME': '/home/cltbld', 20:46:54 INFO - 'LANG': 'en_US.UTF-8', 20:46:54 INFO - 'LANGUAGE': 'en_US:en', 20:46:54 INFO - 'LOGNAME': 'cltbld', 20:46:54 INFO - 'MAIL': '/var/mail/cltbld', 20:46:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:46:54 INFO - 'MOZ_NO_REMOTE': '1', 20:46:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:46:54 INFO - 'NO_EM_RESTART': '1', 20:46:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:46:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:46:54 INFO - 'PWD': '/builds/slave/test', 20:46:54 INFO - 'SHELL': '/bin/bash', 20:46:54 INFO - 'SHLVL': '1', 20:46:54 INFO - 'TERM': 'linux', 20:46:54 INFO - 'TMOUT': '86400', 20:46:54 INFO - 'USER': 'cltbld', 20:46:54 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1460086771.369701-532901744', 20:46:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:46:54 INFO - '_': '/tools/buildbot/bin/python'} 20:46:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:46:55 INFO - Downloading/unpacking blobuploader==1.2.4 20:46:55 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 20:46:55 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 20:46:55 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 20:46:55 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 20:46:55 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 20:46:55 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 20:46:57 INFO - Downloading blobuploader-1.2.4.tar.gz 20:46:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:46:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:46:57 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 20:46:57 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 20:46:57 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 20:46:57 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 20:46:57 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 20:46:57 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 20:46:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:46:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:46: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 20:46: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 20:46: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 20:46: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 20:46: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 20:46: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 20:46:58 INFO - Downloading docopt-0.6.1.tar.gz 20:46:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:46:58 INFO - Installing collected packages: blobuploader, requests, docopt 20:46:58 INFO - Running setup.py install for blobuploader 20:46:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:46:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:46:58 INFO - Running setup.py install for requests 20:46:58 INFO - Running setup.py install for docopt 20:46:58 INFO - Successfully installed blobuploader requests docopt 20:46:58 INFO - Cleaning up... 20:46:59 INFO - Return code: 0 20:46:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:46:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:46:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:46:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:46:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:46:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:46:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:46:59 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 0x7fa4fcca3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28915a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2920410>, '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 0x2921310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29217a0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1460086771.369701-532901744', '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 20:46:59 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 20:46:59 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 20:46:59 INFO - Using env: {'DISPLAY': ':0', 20:46:59 INFO - 'HOME': '/home/cltbld', 20:46:59 INFO - 'LANG': 'en_US.UTF-8', 20:46:59 INFO - 'LANGUAGE': 'en_US:en', 20:46:59 INFO - 'LOGNAME': 'cltbld', 20:46:59 INFO - 'MAIL': '/var/mail/cltbld', 20:46:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:46:59 INFO - 'MOZ_NO_REMOTE': '1', 20:46:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:46:59 INFO - 'NO_EM_RESTART': '1', 20:46:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:46:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:46:59 INFO - 'PWD': '/builds/slave/test', 20:46:59 INFO - 'SHELL': '/bin/bash', 20:46:59 INFO - 'SHLVL': '1', 20:46:59 INFO - 'TERM': 'linux', 20:46:59 INFO - 'TMOUT': '86400', 20:46:59 INFO - 'USER': 'cltbld', 20:46:59 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1460086771.369701-532901744', 20:46:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:46:59 INFO - '_': '/tools/buildbot/bin/python'} 20:46:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:46:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:46:59 INFO - Running setup.py (path:/tmp/pip-2sGzHi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:46:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:46:59 INFO - Running setup.py (path:/tmp/pip-JKWmjo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:46:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:46:59 INFO - Running setup.py (path:/tmp/pip-7SyGLN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:46:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:46:59 INFO - Running setup.py (path:/tmp/pip-iOq7dU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:46:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:46:59 INFO - Running setup.py (path:/tmp/pip-ZLUz4f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:46:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:46:59 INFO - Running setup.py (path:/tmp/pip-OuLK9t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:46:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:46:59 INFO - Running setup.py (path:/tmp/pip-PyHg26-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:47:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:47:00 INFO - Running setup.py (path:/tmp/pip-Vpgr5w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:47:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:47:00 INFO - Running setup.py (path:/tmp/pip-JTwQAB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:47:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:47:00 INFO - Running setup.py (path:/tmp/pip-CGzztX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:47:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:47:00 INFO - Running setup.py (path:/tmp/pip-0MzaRo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:47:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:47:00 INFO - Running setup.py (path:/tmp/pip-sd3bNi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:47:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:47:00 INFO - Running setup.py (path:/tmp/pip-BrVjcP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:47:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:47:00 INFO - Running setup.py (path:/tmp/pip-yNZxqb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:47:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:47:00 INFO - Running setup.py (path:/tmp/pip-uzk3jU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:47:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:47:00 INFO - Running setup.py (path:/tmp/pip-MfiEaK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:47:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:47:00 INFO - Running setup.py (path:/tmp/pip-ZfU5Xl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:47:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:47:00 INFO - Running setup.py install for manifestparser 20:47:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:47:00 INFO - Running setup.py install for mozcrash 20:47:00 INFO - Running setup.py install for mozdebug 20:47:01 INFO - Running setup.py install for mozdevice 20:47:01 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:47:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:47:01 INFO - Running setup.py install for mozfile 20:47:01 INFO - Running setup.py install for mozhttpd 20:47:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:47:01 INFO - Running setup.py install for mozinfo 20:47:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:47:01 INFO - Running setup.py install for mozInstall 20:47:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:47:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:47:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:47:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:47:01 INFO - Running setup.py install for mozleak 20:47:01 INFO - Running setup.py install for mozlog 20:47:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:47:01 INFO - Running setup.py install for moznetwork 20:47:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:47:01 INFO - Running setup.py install for mozprocess 20:47:01 INFO - Running setup.py install for mozprofile 20:47:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:47:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:47:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:47:02 INFO - Running setup.py install for mozrunner 20:47:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:47:02 INFO - Running setup.py install for mozscreenshot 20:47:02 INFO - Running setup.py install for moztest 20:47:02 INFO - Running setup.py install for mozversion 20:47:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:47:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:47:02 INFO - Cleaning up... 20:47:02 INFO - Return code: 0 20:47:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:47: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')]} 20:47:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:47:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:47: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')]} 20:47:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:47:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:47:02 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 0x7fa4fcca3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28915a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2920410>, '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 0x2921310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29217a0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1460086771.369701-532901744', '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 20:47:02 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 20:47:02 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 20:47:02 INFO - Using env: {'DISPLAY': ':0', 20:47:02 INFO - 'HOME': '/home/cltbld', 20:47:02 INFO - 'LANG': 'en_US.UTF-8', 20:47:02 INFO - 'LANGUAGE': 'en_US:en', 20:47:02 INFO - 'LOGNAME': 'cltbld', 20:47:02 INFO - 'MAIL': '/var/mail/cltbld', 20:47:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:47:02 INFO - 'MOZ_NO_REMOTE': '1', 20:47:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:47:02 INFO - 'NO_EM_RESTART': '1', 20:47:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:47:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:47:02 INFO - 'PWD': '/builds/slave/test', 20:47:02 INFO - 'SHELL': '/bin/bash', 20:47:02 INFO - 'SHLVL': '1', 20:47:02 INFO - 'TERM': 'linux', 20:47:02 INFO - 'TMOUT': '86400', 20:47:02 INFO - 'USER': 'cltbld', 20:47:02 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1460086771.369701-532901744', 20:47:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:47:02 INFO - '_': '/tools/buildbot/bin/python'} 20:47:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:47:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:47:02 INFO - Running setup.py (path:/tmp/pip-QyU6Wl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:47:02 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)) 20:47:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:47:02 INFO - Running setup.py (path:/tmp/pip-uyJcIY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:47:02 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)) 20:47:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:47:02 INFO - Running setup.py (path:/tmp/pip-SgyyUM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:47:02 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)) 20:47:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:47:02 INFO - Running setup.py (path:/tmp/pip-Lhbkti-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:47:03 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)) 20:47:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:47:03 INFO - Running setup.py (path:/tmp/pip-boMrg4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:47:03 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)) 20:47:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:47:03 INFO - Running setup.py (path:/tmp/pip-IvWVEP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:47:03 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)) 20:47:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:47:03 INFO - Running setup.py (path:/tmp/pip-VxQi27-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:47:03 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)) 20:47:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:47:03 INFO - Running setup.py (path:/tmp/pip-fF_Bq8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:47:03 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)) 20:47:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:47:03 INFO - Running setup.py (path:/tmp/pip-HT2dYu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:47:03 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)) 20:47:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:47:03 INFO - Running setup.py (path:/tmp/pip-RWuf4l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:47:03 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)) 20:47:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:47:03 INFO - Running setup.py (path:/tmp/pip-427HqY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:47:03 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)) 20:47:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:47:03 INFO - Running setup.py (path:/tmp/pip-hAHWS0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:47:03 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)) 20:47:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:47:03 INFO - Running setup.py (path:/tmp/pip-8Tngah-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:47:03 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)) 20:47:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:47:03 INFO - Running setup.py (path:/tmp/pip-o5ZnHY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:47:03 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)) 20:47:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:47:03 INFO - Running setup.py (path:/tmp/pip-4ADltr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:47:03 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)) 20:47:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:47:03 INFO - Running setup.py (path:/tmp/pip-LCfUwV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:47:03 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)) 20:47:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:47:03 INFO - Running setup.py (path:/tmp/pip-xM2wpr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:47:03 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)) 20:47:03 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)) 20:47:03 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)) 20:47:03 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)) 20:47:03 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)) 20:47:03 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)) 20:47:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:47:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:47:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:47:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:47:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:47:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:47:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:47:07 INFO - Downloading blessings-1.6.tar.gz 20:47:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:47:07 INFO - Installing collected packages: blessings 20:47:07 INFO - Running setup.py install for blessings 20:47:07 INFO - Successfully installed blessings 20:47:07 INFO - Cleaning up... 20:47:07 INFO - Return code: 0 20:47:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:47:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:47:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:47:07 INFO - Reading from file tmpfile_stdout 20:47:07 INFO - Current package versions: 20:47:07 INFO - argparse == 1.2.1 20:47:07 INFO - blessings == 1.6 20:47:07 INFO - blobuploader == 1.2.4 20:47:07 INFO - docopt == 0.6.1 20:47:07 INFO - manifestparser == 1.1 20:47:07 INFO - mozInstall == 1.12 20:47:07 INFO - mozcrash == 0.17 20:47:07 INFO - mozdebug == 0.1 20:47:07 INFO - mozdevice == 0.48 20:47:07 INFO - mozfile == 1.2 20:47:07 INFO - mozhttpd == 0.7 20:47:07 INFO - mozinfo == 0.9 20:47:07 INFO - mozleak == 0.1 20:47:07 INFO - mozlog == 3.1 20:47:07 INFO - moznetwork == 0.27 20:47:07 INFO - mozprocess == 0.22 20:47:07 INFO - mozprofile == 0.28 20:47:07 INFO - mozrunner == 6.11 20:47:07 INFO - mozscreenshot == 0.1 20:47:07 INFO - mozsystemmonitor == 0.0 20:47:07 INFO - moztest == 0.7 20:47:07 INFO - mozversion == 1.4 20:47:07 INFO - psutil == 3.1.1 20:47:07 INFO - requests == 1.2.3 20:47:07 INFO - wsgiref == 0.1.2 20:47:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:47:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:47:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:47:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:47:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:47:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:47:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:47:07 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 0x7fa4fcca3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28915a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2920410>, '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 0x2921310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29217a0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1460086771.369701-532901744', '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 20:47:07 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 20:47:07 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 20:47:07 INFO - Using env: {'DISPLAY': ':0', 20:47:07 INFO - 'HOME': '/home/cltbld', 20:47:07 INFO - 'LANG': 'en_US.UTF-8', 20:47:07 INFO - 'LANGUAGE': 'en_US:en', 20:47:07 INFO - 'LOGNAME': 'cltbld', 20:47:07 INFO - 'MAIL': '/var/mail/cltbld', 20:47:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:47:07 INFO - 'MOZ_NO_REMOTE': '1', 20:47:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:47:07 INFO - 'NO_EM_RESTART': '1', 20:47:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:47:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:47:07 INFO - 'PWD': '/builds/slave/test', 20:47:07 INFO - 'SHELL': '/bin/bash', 20:47:07 INFO - 'SHLVL': '1', 20:47:07 INFO - 'TERM': 'linux', 20:47:07 INFO - 'TMOUT': '86400', 20:47:07 INFO - 'USER': 'cltbld', 20:47:07 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1460086771.369701-532901744', 20:47:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:47:07 INFO - '_': '/tools/buildbot/bin/python'} 20:47:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:47:07 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)) 20:47:07 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)) 20:47:07 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)) 20:47:07 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)) 20:47:07 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)) 20:47:07 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)) 20:47:07 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)) 20:47:07 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)) 20:47:07 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)) 20:47:07 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)) 20:47:07 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)) 20:47:07 INFO - Cleaning up... 20:47:07 INFO - Return code: 0 20:47:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:47:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:47:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:47:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:47:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:47:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:47:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:47:07 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 0x7fa4fcca3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28915a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2920410>, '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 0x2921310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29217a0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1460086771.369701-532901744', '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 20:47:07 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 20:47:07 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 20:47:07 INFO - Using env: {'DISPLAY': ':0', 20:47:07 INFO - 'HOME': '/home/cltbld', 20:47:07 INFO - 'LANG': 'en_US.UTF-8', 20:47:07 INFO - 'LANGUAGE': 'en_US:en', 20:47:07 INFO - 'LOGNAME': 'cltbld', 20:47:07 INFO - 'MAIL': '/var/mail/cltbld', 20:47:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:47:07 INFO - 'MOZ_NO_REMOTE': '1', 20:47:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:47:07 INFO - 'NO_EM_RESTART': '1', 20:47:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:47:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:47:07 INFO - 'PWD': '/builds/slave/test', 20:47:07 INFO - 'SHELL': '/bin/bash', 20:47:07 INFO - 'SHLVL': '1', 20:47:07 INFO - 'TERM': 'linux', 20:47:07 INFO - 'TMOUT': '86400', 20:47:07 INFO - 'USER': 'cltbld', 20:47:07 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1460086771.369701-532901744', 20:47:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:47:07 INFO - '_': '/tools/buildbot/bin/python'} 20:47:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:47:07 INFO - Downloading/unpacking jsonschema 20:47: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 20:47: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 20:47: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 20:47: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 20:47: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 20:47: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 20:47:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:47:11 INFO - Downloading/unpacking functools32 (from jsonschema) 20:47: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 20:47: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 20:47: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 20:47: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 20:47: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 20:47: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 20:47:11 INFO - Downloading functools32-3.2.3-2.tar.gz 20:47:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:47:11 INFO - warning: no files found matching '*.txt' 20:47:11 INFO - no previously-included directories found matching 'build' 20:47:11 INFO - no previously-included directories found matching 'dist' 20:47:11 INFO - no previously-included directories found matching '.git*' 20:47:11 INFO - Installing collected packages: jsonschema, functools32 20:47:11 INFO - Running setup.py install for functools32 20:47:11 INFO - warning: no files found matching '*.txt' 20:47:11 INFO - no previously-included directories found matching 'build' 20:47:11 INFO - no previously-included directories found matching 'dist' 20:47:11 INFO - no previously-included directories found matching '.git*' 20:47:11 INFO - Successfully installed jsonschema functools32 20:47:11 INFO - Cleaning up... 20:47:12 INFO - Return code: 0 20:47:12 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 20:47: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')]} 20:47:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:47:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:47: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')]} 20:47:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:47:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:47: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 0x7fa4fcca3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28915a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2920410>, '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 0x2921310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29217a0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1460086771.369701-532901744', '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 20:47: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 20:47: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 20:47:12 INFO - Using env: {'DISPLAY': ':0', 20:47:12 INFO - 'HOME': '/home/cltbld', 20:47:12 INFO - 'LANG': 'en_US.UTF-8', 20:47:12 INFO - 'LANGUAGE': 'en_US:en', 20:47:12 INFO - 'LOGNAME': 'cltbld', 20:47:12 INFO - 'MAIL': '/var/mail/cltbld', 20:47:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:47:12 INFO - 'MOZ_NO_REMOTE': '1', 20:47:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:47:12 INFO - 'NO_EM_RESTART': '1', 20:47:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:47:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:47:12 INFO - 'PWD': '/builds/slave/test', 20:47:12 INFO - 'SHELL': '/bin/bash', 20:47:12 INFO - 'SHLVL': '1', 20:47:12 INFO - 'TERM': 'linux', 20:47:12 INFO - 'TMOUT': '86400', 20:47:12 INFO - 'USER': 'cltbld', 20:47:12 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1460086771.369701-532901744', 20:47:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:47:12 INFO - '_': '/tools/buildbot/bin/python'} 20:47:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:47:12 INFO - Downloading/unpacking flake8 20:47: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 20:47: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 20:47: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 20:47: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 20:47: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 20:47: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 20:47:15 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 20:47:15 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 20:47:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:47:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:47:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:47:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:47:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:47:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:47:15 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 20:47:15 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 20:47:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:47:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:47:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:47:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:47:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:47:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:47:15 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 20:47:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:47:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:47:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:47:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:47:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:47:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:47:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 20:47:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:47:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:47:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:47:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:47:16 INFO - no previously-included directories found matching 'docs/_build' 20:47:16 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 20:47:16 INFO - Running setup.py install for pep8 20:47:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:47:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:47:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:47:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:47:16 INFO - no previously-included directories found matching 'docs/_build' 20:47:16 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 20:47:16 INFO - Successfully installed flake8 mccabe pyflakes pep8 20:47:16 INFO - Cleaning up... 20:47:16 INFO - Return code: 0 20:47:16 INFO - Running post-action listener: _resource_record_post_action 20:47:16 INFO - Running post-action listener: _start_resource_monitoring 20:47:16 INFO - Starting resource monitoring. 20:47:16 INFO - ##### 20:47:16 INFO - ##### Running install step. 20:47:16 INFO - ##### 20:47:16 INFO - Running pre-action listener: _resource_record_pre_action 20:47:16 INFO - Running main action method: install 20:47:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:47:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:47:16 INFO - Reading from file tmpfile_stdout 20:47:16 INFO - Detecting whether we're running mozinstall >=1.0... 20:47:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:47:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:47:16 INFO - Reading from file tmpfile_stdout 20:47:16 INFO - Output received: 20:47:16 INFO - Usage: mozinstall [options] installer 20:47:16 INFO - Options: 20:47:16 INFO - -h, --help show this help message and exit 20:47:16 INFO - -d DEST, --destination=DEST 20:47:16 INFO - Directory to install application into. [default: 20:47:16 INFO - "/builds/slave/test"] 20:47:16 INFO - --app=APP Application being installed. [default: firefox] 20:47:16 INFO - mkdir: /builds/slave/test/build/application 20:47:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 20:47:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 20:47:32 INFO - Reading from file tmpfile_stdout 20:47:32 INFO - Output received: 20:47:32 INFO - /builds/slave/test/build/application/firefox/firefox 20:47:32 INFO - Running post-action listener: _resource_record_post_action 20:47:32 INFO - ##### 20:47:32 INFO - ##### Running run-tests step. 20:47:32 INFO - ##### 20:47:32 INFO - Running pre-action listener: _resource_record_pre_action 20:47:32 INFO - Running main action method: run_tests 20:47:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:47:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:47:32 INFO - Python 2.7.3 20:47:32 INFO - Return code: 0 20:47:32 INFO - grabbing minidump binary from tooltool 20:47:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:47:32 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 0x2920410>, '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 0x2921310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29217a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:47:32 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 20:47:32 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 20:47:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:47:32 INFO - Return code: 0 20:47:32 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:47:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:47:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:47:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:47:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:47:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 20:47:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 20:47:33 INFO - Return code: 0 20:47:33 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/F9p3J0xnTNmJoBYMObrXAQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--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 20:47:33 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/F9p3J0xnTNmJoBYMObrXAQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-013 --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 20:47:33 INFO - Using env: {'DISPLAY': ':0', 20:47:33 INFO - 'HOME': '/home/cltbld', 20:47:33 INFO - 'LANG': 'en_US.UTF-8', 20:47:33 INFO - 'LANGUAGE': 'en_US:en', 20:47:33 INFO - 'LOGNAME': 'cltbld', 20:47:33 INFO - 'MAIL': '/var/mail/cltbld', 20:47:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:47:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:47:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:47:33 INFO - 'MOZ_NO_REMOTE': '1', 20:47:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:47:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:47:33 INFO - 'NO_EM_RESTART': '1', 20:47:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:47:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:47:33 INFO - 'PWD': '/builds/slave/test', 20:47:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:47:33 INFO - 'SHELL': '/bin/bash', 20:47:33 INFO - 'SHLVL': '1', 20:47:33 INFO - 'TERM': 'linux', 20:47:33 INFO - 'TMOUT': '86400', 20:47:33 INFO - 'USER': 'cltbld', 20:47:33 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1460086771.369701-532901744', 20:47:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:47:33 INFO - '_': '/tools/buildbot/bin/python'} 20:47:33 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/F9p3J0xnTNmJoBYMObrXAQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--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 20:47:33 INFO - mozversion application_buildid: 20160407194941 20:47:33 INFO - mozversion application_changeset: 8a47b4f44a5a7899b13ab7aeb5b8ac4489ea81d8 20:47:33 INFO - mozversion application_display_name: Nightly 20:47:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:47:33 INFO - mozversion application_name: Firefox 20:47:33 INFO - mozversion application_remotingname: firefox 20:47:33 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 20:47:33 INFO - mozversion application_vendor: Mozilla 20:47:33 INFO - mozversion application_version: 48.0a1 20:47:33 INFO - mozversion platform_buildid: 20160407194941 20:47:33 INFO - mozversion platform_changeset: 8a47b4f44a5a7899b13ab7aeb5b8ac4489ea81d8 20:47:33 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 20:47:33 INFO - mozversion platform_version: 48.0a1 20:47:33 INFO - using testdate: 1460087253 20:47:33 INFO - actual date: 1460087253 20:47:33 INFO - starting webserver on 'localhost:39278' 20:47:33 INFO - SUITE-START | Running 2 tests 20:47:33 INFO - TEST-START | dromaeo_css 20:47:33 INFO - operating with platform_type : linux_ 20:47:33 INFO - Initialising browser for dromaeo_css test... 20:47:33 INFO - TEST-INFO | started process 12223 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNXVvNt/profile http://localhost:39278/getInfo.html) 20:47:37 INFO - PROCESS | 12223 | 20:47:37 INFO - PROCESS | 12223 | (process:12289): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 20:47:37 INFO - PROCESS | 12223 | JavaScript error: jar:file:///builds/slave/test/build/application/firefox/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 20:47:38 INFO - PROCESS | 12223 | __metrics Screen width/height:1600/1200 20:47:38 INFO - PROCESS | 12223 | colorDepth:24 20:47:38 INFO - PROCESS | 12223 | Browser inner width/height: 1024/697 20:47:38 INFO - PROCESS | 12223 | __metrics 20:47:39 ERROR - PROCESS | 12223 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2881: TypeError: this.tabs is undefined 20:47:40 INFO - TEST-INFO | 12223: exit 0 20:47:40 INFO - Browser initialized. 20:47:40 INFO - Running cycle 1/1 for dromaeo_css test... 20:47:40 INFO - TEST-INFO | started process 12340 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNXVvNt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:47:42 INFO - PROCESS | 12340 | 20:47:42 INFO - PROCESS | 12340 | (process:12399): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 20:47:52 INFO - PROCESS | 12340 | RSS: Main: 163913728 20:47:52 INFO - PROCESS | 12340 | 20:48:41 INFO - PROCESS | 12340 | 1460087321919 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] 20:50:53 INFO - PROCESS | 12340 | Cycle 1(1): loaded http://localhost:39278/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39278/tests/dromaeo/cssquery-ext.html) 20:50:54 INFO - PROCESS | 12340 | RSS: Main: 166998016 20:50:54 INFO - PROCESS | 12340 | 20:53:56 INFO - PROCESS | 12340 | Cycle 1(1): loaded http://localhost:39278/tests/dromaeo/cssquery-ext.html (next: http://localhost:39278/tests/dromaeo/cssquery-jquery.html) 20:53:57 INFO - PROCESS | 12340 | RSS: Main: 164888576 20:53:57 INFO - PROCESS | 12340 | 20:56:59 INFO - PROCESS | 12340 | Cycle 1(1): loaded http://localhost:39278/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39278/tests/dromaeo/cssquery-mootools.html) 20:56:59 INFO - PROCESS | 12340 | RSS: Main: 165748736 20:56:59 INFO - PROCESS | 12340 | 21:00:01 INFO - PROCESS | 12340 | Cycle 1(1): loaded http://localhost:39278/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39278/tests/dromaeo/cssquery-prototype.html) 21:00:02 INFO - PROCESS | 12340 | RSS: Main: 164118528 21:00:02 INFO - PROCESS | 12340 | 21:03:04 INFO - PROCESS | 12340 | Cycle 1(1): loaded http://localhost:39278/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39278/tests/dromaeo/cssquery-yui.html) 21:03:05 INFO - PROCESS | 12340 | RSS: Main: 164454400 21:03:05 INFO - PROCESS | 12340 | 21:06:07 INFO - PROCESS | 12340 | Cycle 1(1): loaded http://localhost:39278/tests/dromaeo/cssquery-yui.html (next: http://localhost:39278/tests/dromaeo/cssquery-dojo.html) 21:06:08 INFO - PROCESS | 12340 | RSS: Main: 166805504 21:06:08 INFO - PROCESS | 12340 | 21:06:08 INFO - PROCESS | 12340 | __start_tp_report 21:06:08 INFO - PROCESS | 12340 | _x_x_mozilla_page_load 21:06:08 INFO - PROCESS | 12340 | _x_x_mozilla_page_load_details 21:06:08 INFO - PROCESS | 12340 | |i|pagename|runs| 21:06:08 INFO - PROCESS | 12340 | |0;dojo.html;2609.9478010439793;2672.933176670583;2694.838309701418;2696.501147287753;2699.541078016738;4569.862904112873;4660;4689.5310468953085;4692.741899195543;4694.108119457301;4591.862244132673;4760.214564596846;4811.8797030074265;4826.806927722896;4848.296996935443;4361.694681372297;4379.956200437987;4425.601695847373;4431.556844315575;4463.732176069446;4448.7108337957925;4463.553644635543;4490.797914093857;4499.640028797705;4552.590266875981;4192.496900371944;4322.50291216511;4341.218580655465;4411.27214009688;4449.110177964388;4349.608535231812;4361.302191649353;4361.4112094867105;4365.9126817463475;4402.84590039347;4315.374270730757;4351;4353.10761293934;4385.912281754347;4394.538573449774;4541.386912766768;4632.698874573142;4711.646626502992;4742.407199100113;4756.07256584966;4983.053219888209;5006.4492905780335;5009.974950125263;5010.123228435009;5038.168702164138;4957.380327459067;5031.471695471996;5054.570361519275;5059.645824792229;5083.847484575469;4694.413198350207;4809.254565542346;4815.012922350979;4820.276958456225;4865.197242454955;5210.947890521122;5214.895702085937;5235.554977826928;5254.15933450646;5267.657602255841;4875.414950205927;4981.078500477351;5026.949730502722;5034.622403319766;5039.092963266574;4866.780994855169;5107.693538387634;5113.590912726973;5203.375594928632;5224.738763061831;5070.923936140961;5075.39095308558;5081.618878584121;5085.160948443539;5119.718415487184;4948.8762780930765;5046.924296135561;5083.186690129562;5088.643794934393;5122.385313762373;4340.088581397942;4391.934120988188;4402.8679139625865;4417.801198946056;4436.489803672554;3803.8858834235016;3808.809559522013;3810.2189051244427;3834.6357096075826;3852.730308878408;4291.785410729451;4403.559644035635;4411.977940110343;4416.205083085076;4488.236999709992;5148.330717006766;5156.04613146569;5160.819371322061;5170.741462926839;5206.245094461357;4405.229084910128;4453.032104637349;4457.77711114443;4462.486814016364;4512.0750246200105;4462.286034234507;4626.190416677068;4702.600278976257;4720.622350211975;4736.100140973204;4822.493638167942;4845.8061677532505;4873;4892.951070489321;4924.63065270099;5130.358705161855;5144.768485418091;5152.3044389007;5156.4327923927585;5158.071547121554;4674.0651869625535;4754.358161648272;4846.5153484651255;4849.248366503198;4905.632077594123;4985.775640096132;4995.200767877122;5007.173816320266;5013.874653133701;5066.189409694432;5089.287499750112;5099.464556221544;5099.87250318745;5105.183170692671;5110.233464980282;4785.569298763128;4818.975905120452;4901.803927842846;4977.552020318189;4980;4948.554630083309;4993.525615066563;5009.0983622948215;5014.9498505015945;5056.0140772549;4854.538818812207;4855.101806165871;4866.318715379779;4874.658773885794;4914.778834952364;4867.1969125093965;4954.083494553375;4978.975105124451;5025.497450254945;5054.671446355975;4862.7325497098;4862.756862156949;4875.146849301429;4885.267209918541;4921.26181072842 21:06:08 INFO - PROCESS | 12340 | |1;ext.html;572.1646396261458;591.4085914085914;620.9379062093791;626.6929204689702;628.5223230344936;31807.84096079519;32555.837220813923;32749.83625081877;32846.34307313852;32880.67119328806;34180.65819341806;34329.31341373171;34597.30805383897;34841.47737783935;35076.82461587695;7455.776326710207;7577.469577129603;7579.696812127509;7623.047119110111;7633.427492938024;7504.174540800507;7628.694852205905;7685.884711729301;7692.192319806423;7696.307332340089;7677.193894641066;7746.651400686955;7759.262870027338;7775;7795.5712435816;7690.884636730453;7712.884306735404;7737.8452430951065;7775.261350171753;7782.610869456533;7592.544447333123;7714.421418393643;7731.806704832368;7735.1491335953;7735.4585179037485;29235;33868.153296167795;34386.82806585951;34412.82793586041;34425.13937151566;2838.6451693538306;2891.956620650692;2968.124403301031;2982.6719060903283;3052.6794686557814;27016.324591885164;27394.863025684743;27545.44909101807;27754.75103620342;27822.721772782217;3416.145963509123;3447.413939630269;3568.839402226906;3586.5158203642695;3640.6359364063646;236866;243905;244490;244654;245949;49620;49647.751761240965;49709;49716.502834971914;49739.25391119136;60733;60942.69528652328;62203.68898155571;62581.06128408077;62628.68685656634;15609.297581608855;15638.139902305255;15753.68492630141;15805;15839.841601583837;11986.400679966142;12094.818577721342;12097;12131.150819442732;12194.207376520499;19488.220471181277;19800.70298945517;19823.207071717257;19890.70163947542;19908.303209387603;7640.503367281109;7685.961570192113;7686.846263074707;7723.691052357955;7897.921020789833;816.1797393619374;865.372604861483;985.0445068283753;991.5587563534302;994.7761753605381;27487.725122748918;28193.43613127726;28526.714732852404;28871.566926496118;28922.566161507595;990.3810118675827;991.4348821172007;1003.4581326083833;1014.7767491151935;1019.3781793106199;14680.632984175481;15090.54728358151;15231.695366092616;15301.15843628611;15350.846491534941;351220;351501;354720;355000;355994;48376.5162348379;49047.264291035666;49226;49288.50711492911;49578.50421495811;1239.0645062977574;1264.27304300026;1270.399296885912;1276.814861845046;1282.435728279554;26284.868575656998;27772.583411248444;27945.580816287365;28294.858525708063;28466;42397.78801105975;42868.14263714646;43184.35223471713;43195.78402107969;43214.78392608017;307827;308827;309070;310066;310271;24537.14120005791;24993.12524061649;25136.74863251344;25277.87361063183;25477.872610636827;41755.7912210437;42198.57801421946;42231.577684222764;42381;42989.78505107454;35405;35740.64259357373;35924.46113308355;36663.63336366602;36687.816560917025;34832.47751283783;35585.82207088948;35867.08832480324;35877;35894.28211435705;31165.68834311628;35412;35799;35889;35944.820275898455;28373;28819.279518012216;29036.56445153282;29085.127446176648;29219;22676.433089172904;24262.878685606458;24359.23580818618;24376.390590235387;24788.25635230946 21:06:08 INFO - PROCESS | 12340 | |2;jquery.html;364.6280793590538;369.43476480984094;372.6720485972344;377.0893292698134;383.9750416222943;15752;15831.44589939351;16329.673406531861;16348.83651163491;16379;15322.846771532282;16559.83440165598;17246.137693115357;17318.047507387088;17318.307267709308;5194.714290714019;5337.786488540453;5362.168863826113;5366.812161574346;5368.275282836826;3690.741648084622;5227.712475813829;5751.194832723422;6117.69411529424;6122.0816877468515;6052.031674932012;6075.696215189245;6076.817695469143;6099.634021958696;6115.816525504242;4908.337374454439;5189.299444574972;5230.686158830464;5236.188390799432;5255;4953.306537084811;5053.4946505349535;5183.922241166386;5359.785608575652;5362.624616276862;10974.670759877217;11143.554257829677;11454.140939429577;11479.942600286946;11549;1846.22458567402;1885.886846789197;1890.7825600056033;1912.7322174895526;1968.9606207875763;8334.749957501284;8440.493570385735;8479.448835825651;8777.253933415668;8818.206361427438;1628.6986907422165;1681.5459825846954;1683.2088918208422;1734.80049794274;1745.4901510193718;67832;68027;68261.31738682599;69230.30769692289;70173.2982670177;9864.260180486348;9871.60513579463;10036.698899033041;10097.646582369582;10312.535935882903;13549.796753048711;13625.386857591433;13651.180929144282;13678;13736.45054197841;7349.412047036224;7371.3734332582335;7448.73929412468;7518.774436766906;7612.505187162817;6932.688029038604;6966.164060312795;6996.090508233897;7039.648017599202;7139.607321597258;3909.237698648736;3910.9608903911167;4040.3939409088284;4120.21715873983;4192.161567686414;1694.4323651576613;1753.1321995612;1755.1399814091258;1794.5603327184924;1806.096951524238;855.9186877246651;888.8311220868014;915.3089417489753;957.9904200958041;962.129273007929;16446.43758842908;16533.421330253383;16575.751363729552;16982.150892455327;17264;859.5831021954347;880.3089574683843;901.4095767272447;907.3421769217397;918.8514357053683;9089.863652045224;9144.177024067865;9494.667686630935;9508.714738557854;9659.420434773936;384344;390602;393840;397969;398926;73241;75508.24491755122;76163.61918190373;77872.61063694759;78329.60835195788;896.9730908072768;907.7140700679397;914.433051508056;916.2486760856034;937.1471960515762;14248.786268205778;14782.186979716218;14916.7762483565;14925.10449373041;15295.61760955985;31572.36855262928;33578.832105840294;34938.47592286169;35197.64802351944;35318.47022294616;43622.781886090364;44518.777406112764;45499.31751023671;45735.771321143184;45840.312395314766;7084.681189346595;7234.493585448968;7384.523095381052;7404.518706284074;7417.184109748031;9796.853047204155;10917.126629869432;11294.94352528265;11397.430128493708;11762;10198.133158681596;10206.897931020594;10223.795524089624;10319.071283584513;10343.793124137626;9868.703938881845;10012.949935250277;10254.846482238516;10484;10519.94740026295;10132.189424845847;10213.285070045322;10504.842427363443;10546.78906421852;10757.9462102689;7377.3360397564475;7510.549367037996;7540.924590754023;7641.3886889047635;7711.845763084595;7622.123455802654;10015.849762253718;10254.128399086161;10532.104771094237;10757.408342541235 21:06:08 INFO - PROCESS | 12340 | |3;mootools.html;1428.407211007432;1460.591034510337;1587.8729701623863;1788.5439213000682;1801.9549511262207;6833.658317084139;7477.065366829146;7539.4345424093135;7714.3828493720575;7733.883991740128;7622.65698043588;7653.081630204383;7655.196204398541;7713.807154821132;7729.768106956801;2179.226374637005;2212.3805334506283;2222.866628002317;2226.2875879718495;2233.8771367574777;2128.4146859613575;2149.591577600259;2154.493693981913;2157.9784202157934;2176.3688530326185;2150.4623844038993;2182.0617134632103;2193.254293540196;2206.702095217141;2264.3659775262954;2201.7798220177933;2202.3723238876923;2213.0483891926465;2214.092222188895;2215.4461384653837;2164.675298705191;2166.729158855143;2170.9579401887027;2187.0923566719794;2193.385851961453;7786.844263114763;7788.805279867992;7806.009467585786;7825.569593672346;7871.881921771178;4487.259602165639;4658.534146585348;4681.180793361148;4698.953010469886;4712.198926182523;2790.204791634395;2831.051597714768;2935.324875278698;2945.749611283022;2971.1086673997715;884.5002573545926;903;910.9954450227773;930.4370855632312;931.9673811416636;10735.248532602722;10749.51627176771;10751.139908807276;10755.139588832875;10781.407022613676;4185.644220241314;4351.434313539283;4357.433533640607;4379;4397.274449715825;7985.960070199728;8020.478668886503;8037.115917249098;8038.919610803934;8056.154103819014;4426.955730442654;4458.799354029076;4469.329600559877;4499.820007199741;4516.796744146522;3680.4663323817895;4207.852725154666;4230.2174097792;4253.2769429197115;4307.806148723315;3438.9656103439147;3478.356504046709;3505.614382417932;3585.282943411276;3604.4593311003036;1077.9083777878811;1110.8555887734703;1113.704868209925;1128.4470609401335;1135.1146106037304;970.9902900971041;973.6154219083422;982.4400091947522;1034.6895931220604;1217.5495066825154;7236.565806051653;7295.89056164158;7350.117985841734;7380.667869945865;7416.295451932057;432.2025862284081;441.41512495943005;441.77690266415897;443.8424359352448;445.22753023504197;5633.0987042073075;5637.408072152447;5816.796412125555;5847.795327163529;5947.1376650385455;9195.264378849675;9642.325037247465;9659.32384733076;9704.369216000938;9766.267529935283;9422;9543.141117299476;9566.378185418065;9772.609095636095;9865.408075515492;7265.673044713;7320.7071717131785;7346.375558077623;7362.8527429451115;7420.554766714123;7145.035420218204;7171.964140179266;7249.565026098451;7255.818604534928;7278.490505664553;8886;8943.955280223818;8949.149830766068;9113.681021164493;9131.178193962309;8976.237019853386;9053.54732263371;9232.769180770534;9235.399699019543;9345.392549484262;5666.631668941505;6065.514758819196;6232.065190221322;6404.359564043559;6457.418832305115;7446.478746487694;7490.288422599844;7491.925080749123;7499.850003000019;7507.549547026977;6556.934430655632;6774.932250677627;6791.185057793096;6832.863342733217;6877.89683154763;6750.594964302158;6771.729130834711;6777.220619628806;6811.386975172259;6814.7955561331255;6737.29258427858;6899.827504312231;6967.09427774386;6982.812921803407;7029.0862187915245;6584.572002819801;6640.966795165993;6654.933450665625;6664.50016248793;6689.096971908924;6685.197776266685;6766.15423072116;6799.3200679931615;6804.285550017177;6809.931900681128 21:06:08 INFO - PROCESS | 12340 | |4;prototype.html;307.79993004547043;312.3082372544813;312.60611629347017;315.6590881847605;317.73945364800863;5207.947920520794;5503.53219976302;5509.146082357241;5510.531604813596;5518.33779946407;5314.229436731672;5390.326209223847;5393.73031348432;5412.431694672062;5414.945850541503;3896.337622604164;3975.403689446577;4107.856225032125;4157.251694694946;4162.271602469556;4091.754494730311;4096.078382363974;4099.713020088595;4100.298376173899;4117.5882411758885;4024.6377825995655;4056.817443215062;4062.2281766464275;4085.9795701021453;4086.2440448516973;3857.4599556061894;4080.8775736727944;4095.795210239491;4099.241640296525;4102.343625019982;3569.94645080324;3580.534530511043;3583.498310236569;3586.1214002569536;3592.1019745063736;5098;5103.872403189913;5103.923441148386;5106.66806657566;5128.538431541179;4737.905241895142;4740.2889566564945;4743.956329607516;4750.45369782476;4754.334393184957;5432.864178395572;5582.720863956786;5587.664740115565;5618.381977982419;5624.128260119688;3890.513685789276;3891.571927088018;3895.844166233347;3925;3933.134710363744;5806.680632565207;5890.941090589082;5935.554833387513;5948.524118070544;5956.344802071769;3943.8422463101156;4024.8188831502653;4026.4966879140106;4032.959670403317;4040.8585699500377;4067.9796601016806;4072.6945479089186;4089.0985691653523;4092.5498195198506;4104.979475102606;4692.366530518405;4697.436307643105;4714.834980775725;4725.5510726480925;4742.5020372861045;5544.889102217933;5650.886982260332;5665.830025099253;5668.234788303609;5688.488036076773;1390.7844284135974;1418.7871819227198;1424.0814674534868;1425.2161311278755;1426.108682073704;919.0579655852804;936.498973049429;936.6768464879606;948.8434408322687;949.534727983297;4716.976415117971;4768.713877167381;4905.117078925757;4927.162382395001;4983.202687569971;5866;5871.530277577784;5873.412658734178;5888.998870191992;5905.350411454737;4863.8540843774745;4901.3383193269165;4938.308636790852;4939.753012349368;4950.628702847301;3107.860146293422;3131.968680313213;3139.309351942569;3142.711488289836;3159;5497.47773961473;5520.696361700145;5523.033469142964;5553.416891226444;5563;5733.31200255972;5942.37605051472;5977;5986.360570557853;6014.909776353271;5465.098258787335;5478.91781623276;5480.123180291134;5514.759179184732;5550.111982082847;5688.95197728809;5841.474267315962;5842.444967728059;5848.70120461452;5881.529477641864;5682.204491371294;5727.284089488814;5791.218185544897;5793.246877905845;5798.82603521895;5511.9527289814805;5513.5037846594;5514.2004409359615;5529.364123125892;5529.861753456195;3796.6393192646656;4020.9597904020584;4026.315526360467;4027.617376349242;4043.5147782266317;5780.624259423124;5807.796727114531;5824.912626310524;5837.737301821343;5850.824475265749;5600.215969764155;5636.943630563642;5648.971755141198;5666.660000399989;5668.716564171693;5480.506754392124;5548.77926856091;5601.767611125546;5646.576506761927;5677;5494.587905907153;5508.366537848199;5534.391216966211;5554.222408862682;5565.415631358811;5385.596080293915;5580;5741.598088133791;5749.942500575108;5753.252077229933;5585.720713964204;5591.664500130005;5593.105103183471;5596.048671725735;5598.216249725123 21:06:08 INFO - PROCESS | 12340 | |5;yui.html;748.6406524868064;754.2344520311883;768.1320108277646;768.7539987204093;772.1159272632832;11996.640100796969;12265.202761820476;13723.107997980123;14490.927545362258;14492.565223043326;14423.855761442383;14544.272786360692;14548.127112373239;14559.199244041574;14626.634334141625;647.5726020826255;813.1055838577562;823.180934969706;824.1511243419287;824.3899514359391;798.704479342644;825.2325337436182;829.7510746775973;829.9336053115736;832.2509741232878;855.7133360324299;863.8401895649293;866.7356456280831;866.8613021916494;867.0332579174207;847.6100993542947;851.638053827124;858.5192292316323;859.1022381611232;860.2300940658076;629.0909635576594;630.0486265738767;630.7382436288934;630.7792272704562;632.7279269913935;12336.321502317369;12390;12395.876041239653;12416.255024698547;12433.129680922339;12475.126741128124;12546.309952952584;12585.307808070553;12600.55898043564;12841.165324253894;9911.801763964753;9912.454814985173;10008.699739007841;10243.948780256125;10246.026627470379;3270.8528116234825;3299.2081900343983;3301.6203136639356;3309.2057906102605;3371.578552680915;45181;45192.548074519495;45675;45918.770406147756;46028.539714603095;9873.703788886201;10056.145227655585;10082.49587520621;10098;10162.644307449204;16966.406175783788;17034.318627254772;17048.403305884236;17090.230939607747;17092.2308496118;6002.189704389939;6008.188894499274;6146.078088286793;6224.875502490016;6264.123022776815;3665.17533554948;3717.4052151655605;3751.9249615007548;3784.1674831537016;3808.7333886628226;2725.8909643614033;2801.7618502427113;2810.12886005339;2811.943761124766;2819.4502072095743;494.7921872813355;501.83941138835223;510.7318657704661;513.7970501651827;514.4135685318739;548.240686648994;554.919536667181;607.5716619783042;625.3465128940269;644.452215616722;7449.739259125905;7460.14208366034;7720.112187098443;7793.571353575608;7855.175206603339;537.4007981101045;576.7145263094795;586.6919867069737;604.8608819971344;610.9725062372204;3597.9280414392088;3643.307771523402;3681.705463562962;3716.498272733146;3756.436534519844;47738.28392574114;49067.75466122646;49286.75356623194;49325.26012109821;49512.50487495079;41665.37501937473;43758;43847.12305753867;44393.778031109636;44703.55296447059;39076.41385379222;39317;39402;40374.798126009184;40678.59321406748;7225.132984041738;7285.526440781332;7396.106790826602;7437.628118593941;7443.702251909863;24908.252752417455;25368.492630146924;25699.614505782803;26430.603540946515;29208.853955730086;33855.15362115967;33925.49111763375;34130.317393651494;34470.48294275538;35135.82432087823;10759.13926885863;10982.231243813176;11011;11044.613438529614;11127.666170014912;12138.271703697807;12260.509579616715;12300.446479908605;12452;12563.12058155957;10890.673279801618;11175.21773475849;11366.488508017324;11603.245789023686;11988.220765650205;10930.56277748881;10996.340219586851;11330.37682927447;11375.772484550098;11580.131490138441;10770.569177233136;10777.299475534066;10963.342199468058;11163.609273675382;11530.827037594276;9756.60973561078;9855.753606159617;9867.55595998196;9942.403455792675;10014.3490673106;9134.97985077614;9412.435253884789;9744.045167916252;9826.16477599412;9835.114839664464 21:06:08 INFO - PROCESS | 12340 | __end_tp_report 21:06:08 INFO - PROCESS | 12340 | __start_cc_report 21:06:08 INFO - PROCESS | 12340 | _x_x_mozilla_cycle_collect,384 21:06:08 INFO - PROCESS | 12340 | __end_cc_report 21:06:08 INFO - PROCESS | 12340 | __startTimestamp1460088368094__endTimestamp 21:06:08 INFO - PROCESS | 12340 | 21:06:08 INFO - PROCESS | 12340 | ------- Summary: start ------- 21:06:08 INFO - PROCESS | 12340 | Number of tests: 6 21:06:08 INFO - PROCESS | 12340 | 21:06:08 INFO - PROCESS | 12340 | [#0] dojo.html Cycles:165 Average:4713.52 Median:4854.54 stddev:484.95 (10.0%) stddev-sans-first:457.50 21:06:08 INFO - PROCESS | 12340 | Values: 2609.9 2672.9 2694.8 2696.5 2699.5 4569.9 4660.0 4689.5 4692.7 4694.1 4591.9 4760.2 4811.9 4826.8 4848.3 4361.7 4380.0 4425.6 4431.6 4463.7 4448.7 4463.6 4490.8 4499.6 4552.6 4192.5 4322.5 4341.2 4411.3 4449.1 4349.6 4361.3 4361.4 4365.9 4402.8 4315.4 4351.0 4353.1 4385.9 4394.5 4541.4 4632.7 4711.6 4742.4 4756.1 4983.1 5006.4 5010.0 5010.1 5038.2 4957.4 5031.5 5054.6 5059.6 5083.8 4694.4 4809.3 4815.0 4820.3 4865.2 5210.9 5214.9 5235.6 5254.2 5267.7 4875.4 4981.1 5026.9 5034.6 5039.1 4866.8 5107.7 5113.6 5203.4 5224.7 5070.9 5075.4 5081.6 5085.2 5119.7 4948.9 5046.9 5083.2 5088.6 5122.4 4340.1 4391.9 4402.9 4417.8 4436.5 3803.9 3808.8 3810.2 3834.6 3852.7 4291.8 4403.6 4412.0 4416.2 4488.2 5148.3 5156.0 5160.8 5170.7 5206.2 4405.2 4453.0 4457.8 4462.5 4512.1 4462.3 4626.2 4702.6 4720.6 4736.1 4822.5 4845.8 4873.0 4893.0 4924.6 5130.4 5144.8 5152.3 5156.4 5158.1 4674.1 4754.4 4846.5 4849.2 4905.6 4985.8 4995.2 5007.2 5013.9 5066.2 5089.3 5099.5 5099.9 5105.2 5110.2 4785.6 4819.0 4901.8 4977.6 4980.0 4948.6 4993.5 5009.1 5014.9 5056.0 4854.5 4855.1 4866.3 4874.7 4914.8 4867.2 4954.1 4979.0 5025.5 5054.7 4862.7 4862.8 4875.1 4885.3 4921.3 21:06:08 INFO - PROCESS | 12340 | 21:06:08 INFO - PROCESS | 12340 | [#1] ext.html Cycles:180 Average:45551.37 Median:34959.15 stddev:80228.06 (229.5%) stddev-sans-first:80382.04 21:06:08 INFO - PROCESS | 12340 | Values: 572.2 591.4 620.9 626.7 628.5 31807.8 32555.8 32749.8 32846.3 32880.7 34180.7 34329.3 34597.3 34841.5 35076.8 7455.8 7577.5 7579.7 7623.0 7633.4 7504.2 7628.7 7685.9 7692.2 7696.3 7677.2 7746.7 7759.3 7775.0 7795.6 7690.9 7712.9 7737.8 7775.3 7782.6 7592.5 7714.4 7731.8 7735.1 7735.5 29235.0 33868.2 34386.8 34412.8 34425.1 2838.6 2892.0 2968.1 2982.7 3052.7 27016.3 27394.9 27545.4 27754.8 27822.7 3416.1 3447.4 3568.8 3586.5 3640.6 236866.0 243905.0 244490.0 244654.0 245949.0 49620.0 49647.8 49709.0 49716.5 49739.3 60733.0 60942.7 62203.7 62581.1 62628.7 15609.3 15638.1 15753.7 15805.0 15839.8 11986.4 12094.8 12097.0 12131.2 12194.2 19488.2 19800.7 19823.2 19890.7 19908.3 7640.5 7686.0 7686.8 7723.7 7897.9 816.2 865.4 985.0 991.6 994.8 27487.7 28193.4 28526.7 28871.6 28922.6 990.4 991.4 1003.5 1014.8 1019.4 14680.6 15090.5 15231.7 15301.2 15350.8 351220.0 351501.0 354720.0 355000.0 355994.0 48376.5 49047.3 49226.0 49288.5 49578.5 1239.1 1264.3 1270.4 1276.8 1282.4 26284.9 27772.6 27945.6 28294.9 28466.0 42397.8 42868.1 43184.4 43195.8 43214.8 307827.0 308827.0 309070.0 310066.0 310271.0 24537.1 24993.1 25136.7 25277.9 25477.9 41755.8 42198.6 42231.6 42381.0 42989.8 35405.0 35740.6 35924.5 36663.6 36687.8 34832.5 35585.8 35867.1 35877.0 35894.3 31165.7 35412.0 35799.0 35889.0 35944.8 28373.0 28819.3 29036.6 29085.1 29219.0 22676.4 24262.9 24359.2 24376.4 24788.3 21:06:08 INFO - PROCESS | 12340 | 21:06:08 INFO - PROCESS | 12340 | [#2] jquery.html Cycles:180 Average:23761.36 Median:23907.47 stddev:64846.15 (271.2%) stddev-sans-first:65004.27 21:06:08 INFO - PROCESS | 12340 | Values: 364.6 369.4 372.7 377.1 384.0 15752.0 15831.4 16329.7 16348.8 16379.0 15322.8 16559.8 17246.1 17318.0 17318.3 5194.7 5337.8 5362.2 5366.8 5368.3 3690.7 5227.7 5751.2 6117.7 6122.1 6052.0 6075.7 6076.8 6099.6 6115.8 4908.3 5189.3 5230.7 5236.2 5255.0 4953.3 5053.5 5183.9 5359.8 5362.6 10974.7 11143.6 11454.1 11479.9 11549.0 1846.2 1885.9 1890.8 1912.7 1969.0 8334.7 8440.5 8479.4 8777.3 8818.2 1628.7 1681.5 1683.2 1734.8 1745.5 67832.0 68027.0 68261.3 69230.3 70173.3 9864.3 9871.6 10036.7 10097.6 10312.5 13549.8 13625.4 13651.2 13678.0 13736.5 7349.4 7371.4 7448.7 7518.8 7612.5 6932.7 6966.2 6996.1 7039.6 7139.6 3909.2 3911.0 4040.4 4120.2 4192.2 1694.4 1753.1 1755.1 1794.6 1806.1 855.9 888.8 915.3 958.0 962.1 16446.4 16533.4 16575.8 16982.2 17264.0 859.6 880.3 901.4 907.3 918.9 9089.9 9144.2 9494.7 9508.7 9659.4 384344.0 390602.0 393840.0 397969.0 398926.0 73241.0 75508.2 76163.6 77872.6 78329.6 897.0 907.7 914.4 916.2 937.1 14248.8 14782.2 14916.8 14925.1 15295.6 31572.4 33578.8 34938.5 35197.6 35318.5 43622.8 44518.8 45499.3 45735.8 45840.3 7084.7 7234.5 7384.5 7404.5 7417.2 9796.9 10917.1 11294.9 11397.4 11762.0 10198.1 10206.9 10223.8 10319.1 10343.8 9868.7 10012.9 10254.8 10484.0 10519.9 10132.2 10213.3 10504.8 10546.8 10757.9 7377.3 7510.5 7540.9 7641.4 7711.8 7622.1 10015.8 10254.1 10532.1 10757.4 21:06:08 INFO - PROCESS | 12340 | 21:06:08 INFO - PROCESS | 12340 | [#3] mootools.html Cycles:180 Average:5400.97 Median:6659.72 stddev:2901.59 (43.6%) stddev-sans-first:2894.37 21:06:08 INFO - PROCESS | 12340 | Values: 1428.4 1460.6 1587.9 1788.5 1802.0 6833.7 7477.1 7539.4 7714.4 7733.9 7622.7 7653.1 7655.2 7713.8 7729.8 2179.2 2212.4 2222.9 2226.3 2233.9 2128.4 2149.6 2154.5 2158.0 2176.4 2150.5 2182.1 2193.3 2206.7 2264.4 2201.8 2202.4 2213.0 2214.1 2215.4 2164.7 2166.7 2171.0 2187.1 2193.4 7786.8 7788.8 7806.0 7825.6 7871.9 4487.3 4658.5 4681.2 4699.0 4712.2 2790.2 2831.1 2935.3 2945.7 2971.1 884.5 903.0 911.0 930.4 932.0 10735.2 10749.5 10751.1 10755.1 10781.4 4185.6 4351.4 4357.4 4379.0 4397.3 7986.0 8020.5 8037.1 8038.9 8056.2 4427.0 4458.8 4469.3 4499.8 4516.8 3680.5 4207.9 4230.2 4253.3 4307.8 3439.0 3478.4 3505.6 3585.3 3604.5 1077.9 1110.9 1113.7 1128.4 1135.1 971.0 973.6 982.4 1034.7 1217.5 7236.6 7295.9 7350.1 7380.7 7416.3 432.2 441.4 441.8 443.8 445.2 5633.1 5637.4 5816.8 5847.8 5947.1 9195.3 9642.3 9659.3 9704.4 9766.3 9422.0 9543.1 9566.4 9772.6 9865.4 7265.7 7320.7 7346.4 7362.9 7420.6 7145.0 7172.0 7249.6 7255.8 7278.5 8886.0 8944.0 8949.1 9113.7 9131.2 8976.2 9053.5 9232.8 9235.4 9345.4 5666.6 6065.5 6232.1 6404.4 6457.4 7446.5 7490.3 7491.9 7499.9 7507.5 6556.9 6774.9 6791.2 6832.9 6877.9 6750.6 6771.7 6777.2 6811.4 6814.8 6737.3 6899.8 6967.1 6982.8 7029.1 6584.6 6641.0 6654.9 6664.5 6689.1 6685.2 6766.2 6799.3 6804.3 6809.9 21:06:08 INFO - PROCESS | 12340 | 21:06:08 INFO - PROCESS | 12340 | [#4] prototype.html Cycles:180 Average:4658.68 Median:5413.69 stddev:1383.22 (25.6%) stddev-sans-first:1348.00 21:06:08 INFO - PROCESS | 12340 | Values: 307.8 312.3 312.6 315.7 317.7 5207.9 5503.5 5509.1 5510.5 5518.3 5314.2 5390.3 5393.7 5412.4 5414.9 3896.3 3975.4 4107.9 4157.3 4162.3 4091.8 4096.1 4099.7 4100.3 4117.6 4024.6 4056.8 4062.2 4086.0 4086.2 3857.5 4080.9 4095.8 4099.2 4102.3 3569.9 3580.5 3583.5 3586.1 3592.1 5098.0 5103.9 5103.9 5106.7 5128.5 4737.9 4740.3 4744.0 4750.5 4754.3 5432.9 5582.7 5587.7 5618.4 5624.1 3890.5 3891.6 3895.8 3925.0 3933.1 5806.7 5890.9 5935.6 5948.5 5956.3 3943.8 4024.8 4026.5 4033.0 4040.9 4068.0 4072.7 4089.1 4092.5 4105.0 4692.4 4697.4 4714.8 4725.6 4742.5 5544.9 5650.9 5665.8 5668.2 5688.5 1390.8 1418.8 1424.1 1425.2 1426.1 919.1 936.5 936.7 948.8 949.5 4717.0 4768.7 4905.1 4927.2 4983.2 5866.0 5871.5 5873.4 5889.0 5905.4 4863.9 4901.3 4938.3 4939.8 4950.6 3107.9 3132.0 3139.3 3142.7 3159.0 5497.5 5520.7 5523.0 5553.4 5563.0 5733.3 5942.4 5977.0 5986.4 6014.9 5465.1 5478.9 5480.1 5514.8 5550.1 5689.0 5841.5 5842.4 5848.7 5881.5 5682.2 5727.3 5791.2 5793.2 5798.8 5512.0 5513.5 5514.2 5529.4 5529.9 3796.6 4021.0 4026.3 4027.6 4043.5 5780.6 5807.8 5824.9 5837.7 5850.8 5600.2 5636.9 5649.0 5666.7 5668.7 5480.5 5548.8 5601.8 5646.6 5677.0 5494.6 5508.4 5534.4 5554.2 5565.4 5385.6 5580.0 5741.6 5749.9 5753.3 5585.7 5591.7 5593.1 5596.0 5598.2 21:06:08 INFO - PROCESS | 12340 | 21:06:08 INFO - PROCESS | 12340 | [#5] yui.html Cycles:180 Average:12398.14 Median:39888.40 stddev:13525.30 (33.9%) stddev-sans-first:13534.95 21:06:08 INFO - PROCESS | 12340 | Values: 748.6 754.2 768.1 768.8 772.1 11996.6 12265.2 13723.1 14490.9 14492.6 14423.9 14544.3 14548.1 14559.2 14626.6 647.6 813.1 823.2 824.2 824.4 798.7 825.2 829.8 829.9 832.3 855.7 863.8 866.7 866.9 867.0 847.6 851.6 858.5 859.1 860.2 629.1 630.0 630.7 630.8 632.7 12336.3 12390.0 12395.9 12416.3 12433.1 12475.1 12546.3 12585.3 12600.6 12841.2 9911.8 9912.5 10008.7 10243.9 10246.0 3270.9 3299.2 3301.6 3309.2 3371.6 45181.0 45192.5 45675.0 45918.8 46028.5 9873.7 10056.1 10082.5 10098.0 10162.6 16966.4 17034.3 17048.4 17090.2 17092.2 6002.2 6008.2 6146.1 6224.9 6264.1 3665.2 3717.4 3751.9 3784.2 3808.7 2725.9 2801.8 2810.1 2811.9 2819.5 494.8 501.8 510.7 513.8 514.4 548.2 554.9 607.6 625.3 644.5 7449.7 7460.1 7720.1 7793.6 7855.2 537.4 576.7 586.7 604.9 611.0 3597.9 3643.3 3681.7 3716.5 3756.4 47738.3 49067.8 49286.8 49325.3 49512.5 41665.4 43758.0 43847.1 44393.8 44703.6 39076.4 39317.0 39402.0 40374.8 40678.6 7225.1 7285.5 7396.1 7437.6 7443.7 24908.3 25368.5 25699.6 26430.6 29208.9 33855.2 33925.5 34130.3 34470.5 35135.8 10759.1 10982.2 11011.0 11044.6 11127.7 12138.3 12260.5 12300.4 12452.0 12563.1 10890.7 11175.2 11366.5 11603.2 11988.2 10930.6 10996.3 11330.4 11375.8 11580.1 10770.6 10777.3 10963.3 11163.6 11530.8 9756.6 9855.8 9867.6 9942.4 10014.3 9135.0 9412.4 9744.0 9826.2 9835.1 21:06:08 INFO - PROCESS | 12340 | -------- Summary: end -------- 21:06:08 INFO - PROCESS | 12340 | 21:06:08 INFO - TEST-INFO | 12340: exit 0 21:06:08 INFO - TEST-OK | dromaeo_css | took 1115089ms 21:06:08 INFO - TEST-START | kraken 21:06:08 INFO - operating with platform_type : linux_ 21:06:08 INFO - Initialising browser for kraken test... 21:06:08 INFO - TEST-INFO | started process 12575 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQJyYDl/profile http://localhost:39278/getInfo.html) 21:06:12 INFO - PROCESS | 12575 | 21:06:12 INFO - PROCESS | 12575 | (process:12644): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 21:06:12 INFO - PROCESS | 12575 | JavaScript error: jar:file:///builds/slave/test/build/application/firefox/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 21:06:13 INFO - PROCESS | 12575 | __metrics Screen width/height:1600/1200 21:06:13 INFO - PROCESS | 12575 | colorDepth:24 21:06:13 INFO - PROCESS | 12575 | Browser inner width/height: 1024/697 21:06:13 INFO - PROCESS | 12575 | __metrics 21:06:14 ERROR - PROCESS | 12575 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2881: TypeError: this.tabs is undefined 21:06:15 INFO - TEST-INFO | 12575: exit 0 21:06:15 INFO - Browser initialized. 21:06:15 INFO - Running cycle 1/1 for kraken test... 21:06:15 INFO - TEST-INFO | started process 12695 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQJyYDl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:06:17 INFO - PROCESS | 12695 | 21:06:17 INFO - PROCESS | 12695 | (process:12756): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 21:06:27 INFO - PROCESS | 12695 | RSS: Main: 164126720 21:06:27 INFO - PROCESS | 12695 | 21:06:29 INFO - PROCESS | 12695 | Cycle 1(1): loaded http://localhost:39278/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39278/tests/kraken/driver.html?testName=audio-beat-detection) 21:06:30 INFO - PROCESS | 12695 | RSS: Main: 168882176 21:06:30 INFO - PROCESS | 12695 | 21:06:33 INFO - PROCESS | 12695 | Cycle 1(1): loaded http://localhost:39278/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39278/tests/kraken/driver.html?testName=audio-dft) 21:06:33 INFO - PROCESS | 12695 | RSS: Main: 172077056 21:06:33 INFO - PROCESS | 12695 | 21:06:36 INFO - PROCESS | 12695 | Cycle 1(1): loaded http://localhost:39278/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39278/tests/kraken/driver.html?testName=audio-fft) 21:06:37 INFO - PROCESS | 12695 | RSS: Main: 162287616 21:06:37 INFO - PROCESS | 12695 | 21:06:39 INFO - PROCESS | 12695 | Cycle 1(1): loaded http://localhost:39278/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39278/tests/kraken/driver.html?testName=audio-oscillator) 21:06:40 INFO - PROCESS | 12695 | RSS: Main: 162832384 21:06:40 INFO - PROCESS | 12695 | 21:06:42 INFO - PROCESS | 12695 | Cycle 1(1): loaded http://localhost:39278/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39278/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:06:42 INFO - PROCESS | 12695 | RSS: Main: 164147200 21:06:43 INFO - PROCESS | 12695 | 21:06:46 INFO - PROCESS | 12695 | Cycle 1(1): loaded http://localhost:39278/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39278/tests/kraken/driver.html?testName=imaging-darkroom) 21:06:46 INFO - PROCESS | 12695 | RSS: Main: 164646912 21:06:46 INFO - PROCESS | 12695 | 21:06:50 INFO - PROCESS | 12695 | Cycle 1(1): loaded http://localhost:39278/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39278/tests/kraken/driver.html?testName=imaging-desaturate) 21:06:50 INFO - PROCESS | 12695 | RSS: Main: 164614144 21:06:50 INFO - PROCESS | 12695 | 21:06:53 INFO - PROCESS | 12695 | Cycle 1(1): loaded http://localhost:39278/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39278/tests/kraken/driver.html?testName=json-parse-financial) 21:06:54 INFO - PROCESS | 12695 | RSS: Main: 164986880 21:06:54 INFO - PROCESS | 12695 | 21:06:56 INFO - PROCESS | 12695 | Cycle 1(1): loaded http://localhost:39278/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39278/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:06:56 INFO - PROCESS | 12695 | RSS: Main: 165318656 21:06:56 INFO - PROCESS | 12695 | 21:06:58 INFO - PROCESS | 12695 | Cycle 1(1): loaded http://localhost:39278/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39278/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:06:59 INFO - PROCESS | 12695 | RSS: Main: 165478400 21:06:59 INFO - PROCESS | 12695 | 21:07:01 INFO - PROCESS | 12695 | Cycle 1(1): loaded http://localhost:39278/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39278/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:07:02 INFO - PROCESS | 12695 | RSS: Main: 165933056 21:07:02 INFO - PROCESS | 12695 | 21:07:04 INFO - PROCESS | 12695 | Cycle 1(1): loaded http://localhost:39278/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39278/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:07:05 INFO - PROCESS | 12695 | RSS: Main: 166309888 21:07:05 INFO - PROCESS | 12695 | 21:07:08 INFO - PROCESS | 12695 | Cycle 1(1): loaded http://localhost:39278/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39278/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:07:09 INFO - PROCESS | 12695 | RSS: Main: 165834752 21:07:09 INFO - PROCESS | 12695 | 21:07:10 INFO - PROCESS | 12695 | Cycle 1(1): loaded http://localhost:39278/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39278/tests/kraken/driver.html?testName=ai-astar) 21:07:11 INFO - PROCESS | 12695 | RSS: Main: 167161856 21:07:11 INFO - PROCESS | 12695 | 21:07:11 INFO - PROCESS | 12695 | __start_tp_report 21:07:11 INFO - PROCESS | 12695 | _x_x_mozilla_page_load 21:07:11 INFO - PROCESS | 12695 | _x_x_mozilla_page_load_details 21:07:11 INFO - PROCESS | 12695 | |i|pagename|runs| 21:07:11 INFO - PROCESS | 12695 | |0;ai-astar;116;108;114;113;115;127;120;120;116;117 21:07:11 INFO - PROCESS | 12695 | |1;audio-beat-detection;157;133;161;176;138;162;157;138;181;136 21:07:11 INFO - PROCESS | 12695 | |2;audio-dft;164;165;163;164;164;167;166;165;167;169 21:07:11 INFO - PROCESS | 12695 | |3;audio-fft;78;74;78;74;73;78;74;145;76;75 21:07:11 INFO - PROCESS | 12695 | |4;audio-oscillator;94;93;135;95;95;94;146;95;95;130 21:07:11 INFO - PROCESS | 12695 | |5;imaging-gaussian-blur;118;117;118;117;117;118;117;118;117;118 21:07:11 INFO - PROCESS | 12695 | |6;imaging-darkroom;154;147;147;147;146;147;148;147;147;147 21:07:11 INFO - PROCESS | 12695 | |7;imaging-desaturate;97;96;96;96;96;96;96;99;101;97 21:07:11 INFO - PROCESS | 12695 | |8;json-parse-financial;67;70;66;68;66;66;67;67;68;63 21:07:11 INFO - PROCESS | 12695 | |9;json-stringify-tinderbox;64;64;64;65;63;64;64;66;65;65 21:07:11 INFO - PROCESS | 12695 | |10;stanford-crypto-aes;85;86;88;93;84;84;85;85;98;83 21:07:11 INFO - PROCESS | 12695 | |11;stanford-crypto-ccm;140;148;141;139;142;141;153;144;145;143 21:07:11 INFO - PROCESS | 12695 | |12;stanford-crypto-pbkdf2;175;172;178;176;175;169;174;170;172;177 21:07:11 INFO - PROCESS | 12695 | |13;stanford-crypto-sha256-iterative;72;72;71;75;79;71;71;69;69;70 21:07:11 INFO - PROCESS | 12695 | __end_tp_report 21:07:11 INFO - PROCESS | 12695 | __start_cc_report 21:07:11 INFO - PROCESS | 12695 | _x_x_mozilla_cycle_collect,912 21:07:11 INFO - PROCESS | 12695 | __end_cc_report 21:07:11 INFO - PROCESS | 12695 | __startTimestamp1460088431162__endTimestamp 21:07:11 INFO - PROCESS | 12695 | 21:07:11 INFO - PROCESS | 12695 | ------- Summary: start ------- 21:07:11 INFO - PROCESS | 12695 | Number of tests: 14 21:07:11 INFO - PROCESS | 12695 | 21:07:11 INFO - PROCESS | 12695 | [#0] ai-astar Cycles:10 Average:116.60 Median:116.50 stddev:5.04 (4.3%) stddev-sans-first:5.34 21:07:11 INFO - PROCESS | 12695 | Values: 116.0 108.0 114.0 113.0 115.0 127.0 120.0 120.0 116.0 117.0 21:07:11 INFO - PROCESS | 12695 | 21:07:11 INFO - PROCESS | 12695 | [#1] audio-beat-detection Cycles:10 Average:153.90 Median:159.00 stddev:17.06 (10.7%) stddev-sans-first:18.06 21:07:11 INFO - PROCESS | 12695 | Values: 157.0 133.0 161.0 176.0 138.0 162.0 157.0 138.0 181.0 136.0 21:07:11 INFO - PROCESS | 12695 | 21:07:11 INFO - PROCESS | 12695 | [#2] audio-dft Cycles:10 Average:165.40 Median:165.50 stddev:1.84 (1.1%) stddev-sans-first:1.88 21:07:11 INFO - PROCESS | 12695 | Values: 164.0 165.0 163.0 164.0 164.0 167.0 166.0 165.0 167.0 169.0 21:07:11 INFO - PROCESS | 12695 | 21:07:11 INFO - PROCESS | 12695 | [#3] audio-fft Cycles:10 Average:82.50 Median:75.50 stddev:22.04 (29.2%) stddev-sans-first:23.32 21:07:11 INFO - PROCESS | 12695 | Values: 78.0 74.0 78.0 74.0 73.0 78.0 74.0 145.0 76.0 75.0 21:07:11 INFO - PROCESS | 12695 | 21:07:11 INFO - PROCESS | 12695 | [#4] audio-oscillator Cycles:10 Average:107.20 Median:94.50 stddev:20.93 (22.2%) stddev-sans-first:21.65 21:07:11 INFO - PROCESS | 12695 | Values: 94.0 93.0 135.0 95.0 95.0 94.0 146.0 95.0 95.0 130.0 21:07:11 INFO - PROCESS | 12695 | 21:07:11 INFO - PROCESS | 12695 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:118.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 21:07:11 INFO - PROCESS | 12695 | Values: 118.0 117.0 118.0 117.0 117.0 118.0 117.0 118.0 117.0 118.0 21:07:11 INFO - PROCESS | 12695 | 21:07:11 INFO - PROCESS | 12695 | [#6] imaging-darkroom Cycles:10 Average:147.70 Median:147.00 stddev:2.26 (1.5%) stddev-sans-first:0.50 21:07:11 INFO - PROCESS | 12695 | Values: 154.0 147.0 147.0 147.0 146.0 147.0 148.0 147.0 147.0 147.0 21:07:11 INFO - PROCESS | 12695 | 21:07:11 INFO - PROCESS | 12695 | [#7] imaging-desaturate Cycles:10 Average:97.00 Median:96.00 stddev:1.70 (1.8%) stddev-sans-first:1.80 21:07:11 INFO - PROCESS | 12695 | Values: 97.0 96.0 96.0 96.0 96.0 96.0 96.0 99.0 101.0 97.0 21:07:11 INFO - PROCESS | 12695 | 21:07:11 INFO - PROCESS | 12695 | [#8] json-parse-financial Cycles:10 Average:66.80 Median:67.00 stddev:1.81 (2.7%) stddev-sans-first:1.92 21:07:11 INFO - PROCESS | 12695 | Values: 67.0 70.0 66.0 68.0 66.0 66.0 67.0 67.0 68.0 63.0 21:07:11 INFO - PROCESS | 12695 | 21:07:11 INFO - PROCESS | 12695 | [#9] json-stringify-tinderbox Cycles:10 Average:64.40 Median:64.50 stddev:0.84 (1.3%) stddev-sans-first:0.88 21:07:11 INFO - PROCESS | 12695 | Values: 64.0 64.0 64.0 65.0 63.0 64.0 64.0 66.0 65.0 65.0 21:07:11 INFO - PROCESS | 12695 | 21:07:11 INFO - PROCESS | 12695 | [#10] stanford-crypto-aes Cycles:10 Average:87.10 Median:85.50 stddev:4.77 (5.6%) stddev-sans-first:5.00 21:07:11 INFO - PROCESS | 12695 | Values: 85.0 86.0 88.0 93.0 84.0 84.0 85.0 85.0 98.0 83.0 21:07:11 INFO - PROCESS | 12695 | 21:07:11 INFO - PROCESS | 12695 | [#11] stanford-crypto-ccm Cycles:10 Average:143.60 Median:143.50 stddev:4.22 (2.9%) stddev-sans-first:4.27 21:07:11 INFO - PROCESS | 12695 | Values: 140.0 148.0 141.0 139.0 142.0 141.0 153.0 144.0 145.0 143.0 21:07:11 INFO - PROCESS | 12695 | 21:07:11 INFO - PROCESS | 12695 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.80 Median:175.00 stddev:2.97 (1.7%) stddev-sans-first:3.12 21:07:11 INFO - PROCESS | 12695 | Values: 175.0 172.0 178.0 176.0 175.0 169.0 174.0 170.0 172.0 177.0 21:07:11 INFO - PROCESS | 12695 | 21:07:11 INFO - PROCESS | 12695 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.90 Median:71.50 stddev:3.03 (4.2%) stddev-sans-first:3.22 21:07:11 INFO - PROCESS | 12695 | Values: 72.0 72.0 71.0 75.0 79.0 71.0 71.0 69.0 69.0 70.0 21:07:11 INFO - PROCESS | 12695 | -------- Summary: end -------- 21:07:11 INFO - PROCESS | 12695 | 21:07:12 INFO - TEST-INFO | 12695: exit 0 21:07:12 INFO - TEST-OK | kraken | took 63408ms 21:07:12 INFO - SUITE-END | took 1178s 21:07:12 INFO - Completed test suite (00:19:38) 21:07:12 INFO - javascript benchmark 21:07:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2609.9478010439793, 2672.933176670583, 2694.838309701418, 2696.501147287753, 2699.541078016738, 4569.862904112873, 4660.0, 4689.5310468953085, 4692.741899195543, 4694.108119457301, 4591.862244132673, 4760.214564596846, 4811.8797030074265, 4826.806927722896, 4848.296996935443, 4361.694681372297, 4379.956200437987, 4425.601695847373, 4431.556844315575, 4463.732176069446, 4448.7108337957925, 4463.553644635543, 4490.797914093857, 4499.640028797705, 4552.590266875981, 4192.496900371944, 4322.50291216511, 4341.218580655465, 4411.27214009688, 4449.110177964388, 4349.608535231812, 4361.302191649353, 4361.4112094867105, 4365.9126817463475, 4402.84590039347, 4315.374270730757, 4351.0, 4353.10761293934, 4385.912281754347, 4394.538573449774, 4541.386912766768, 4632.698874573142, 4711.646626502992, 4742.407199100113, 4756.07256584966, 4983.053219888209, 5006.4492905780335, 5009.974950125263, 5010.123228435009, 5038.168702164138, 4957.380327459067, 5031.471695471996, 5054.570361519275, 5059.645824792229, 5083.847484575469, 4694.413198350207, 4809.254565542346, 4815.012922350979, 4820.276958456225, 4865.197242454955, 5210.947890521122, 5214.895702085937, 5235.554977826928, 5254.15933450646, 5267.657602255841, 4875.414950205927, 4981.078500477351, 5026.949730502722, 5034.622403319766, 5039.092963266574, 4866.780994855169, 5107.693538387634, 5113.590912726973, 5203.375594928632, 5224.738763061831, 5070.923936140961, 5075.39095308558, 5081.618878584121, 5085.160948443539, 5119.718415487184, 4948.8762780930765, 5046.924296135561, 5083.186690129562, 5088.643794934393, 5122.385313762373, 4340.088581397942, 4391.934120988188, 4402.8679139625865, 4417.801198946056, 4436.489803672554, 3803.8858834235016, 3808.809559522013, 3810.2189051244427, 3834.6357096075826, 3852.730308878408, 4291.785410729451, 4403.559644035635, 4411.977940110343, 4416.205083085076, 4488.236999709992, 5148.330717006766, 5156.04613146569, 5160.819371322061, 5170.741462926839, 5206.245094461357, 4405.229084910128, 4453.032104637349, 4457.77711114443, 4462.486814016364, 4512.0750246200105, 4462.286034234507, 4626.190416677068, 4702.600278976257, 4720.622350211975, 4736.100140973204, 4822.493638167942, 4845.8061677532505, 4873.0, 4892.951070489321, 4924.63065270099, 5130.358705161855, 5144.768485418091, 5152.3044389007, 5156.4327923927585, 5158.071547121554, 4674.0651869625535, 4754.358161648272, 4846.5153484651255, 4849.248366503198, 4905.632077594123, 4985.775640096132, 4995.200767877122, 5007.173816320266, 5013.874653133701, 5066.189409694432, 5089.287499750112, 5099.464556221544, 5099.87250318745, 5105.183170692671, 5110.233464980282, 4785.569298763128, 4818.975905120452, 4901.803927842846, 4977.552020318189, 4980.0, 4948.554630083309, 4993.525615066563, 5009.0983622948215, 5014.9498505015945, 5056.0140772549, 4854.538818812207, 4855.101806165871, 4866.318715379779, 4874.658773885794, 4914.778834952364, 4867.1969125093965, 4954.083494553375, 4978.975105124451, 5025.497450254945, 5054.671446355975, 4862.7325497098, 4862.756862156949, 4875.146849301429, 4885.267209918541, 4921.26181072842], "value": 4683.16437190562, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [572.1646396261458, 591.4085914085914, 620.9379062093791, 626.6929204689702, 628.5223230344936, 31807.84096079519, 32555.837220813923, 32749.83625081877, 32846.34307313852, 32880.67119328806, 34180.65819341806, 34329.31341373171, 34597.30805383897, 34841.47737783935, 35076.82461587695, 7455.776326710207, 7577.469577129603, 7579.696812127509, 7623.047119110111, 7633.427492938024, 7504.174540800507, 7628.694852205905, 7685.884711729301, 7692.192319806423, 7696.307332340089, 7677.193894641066, 7746.651400686955, 7759.262870027338, 7775.0, 7795.5712435816, 7690.884636730453, 7712.884306735404, 7737.8452430951065, 7775.261350171753, 7782.610869456533, 7592.544447333123, 7714.421418393643, 7731.806704832368, 7735.1491335953, 7735.4585179037485, 29235.0, 33868.153296167795, 34386.82806585951, 34412.82793586041, 34425.13937151566, 2838.6451693538306, 2891.956620650692, 2968.124403301031, 2982.6719060903283, 3052.6794686557814, 27016.324591885164, 27394.863025684743, 27545.44909101807, 27754.75103620342, 27822.721772782217, 3416.145963509123, 3447.413939630269, 3568.839402226906, 3586.5158203642695, 3640.6359364063646, 236866.0, 243905.0, 244490.0, 244654.0, 245949.0, 49620.0, 49647.751761240965, 49709.0, 49716.502834971914, 49739.25391119136, 60733.0, 60942.69528652328, 62203.68898155571, 62581.06128408077, 62628.68685656634, 15609.297581608855, 15638.139902305255, 15753.68492630141, 15805.0, 15839.841601583837, 11986.400679966142, 12094.818577721342, 12097.0, 12131.150819442732, 12194.207376520499, 19488.220471181277, 19800.70298945517, 19823.207071717257, 19890.70163947542, 19908.303209387603, 7640.503367281109, 7685.961570192113, 7686.846263074707, 7723.691052357955, 7897.921020789833, 816.1797393619374, 865.372604861483, 985.0445068283753, 991.5587563534302, 994.7761753605381, 27487.725122748918, 28193.43613127726, 28526.714732852404, 28871.566926496118, 28922.566161507595, 990.3810118675827, 991.4348821172007, 1003.4581326083833, 1014.7767491151935, 1019.3781793106199, 14680.632984175481, 15090.54728358151, 15231.695366092616, 15301.15843628611, 15350.846491534941, 351220.0, 351501.0, 354720.0, 355000.0, 355994.0, 48376.5162348379, 49047.264291035666, 49226.0, 49288.50711492911, 49578.50421495811, 1239.0645062977574, 1264.27304300026, 1270.399296885912, 1276.814861845046, 1282.435728279554, 26284.868575656998, 27772.583411248444, 27945.580816287365, 28294.858525708063, 28466.0, 42397.78801105975, 42868.14263714646, 43184.35223471713, 43195.78402107969, 43214.78392608017, 307827.0, 308827.0, 309070.0, 310066.0, 310271.0, 24537.14120005791, 24993.12524061649, 25136.74863251344, 25277.87361063183, 25477.872610636827, 41755.7912210437, 42198.57801421946, 42231.577684222764, 42381.0, 42989.78505107454, 35405.0, 35740.64259357373, 35924.46113308355, 36663.63336366602, 36687.816560917025, 34832.47751283783, 35585.82207088948, 35867.08832480324, 35877.0, 35894.28211435705, 31165.68834311628, 35412.0, 35799.0, 35889.0, 35944.820275898455, 28373.0, 28819.279518012216, 29036.56445153282, 29085.127446176648, 29219.0, 22676.433089172904, 24262.878685606458, 24359.23580818618, 24376.390590235387, 24788.25635230946], "value": 17348.402197144107, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [364.6280793590538, 369.43476480984094, 372.6720485972344, 377.0893292698134, 383.9750416222943, 15752.0, 15831.44589939351, 16329.673406531861, 16348.83651163491, 16379.0, 15322.846771532282, 16559.83440165598, 17246.137693115357, 17318.047507387088, 17318.307267709308, 5194.714290714019, 5337.786488540453, 5362.168863826113, 5366.812161574346, 5368.275282836826, 3690.741648084622, 5227.712475813829, 5751.194832723422, 6117.69411529424, 6122.0816877468515, 6052.031674932012, 6075.696215189245, 6076.817695469143, 6099.634021958696, 6115.816525504242, 4908.337374454439, 5189.299444574972, 5230.686158830464, 5236.188390799432, 5255.0, 4953.306537084811, 5053.4946505349535, 5183.922241166386, 5359.785608575652, 5362.624616276862, 10974.670759877217, 11143.554257829677, 11454.140939429577, 11479.942600286946, 11549.0, 1846.22458567402, 1885.886846789197, 1890.7825600056033, 1912.7322174895526, 1968.9606207875763, 8334.749957501284, 8440.493570385735, 8479.448835825651, 8777.253933415668, 8818.206361427438, 1628.6986907422165, 1681.5459825846954, 1683.2088918208422, 1734.80049794274, 1745.4901510193718, 67832.0, 68027.0, 68261.31738682599, 69230.30769692289, 70173.2982670177, 9864.260180486348, 9871.60513579463, 10036.698899033041, 10097.646582369582, 10312.535935882903, 13549.796753048711, 13625.386857591433, 13651.180929144282, 13678.0, 13736.45054197841, 7349.412047036224, 7371.3734332582335, 7448.73929412468, 7518.774436766906, 7612.505187162817, 6932.688029038604, 6966.164060312795, 6996.090508233897, 7039.648017599202, 7139.607321597258, 3909.237698648736, 3910.9608903911167, 4040.3939409088284, 4120.21715873983, 4192.161567686414, 1694.4323651576613, 1753.1321995612, 1755.1399814091258, 1794.5603327184924, 1806.096951524238, 855.9186877246651, 888.8311220868014, 915.3089417489753, 957.9904200958041, 962.129273007929, 16446.43758842908, 16533.421330253383, 16575.751363729552, 16982.150892455327, 17264.0, 859.5831021954347, 880.3089574683843, 901.4095767272447, 907.3421769217397, 918.8514357053683, 9089.863652045224, 9144.177024067865, 9494.667686630935, 9508.714738557854, 9659.420434773936, 384344.0, 390602.0, 393840.0, 397969.0, 398926.0, 73241.0, 75508.24491755122, 76163.61918190373, 77872.61063694759, 78329.60835195788, 896.9730908072768, 907.7140700679397, 914.433051508056, 916.2486760856034, 937.1471960515762, 14248.786268205778, 14782.186979716218, 14916.7762483565, 14925.10449373041, 15295.61760955985, 31572.36855262928, 33578.832105840294, 34938.47592286169, 35197.64802351944, 35318.47022294616, 43622.781886090364, 44518.777406112764, 45499.31751023671, 45735.771321143184, 45840.312395314766, 7084.681189346595, 7234.493585448968, 7384.523095381052, 7404.518706284074, 7417.184109748031, 9796.853047204155, 10917.126629869432, 11294.94352528265, 11397.430128493708, 11762.0, 10198.133158681596, 10206.897931020594, 10223.795524089624, 10319.071283584513, 10343.793124137626, 9868.703938881845, 10012.949935250277, 10254.846482238516, 10484.0, 10519.94740026295, 10132.189424845847, 10213.285070045322, 10504.842427363443, 10546.78906421852, 10757.9462102689, 7377.3360397564475, 7510.549367037996, 7540.924590754023, 7641.3886889047635, 7711.845763084595, 7622.123455802654, 10015.849762253718, 10254.128399086161, 10532.104771094237, 10757.408342541235], "value": 7961.8131661206635, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1428.407211007432, 1460.591034510337, 1587.8729701623863, 1788.5439213000682, 1801.9549511262207, 6833.658317084139, 7477.065366829146, 7539.4345424093135, 7714.3828493720575, 7733.883991740128, 7622.65698043588, 7653.081630204383, 7655.196204398541, 7713.807154821132, 7729.768106956801, 2179.226374637005, 2212.3805334506283, 2222.866628002317, 2226.2875879718495, 2233.8771367574777, 2128.4146859613575, 2149.591577600259, 2154.493693981913, 2157.9784202157934, 2176.3688530326185, 2150.4623844038993, 2182.0617134632103, 2193.254293540196, 2206.702095217141, 2264.3659775262954, 2201.7798220177933, 2202.3723238876923, 2213.0483891926465, 2214.092222188895, 2215.4461384653837, 2164.675298705191, 2166.729158855143, 2170.9579401887027, 2187.0923566719794, 2193.385851961453, 7786.844263114763, 7788.805279867992, 7806.009467585786, 7825.569593672346, 7871.881921771178, 4487.259602165639, 4658.534146585348, 4681.180793361148, 4698.953010469886, 4712.198926182523, 2790.204791634395, 2831.051597714768, 2935.324875278698, 2945.749611283022, 2971.1086673997715, 884.5002573545926, 903.0, 910.9954450227773, 930.4370855632312, 931.9673811416636, 10735.248532602722, 10749.51627176771, 10751.139908807276, 10755.139588832875, 10781.407022613676, 4185.644220241314, 4351.434313539283, 4357.433533640607, 4379.0, 4397.274449715825, 7985.960070199728, 8020.478668886503, 8037.115917249098, 8038.919610803934, 8056.154103819014, 4426.955730442654, 4458.799354029076, 4469.329600559877, 4499.820007199741, 4516.796744146522, 3680.4663323817895, 4207.852725154666, 4230.2174097792, 4253.2769429197115, 4307.806148723315, 3438.9656103439147, 3478.356504046709, 3505.614382417932, 3585.282943411276, 3604.4593311003036, 1077.9083777878811, 1110.8555887734703, 1113.704868209925, 1128.4470609401335, 1135.1146106037304, 970.9902900971041, 973.6154219083422, 982.4400091947522, 1034.6895931220604, 1217.5495066825154, 7236.565806051653, 7295.89056164158, 7350.117985841734, 7380.667869945865, 7416.295451932057, 432.2025862284081, 441.41512495943005, 441.77690266415897, 443.8424359352448, 445.22753023504197, 5633.0987042073075, 5637.408072152447, 5816.796412125555, 5847.795327163529, 5947.1376650385455, 9195.264378849675, 9642.325037247465, 9659.32384733076, 9704.369216000938, 9766.267529935283, 9422.0, 9543.141117299476, 9566.378185418065, 9772.609095636095, 9865.408075515492, 7265.673044713, 7320.7071717131785, 7346.375558077623, 7362.8527429451115, 7420.554766714123, 7145.035420218204, 7171.964140179266, 7249.565026098451, 7255.818604534928, 7278.490505664553, 8886.0, 8943.955280223818, 8949.149830766068, 9113.681021164493, 9131.178193962309, 8976.237019853386, 9053.54732263371, 9232.769180770534, 9235.399699019543, 9345.392549484262, 5666.631668941505, 6065.514758819196, 6232.065190221322, 6404.359564043559, 6457.418832305115, 7446.478746487694, 7490.288422599844, 7491.925080749123, 7499.850003000019, 7507.549547026977, 6556.934430655632, 6774.932250677627, 6791.185057793096, 6832.863342733217, 6877.89683154763, 6750.594964302158, 6771.729130834711, 6777.220619628806, 6811.386975172259, 6814.7955561331255, 6737.29258427858, 6899.827504312231, 6967.09427774386, 6982.812921803407, 7029.0862187915245, 6584.572002819801, 6640.966795165993, 6654.933450665625, 6664.50016248793, 6689.096971908924, 6685.197776266685, 6766.15423072116, 6799.3200679931615, 6804.285550017177, 6809.931900681128], "value": 4298.508812834436, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [307.79993004547043, 312.3082372544813, 312.60611629347017, 315.6590881847605, 317.73945364800863, 5207.947920520794, 5503.53219976302, 5509.146082357241, 5510.531604813596, 5518.33779946407, 5314.229436731672, 5390.326209223847, 5393.73031348432, 5412.431694672062, 5414.945850541503, 3896.337622604164, 3975.403689446577, 4107.856225032125, 4157.251694694946, 4162.271602469556, 4091.754494730311, 4096.078382363974, 4099.713020088595, 4100.298376173899, 4117.5882411758885, 4024.6377825995655, 4056.817443215062, 4062.2281766464275, 4085.9795701021453, 4086.2440448516973, 3857.4599556061894, 4080.8775736727944, 4095.795210239491, 4099.241640296525, 4102.343625019982, 3569.94645080324, 3580.534530511043, 3583.498310236569, 3586.1214002569536, 3592.1019745063736, 5098.0, 5103.872403189913, 5103.923441148386, 5106.66806657566, 5128.538431541179, 4737.905241895142, 4740.2889566564945, 4743.956329607516, 4750.45369782476, 4754.334393184957, 5432.864178395572, 5582.720863956786, 5587.664740115565, 5618.381977982419, 5624.128260119688, 3890.513685789276, 3891.571927088018, 3895.844166233347, 3925.0, 3933.134710363744, 5806.680632565207, 5890.941090589082, 5935.554833387513, 5948.524118070544, 5956.344802071769, 3943.8422463101156, 4024.8188831502653, 4026.4966879140106, 4032.959670403317, 4040.8585699500377, 4067.9796601016806, 4072.6945479089186, 4089.0985691653523, 4092.5498195198506, 4104.979475102606, 4692.366530518405, 4697.436307643105, 4714.834980775725, 4725.5510726480925, 4742.5020372861045, 5544.889102217933, 5650.886982260332, 5665.830025099253, 5668.234788303609, 5688.488036076773, 1390.7844284135974, 1418.7871819227198, 1424.0814674534868, 1425.2161311278755, 1426.108682073704, 919.0579655852804, 936.498973049429, 936.6768464879606, 948.8434408322687, 949.534727983297, 4716.976415117971, 4768.713877167381, 4905.117078925757, 4927.162382395001, 4983.202687569971, 5866.0, 5871.530277577784, 5873.412658734178, 5888.998870191992, 5905.350411454737, 4863.8540843774745, 4901.3383193269165, 4938.308636790852, 4939.753012349368, 4950.628702847301, 3107.860146293422, 3131.968680313213, 3139.309351942569, 3142.711488289836, 3159.0, 5497.47773961473, 5520.696361700145, 5523.033469142964, 5553.416891226444, 5563.0, 5733.31200255972, 5942.37605051472, 5977.0, 5986.360570557853, 6014.909776353271, 5465.098258787335, 5478.91781623276, 5480.123180291134, 5514.759179184732, 5550.111982082847, 5688.95197728809, 5841.474267315962, 5842.444967728059, 5848.70120461452, 5881.529477641864, 5682.204491371294, 5727.284089488814, 5791.218185544897, 5793.246877905845, 5798.82603521895, 5511.9527289814805, 5513.5037846594, 5514.2004409359615, 5529.364123125892, 5529.861753456195, 3796.6393192646656, 4020.9597904020584, 4026.315526360467, 4027.617376349242, 4043.5147782266317, 5780.624259423124, 5807.796727114531, 5824.912626310524, 5837.737301821343, 5850.824475265749, 5600.215969764155, 5636.943630563642, 5648.971755141198, 5666.660000399989, 5668.716564171693, 5480.506754392124, 5548.77926856091, 5601.767611125546, 5646.576506761927, 5677.0, 5494.587905907153, 5508.366537848199, 5534.391216966211, 5554.222408862682, 5565.415631358811, 5385.596080293915, 5580.0, 5741.598088133791, 5749.942500575108, 5753.252077229933, 5585.720713964204, 5591.664500130005, 5593.105103183471, 5596.048671725735, 5598.216249725123], "value": 4213.556379190721, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [748.6406524868064, 754.2344520311883, 768.1320108277646, 768.7539987204093, 772.1159272632832, 11996.640100796969, 12265.202761820476, 13723.107997980123, 14490.927545362258, 14492.565223043326, 14423.855761442383, 14544.272786360692, 14548.127112373239, 14559.199244041574, 14626.634334141625, 647.5726020826255, 813.1055838577562, 823.180934969706, 824.1511243419287, 824.3899514359391, 798.704479342644, 825.2325337436182, 829.7510746775973, 829.9336053115736, 832.2509741232878, 855.7133360324299, 863.8401895649293, 866.7356456280831, 866.8613021916494, 867.0332579174207, 847.6100993542947, 851.638053827124, 858.5192292316323, 859.1022381611232, 860.2300940658076, 629.0909635576594, 630.0486265738767, 630.7382436288934, 630.7792272704562, 632.7279269913935, 12336.321502317369, 12390.0, 12395.876041239653, 12416.255024698547, 12433.129680922339, 12475.126741128124, 12546.309952952584, 12585.307808070553, 12600.55898043564, 12841.165324253894, 9911.801763964753, 9912.454814985173, 10008.699739007841, 10243.948780256125, 10246.026627470379, 3270.8528116234825, 3299.2081900343983, 3301.6203136639356, 3309.2057906102605, 3371.578552680915, 45181.0, 45192.548074519495, 45675.0, 45918.770406147756, 46028.539714603095, 9873.703788886201, 10056.145227655585, 10082.49587520621, 10098.0, 10162.644307449204, 16966.406175783788, 17034.318627254772, 17048.403305884236, 17090.230939607747, 17092.2308496118, 6002.189704389939, 6008.188894499274, 6146.078088286793, 6224.875502490016, 6264.123022776815, 3665.17533554948, 3717.4052151655605, 3751.9249615007548, 3784.1674831537016, 3808.7333886628226, 2725.8909643614033, 2801.7618502427113, 2810.12886005339, 2811.943761124766, 2819.4502072095743, 494.7921872813355, 501.83941138835223, 510.7318657704661, 513.7970501651827, 514.4135685318739, 548.240686648994, 554.919536667181, 607.5716619783042, 625.3465128940269, 644.452215616722, 7449.739259125905, 7460.14208366034, 7720.112187098443, 7793.571353575608, 7855.175206603339, 537.4007981101045, 576.7145263094795, 586.6919867069737, 604.8608819971344, 610.9725062372204, 3597.9280414392088, 3643.307771523402, 3681.705463562962, 3716.498272733146, 3756.436534519844, 47738.28392574114, 49067.75466122646, 49286.75356623194, 49325.26012109821, 49512.50487495079, 41665.37501937473, 43758.0, 43847.12305753867, 44393.778031109636, 44703.55296447059, 39076.41385379222, 39317.0, 39402.0, 40374.798126009184, 40678.59321406748, 7225.132984041738, 7285.526440781332, 7396.106790826602, 7437.628118593941, 7443.702251909863, 24908.252752417455, 25368.492630146924, 25699.614505782803, 26430.603540946515, 29208.853955730086, 33855.15362115967, 33925.49111763375, 34130.317393651494, 34470.48294275538, 35135.82432087823, 10759.13926885863, 10982.231243813176, 11011.0, 11044.613438529614, 11127.666170014912, 12138.271703697807, 12260.509579616715, 12300.446479908605, 12452.0, 12563.12058155957, 10890.673279801618, 11175.21773475849, 11366.488508017324, 11603.245789023686, 11988.220765650205, 10930.56277748881, 10996.340219586851, 11330.37682927447, 11375.772484550098, 11580.131490138441, 10770.569177233136, 10777.299475534066, 10963.342199468058, 11163.609273675382, 11530.827037594276, 9756.60973561078, 9855.753606159617, 9867.55595998196, 9942.403455792675, 10014.3490673106, 9134.97985077614, 9412.435253884789, 9744.045167916252, 9826.16477599412, 9835.114839664464], "value": 5911.375514201125, "unit": "score"}], "name": "dromaeo_css", "value": 6408.428612003313, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 108.0, 114.0, 113.0, 115.0, 127.0, 120.0, 120.0, 116.0, 117.0], "value": 116.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 133.0, 161.0, 176.0, 138.0, 162.0, 157.0, 138.0, 181.0, 136.0], "value": 153.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 165.0, 163.0, 164.0, 164.0, 167.0, 166.0, 165.0, 167.0, 169.0], "value": 165.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 74.0, 78.0, 74.0, 73.0, 78.0, 74.0, 145.0, 76.0, 75.0], "value": 82.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 135.0, 95.0, 95.0, 94.0, 146.0, 95.0, 95.0, 130.0], "value": 107.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 118.0, 117.0, 117.0, 118.0, 117.0, 118.0, 117.0, 118.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 147.0, 147.0, 147.0, 146.0, 147.0, 148.0, 147.0, 147.0, 147.0], "value": 147.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 99.0, 101.0, 97.0], "value": 97.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 70.0, 66.0, 68.0, 66.0, 66.0, 67.0, 67.0, 68.0, 63.0], "value": 66.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 65.0, 63.0, 64.0, 64.0, 66.0, 65.0, 65.0], "value": 64.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 88.0, 93.0, 84.0, 84.0, 85.0, 85.0, 98.0, 83.0], "value": 87.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 148.0, 141.0, 139.0, 142.0, 141.0, 153.0, 144.0, 145.0, 143.0], "value": 143.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 172.0, 178.0, 176.0, 175.0, 169.0, 174.0, 170.0, 172.0, 177.0], "value": 173.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 72.0, 71.0, 75.0, 79.0, 71.0, 71.0, 69.0, 69.0, 70.0], "value": 71.9, "unit": "score"}], "name": "kraken", "value": 1595.3999999999999, "alertThreshold": 2.0}]} 21:07:12 INFO - Return code: 0 21:07:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 21:07:12 ERROR - # TBPL SUCCESS # 21:07:12 INFO - Running post-action listener: _resource_record_post_action 21:07:12 INFO - Running post-run listener: _resource_record_post_run 21:07:13 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 4096; Write bytes: 299843584; Read time: 4; Write time: 220476 21:07:13 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 22028288; Read time: 0; Write time: 15392 21:07:13 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 4096; Write bytes: 277454848; Read time: 4; Write time: 205060 21:07:13 INFO - Running post-run listener: _upload_blobber_files 21:07:13 INFO - Blob upload gear active. 21:07:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:07: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 21:07: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'] 21:07: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 21:07:14 INFO - (blobuploader) - INFO - Open directory for files ... 21:07:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 21:07:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:07:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:07:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 21:07:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:07:14 INFO - (blobuploader) - INFO - Done attempting. 21:07:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 21:07:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:07:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:07:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 21:07:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:07:15 INFO - (blobuploader) - INFO - Done attempting. 21:07:15 INFO - (blobuploader) - INFO - Iteration through files over. 21:07:15 INFO - Return code: 0 21:07:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:07:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:07: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/65f0b6233b1d13916e1c1978f8b22fd5b5b9630b557cdbd880e897a5f7ddf9605f82a08d9304e597139ef56b6fd699c49b4eac7ae543285799f9c64033b1a8df", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/596b9ad7821ba0c6d40398c057d1354ab398dd2bcd20e1add2589313ae4e4cbb9d96443ac1136d64bb6021e907b7eb858798f831b05f7c977386162c10931382"} 21:07:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:07:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:07:15 INFO - Contents: 21:07:15 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/65f0b6233b1d13916e1c1978f8b22fd5b5b9630b557cdbd880e897a5f7ddf9605f82a08d9304e597139ef56b6fd699c49b4eac7ae543285799f9c64033b1a8df", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/596b9ad7821ba0c6d40398c057d1354ab398dd2bcd20e1add2589313ae4e4cbb9d96443ac1136d64bb6021e907b7eb858798f831b05f7c977386162c10931382"} 21:07:15 INFO - Running post-run listener: copy_logs_to_upload_dir 21:07:15 INFO - Copying logs to upload dir... 21:07:15 INFO - mkdir: /builds/slave/test/build/upload/logs 21:07:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.776422 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-04-07 21:07:15.480253) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-07 21:07:15.483767) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1460086771.369701-532901744 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/65f0b6233b1d13916e1c1978f8b22fd5b5b9630b557cdbd880e897a5f7ddf9605f82a08d9304e597139ef56b6fd699c49b4eac7ae543285799f9c64033b1a8df", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/596b9ad7821ba0c6d40398c057d1354ab398dd2bcd20e1add2589313ae4e4cbb9d96443ac1136d64bb6021e907b7eb858798f831b05f7c977386162c10931382"} build_url:https://queue.taskcluster.net/v1/task/F9p3J0xnTNmJoBYMObrXAQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011415 build_url: 'https://queue.taskcluster.net/v1/task/F9p3J0xnTNmJoBYMObrXAQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/65f0b6233b1d13916e1c1978f8b22fd5b5b9630b557cdbd880e897a5f7ddf9605f82a08d9304e597139ef56b6fd699c49b4eac7ae543285799f9c64033b1a8df", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/596b9ad7821ba0c6d40398c057d1354ab398dd2bcd20e1add2589313ae4e4cbb9d96443ac1136d64bb6021e907b7eb858798f831b05f7c977386162c10931382"}' ========= master_lag: 0.04 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-07 21:07:15.532827) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 21:07:15.533224) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1460086771.369701-532901744 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004503 ========= master_lag: 0.06 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 21:07:15.600785) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-07 21:07:15.601152) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-07 21:07:15.601483) ========= ========= Total master_lag: 0.91 =========