builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-013 starttime: 1460545875.36 results: success (0) buildid: 20160413024753 builduid: fbad9248ff8b4627b6cf0cec25b487f0 revision: ea707a9243907d2e89337d01ecf7c66f5f543a86 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-13 04:11:15.358119) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-13 04:11:15.358882) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-13 04:11:15.359167) ========= 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-1460543755.142896-294655275 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006494 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-13 04:11:15.383690) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-13 04:11:15.383962) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-13 04:11:15.400428) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 04:11:15.400722) ========= 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-1460543755.142896-294655275 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004650 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 04:11:15.451471) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-13 04:11:15.451774) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-13 04:11:15.452124) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 04:11:15.452409) ========= 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-1460543755.142896-294655275 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-13 04:11:15-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 11.7M=0.001s 2016-04-13 04:11:16 (11.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.157064 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 04:11:15.624836) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 04:11:15.625250) ========= 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-1460543755.142896-294655275 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018838 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 04:11:15.676706) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 04:11:15.677031) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev ea707a9243907d2e89337d01ecf7c66f5f543a86 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev ea707a9243907d2e89337d01ecf7c66f5f543a86 --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-1460543755.142896-294655275 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-13 04:11:16,230 truncating revision to first 12 chars 2016-04-13 04:11:16,230 Setting DEBUG logging. 2016-04-13 04:11:16,230 attempt 1/10 2016-04-13 04:11:16,230 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/ea707a924390?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-13 04:11:16,509 unpacking tar archive at: mozilla-central-ea707a924390/testing/mozharness/ program finished with exit code 0 elapsedTime=0.565234 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 04:11:16.256789) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-13 04:11:16.257417) ========= echo ea707a9243907d2e89337d01ecf7c66f5f543a86 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'ea707a9243907d2e89337d01ecf7c66f5f543a86'] 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-1460543755.142896-294655275 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False ea707a9243907d2e89337d01ecf7c66f5f543a86 program finished with exit code 0 elapsedTime=0.004333 script_repo_revision: 'ea707a9243907d2e89337d01ecf7c66f5f543a86' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-13 04:11:16.309952) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-13 04:11:16.310313) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-13 04:11:16.324260) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-04-13 04:11:16.324567) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-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', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-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-1460543755.142896-294655275 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:11:16 INFO - MultiFileLogger online at 20160413 04:11:16 in /builds/slave/test 04:11:16 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 04:11:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:11:16 INFO - {'append_to_log': False, 04:11:16 INFO - 'base_work_dir': '/builds/slave/test', 04:11:16 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 04:11:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:11:16 INFO - 'branch': 'Firefox-Non-PGO', 04:11:16 INFO - 'buildbot_json_path': 'buildprops.json', 04:11:16 INFO - 'config_files': ('talos/linux_config.py',), 04:11:16 INFO - 'default_actions': ('clobber', 04:11:16 INFO - 'read-buildbot-config', 04:11:16 INFO - 'download-and-extract', 04:11:16 INFO - 'populate-webroot', 04:11:16 INFO - 'create-virtualenv', 04:11:16 INFO - 'install', 04:11:16 INFO - 'run-tests'), 04:11:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:11:16 INFO - 'download_minidump_stackwalk': True, 04:11:16 INFO - 'download_symbols': 'ondemand', 04:11:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:11:16 INFO - 'tooltool.py': '/tools/tooltool.py', 04:11:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:11:16 INFO - '/tools/misc-python/virtualenv.py')}, 04:11:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:11:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:11:16 INFO - 'installer_path': 'installer.exe', 04:11:16 INFO - 'log_level': 'info', 04:11:16 INFO - 'log_name': 'talos', 04:11:16 INFO - 'log_to_console': True, 04:11:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:11:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:11:16 INFO - 'opt_config_files': (), 04:11:16 INFO - 'pip_index': False, 04:11:16 INFO - 'sps_profile': False, 04:11:16 INFO - 'sps_profile_interval': 0, 04:11:16 INFO - 'suite': 'dromaeojs-e10s', 04:11:16 INFO - 'system_bits': '32', 04:11:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:11:16 INFO - 'title': 'talos-linux64-ix-013', 04:11:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:11:16 INFO - 'use_talos_json': True, 04:11:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:11:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:11:16 INFO - 'work_dir': 'build'} 04:11:16 INFO - ##### 04:11:16 INFO - ##### Running clobber step. 04:11:16 INFO - ##### 04:11:16 INFO - Running pre-action listener: _resource_record_pre_action 04:11:16 INFO - Running main action method: clobber 04:11:16 INFO - rmtree: /builds/slave/test/build 04:11:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:11:17 INFO - Running post-action listener: _resource_record_post_action 04:11:17 INFO - ##### 04:11:17 INFO - ##### Running read-buildbot-config step. 04:11:17 INFO - ##### 04:11:17 INFO - Running pre-action listener: _resource_record_pre_action 04:11:17 INFO - Running main action method: read_buildbot_config 04:11:17 INFO - Using buildbot properties: 04:11:17 INFO - { 04:11:17 INFO - "project": "", 04:11:17 INFO - "product": "firefox", 04:11:17 INFO - "script_repo_revision": "production", 04:11:17 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 04:11:17 INFO - "repository": "", 04:11:17 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 04:11:17 INFO - "buildid": "20160413024753", 04:11:17 INFO - "pgo_build": "False", 04:11:17 INFO - "basedir": "/builds/slave/test", 04:11:17 INFO - "buildnumber": 285, 04:11:17 INFO - "slavename": "talos-linux64-ix-013", 04:11:17 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 04:11:17 INFO - "platform": "ubuntu64_hw", 04:11:17 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 04:11:17 INFO - "branch": "mozilla-central", 04:11:17 INFO - "repo_path": "mozilla-central", 04:11:17 INFO - "revision": "ea707a9243907d2e89337d01ecf7c66f5f543a86", 04:11:17 INFO - "stage_platform": "linux64", 04:11:17 INFO - "builduid": "fbad9248ff8b4627b6cf0cec25b487f0", 04:11:17 INFO - "slavebuilddir": "test" 04:11:17 INFO - } 04:11:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/Nb9cKTHgSZyScC6jY5zW5Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 04:11:17 INFO - Running post-action listener: _resource_record_post_action 04:11:17 INFO - ##### 04:11:17 INFO - ##### Running download-and-extract step. 04:11:17 INFO - ##### 04:11:17 INFO - Running pre-action listener: _resource_record_pre_action 04:11:17 INFO - Running main action method: download_and_extract 04:11:17 INFO - mkdir: /builds/slave/test/build/tests 04:11:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:11:17 INFO - https://queue.taskcluster.net/v1/task/Nb9cKTHgSZyScC6jY5zW5Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:11:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nb9cKTHgSZyScC6jY5zW5Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 04:11:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nb9cKTHgSZyScC6jY5zW5Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 04:11:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nb9cKTHgSZyScC6jY5zW5Q/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 04:11:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nb9cKTHgSZyScC6jY5zW5Q/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 04:11:25 INFO - Downloaded 1361 bytes. 04:11:25 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 04:11:25 INFO - Using the following test package requirements: 04:11:25 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 04:11:25 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:11:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:11:25 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:11:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:11:25 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:11:25 INFO - u'jsshell-linux-x86_64.zip'], 04:11:25 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:11:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:11:25 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 04:11:25 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:11:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:11:25 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:11:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:11:25 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:11:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:11:25 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:11:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:11:25 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:11:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:11:25 INFO - https://queue.taskcluster.net/v1/task/Nb9cKTHgSZyScC6jY5zW5Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:11:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nb9cKTHgSZyScC6jY5zW5Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:11:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nb9cKTHgSZyScC6jY5zW5Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:11:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nb9cKTHgSZyScC6jY5zW5Q/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 04:11:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nb9cKTHgSZyScC6jY5zW5Q/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 04:11:28 INFO - Downloaded 22197441 bytes. 04:11:28 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'] 04:11:28 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 04:11:29 INFO - Return code: 0 04:11:29 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 04:11:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:11:29 INFO - https://queue.taskcluster.net/v1/task/Nb9cKTHgSZyScC6jY5zW5Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:11:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nb9cKTHgSZyScC6jY5zW5Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:11:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nb9cKTHgSZyScC6jY5zW5Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:11:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nb9cKTHgSZyScC6jY5zW5Q/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 04:11:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nb9cKTHgSZyScC6jY5zW5Q/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 04:11:37 INFO - Downloaded 22197441 bytes. 04:11:37 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'] 04:11:37 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 04:11:39 INFO - Return code: 0 04:11: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')]} 04:11:39 INFO - https://queue.taskcluster.net/v1/task/Nb9cKTHgSZyScC6jY5zW5Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:11:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nb9cKTHgSZyScC6jY5zW5Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 04:11:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nb9cKTHgSZyScC6jY5zW5Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 04:11:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nb9cKTHgSZyScC6jY5zW5Q/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 04:11:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nb9cKTHgSZyScC6jY5zW5Q/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 04:11:40 INFO - Downloaded 10841076 bytes. 04:11:40 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'] 04:11:40 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 04:11:40 INFO - Return code: 0 04:11:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:11:40 INFO - https://queue.taskcluster.net/v1/task/Nb9cKTHgSZyScC6jY5zW5Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:11:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nb9cKTHgSZyScC6jY5zW5Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:11:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nb9cKTHgSZyScC6jY5zW5Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:11:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nb9cKTHgSZyScC6jY5zW5Q/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 04:11:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nb9cKTHgSZyScC6jY5zW5Q/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 04:11:42 INFO - Downloaded 54119602 bytes. 04:11:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Nb9cKTHgSZyScC6jY5zW5Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:11:42 INFO - mkdir: /builds/slave/test/properties 04:11:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:11:42 INFO - Writing to file /builds/slave/test/properties/build_url 04:11:42 INFO - Contents: 04:11:42 INFO - build_url:https://queue.taskcluster.net/v1/task/Nb9cKTHgSZyScC6jY5zW5Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:11:43 INFO - Running post-action listener: _resource_record_post_action 04:11:43 INFO - Running post-action listener: set_extra_try_arguments 04:11:43 INFO - ##### 04:11:43 INFO - ##### Running populate-webroot step. 04:11:43 INFO - ##### 04:11:43 INFO - Running pre-action listener: _resource_record_pre_action 04:11:43 INFO - Running main action method: populate_webroot 04:11:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:11:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:11:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:11:43 INFO - '--tppagecycles', 04:11:43 INFO - '7'], 04:11:43 INFO - 'tests': ['tsvgm']}}, 04:11:43 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:11:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:11:43 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:11:43 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:11:43 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:11:43 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:11:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:11:43 INFO - 'talos_options': ['--disable-e10s'], 04:11:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:11:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:11:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:11:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:11:43 INFO - 'talos_options': ['--disable-e10s'], 04:11:43 INFO - 'tests': ['damp', 'tps']}, 04:11:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:11:43 INFO - 'tests': ['damp', 'tps']}, 04:11:43 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:11:43 INFO - 'tests': ['dromaeo_dom']}, 04:11:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:11:43 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:11:43 INFO - 'tests': ['a11yr', 04:11:43 INFO - 'ts_paint', 04:11:43 INFO - 'tpaint', 04:11:43 INFO - 'sessionrestore', 04:11:43 INFO - 'sessionrestore_no_auto_restore', 04:11:43 INFO - 'tabpaint']}, 04:11:43 INFO - 'other-e10s': {'tests': ['a11yr', 04:11:43 INFO - 'ts_paint', 04:11:43 INFO - 'tpaint', 04:11:43 INFO - 'sessionrestore', 04:11:43 INFO - 'sessionrestore_no_auto_restore', 04:11:43 INFO - 'tabpaint']}, 04:11:43 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:11:43 INFO - 'ts_paint', 04:11:43 INFO - 'tpaint', 04:11:43 INFO - 'sessionrestore', 04:11:43 INFO - 'sessionrestore_no_auto_restore', 04:11:43 INFO - 'tabpaint']}, 04:11:43 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:11:43 INFO - 'ts_paint', 04:11:43 INFO - 'tpaint', 04:11:43 INFO - 'sessionrestore', 04:11:43 INFO - 'sessionrestore_no_auto_restore', 04:11:43 INFO - 'tabpaint']}, 04:11:43 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:11:43 INFO - 'tests': ['a11yr', 04:11:43 INFO - 'ts_paint', 04:11:43 INFO - 'tpaint', 04:11:43 INFO - 'sessionrestore', 04:11:43 INFO - 'sessionrestore_no_auto_restore', 04:11:43 INFO - 'tabpaint']}, 04:11:43 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:11:43 INFO - 'tests': ['a11yr', 04:11:43 INFO - 'ts_paint', 04:11:43 INFO - 'tpaint', 04:11:43 INFO - 'sessionrestore', 04:11:43 INFO - 'sessionrestore_no_auto_restore', 04:11:43 INFO - 'tabpaint']}, 04:11:43 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:11:43 INFO - 'tests': ['tsvgx', 04:11:43 INFO - 'tsvgr_opacity', 04:11:43 INFO - 'tart', 04:11:43 INFO - 'tscrollx', 04:11:43 INFO - 'cart']}, 04:11:43 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:11:43 INFO - 'tsvgr_opacity', 04:11:43 INFO - 'tart', 04:11:43 INFO - 'tscrollx', 04:11:43 INFO - 'cart']}, 04:11:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:11:43 INFO - 'talos_options': ['--disable-e10s'], 04:11:43 INFO - 'tests': ['tp5o']}, 04:11:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:11:43 INFO - 'tests': ['tp5o']}, 04:11:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:11:43 INFO - 'talos_options': ['--disable-e10s', 04:11:43 INFO - '--xperf_path', 04:11:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:11:43 INFO - 'tests': ['tp5n']}, 04:11:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:11:43 INFO - 'talos_options': ['--xperf_path', 04:11:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:11:43 INFO - 'tests': ['tp5n']}}, 04:11:43 INFO - 'talos.zip': {'path': '', 04:11:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:11:43 INFO - Running post-action listener: _resource_record_post_action 04:11:43 INFO - ##### 04:11:43 INFO - ##### Running create-virtualenv step. 04:11:43 INFO - ##### 04:11:43 INFO - Running pre-action listener: _resource_record_pre_action 04:11:43 INFO - Running main action method: create_virtualenv 04:11:43 INFO - Creating virtualenv /builds/slave/test/build/venv 04:11:43 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 04:11:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:11:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:11:43 INFO - Using real prefix '/usr' 04:11:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:11:43 INFO - Installing distribute.............................................................................................................................................................................................done. 04:11:45 INFO - Installing pip.................done. 04:11:45 INFO - Return code: 0 04:11:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:11:45 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')]} 04:11:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:11:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:45 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')]} 04:11:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:11:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:45 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 0x7fe0d8e39f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14625a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f1410>, '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 0x14f2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14f27a0>, '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-1460543755.142896-294655275', '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 04:11:45 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 04:11:45 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 04:11:45 INFO - Using env: {'DISPLAY': ':0', 04:11:45 INFO - 'HOME': '/home/cltbld', 04:11:45 INFO - 'LANG': 'en_US.UTF-8', 04:11:45 INFO - 'LANGUAGE': 'en_US:en', 04:11:45 INFO - 'LOGNAME': 'cltbld', 04:11:45 INFO - 'MAIL': '/var/mail/cltbld', 04:11:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:11:45 INFO - 'MOZ_NO_REMOTE': '1', 04:11:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:11:45 INFO - 'NO_EM_RESTART': '1', 04:11:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:11:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:11:45 INFO - 'PWD': '/builds/slave/test', 04:11:45 INFO - 'SHELL': '/bin/bash', 04:11:45 INFO - 'SHLVL': '1', 04:11:45 INFO - 'TERM': 'linux', 04:11:45 INFO - 'TMOUT': '86400', 04:11:45 INFO - 'USER': 'cltbld', 04:11:45 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1460543755.142896-294655275', 04:11:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:11:45 INFO - '_': '/tools/buildbot/bin/python'} 04:11:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:11:45 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 04:11:45 INFO - Cleaning up... 04:11:45 INFO - Return code: 0 04:11:45 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:11:45 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')]} 04:11:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:11:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:45 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')]} 04:11:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:11:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:45 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 0x7fe0d8e39f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14625a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f1410>, '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 0x14f2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14f27a0>, '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-1460543755.142896-294655275', '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 04:11:45 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 04:11:45 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 04:11:45 INFO - Using env: {'DISPLAY': ':0', 04:11:45 INFO - 'HOME': '/home/cltbld', 04:11:45 INFO - 'LANG': 'en_US.UTF-8', 04:11:45 INFO - 'LANGUAGE': 'en_US:en', 04:11:45 INFO - 'LOGNAME': 'cltbld', 04:11:45 INFO - 'MAIL': '/var/mail/cltbld', 04:11:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:11:45 INFO - 'MOZ_NO_REMOTE': '1', 04:11:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:11:45 INFO - 'NO_EM_RESTART': '1', 04:11:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:11:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:11:45 INFO - 'PWD': '/builds/slave/test', 04:11:45 INFO - 'SHELL': '/bin/bash', 04:11:45 INFO - 'SHLVL': '1', 04:11:45 INFO - 'TERM': 'linux', 04:11:45 INFO - 'TMOUT': '86400', 04:11:45 INFO - 'USER': 'cltbld', 04:11:45 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1460543755.142896-294655275', 04:11:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:11:45 INFO - '_': '/tools/buildbot/bin/python'} 04:11:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:11:46 INFO - Downloading/unpacking psutil>=0.7.1 04:11:46 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 04:11:46 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 04:11:46 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 04:11:46 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 04:11:46 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 04:11:46 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 04:11:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:11:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:11:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:11:48 INFO - Installing collected packages: psutil 04:11:48 INFO - Running setup.py install for psutil 04:11:48 INFO - building 'psutil._psutil_linux' extension 04:11:48 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 04:11:48 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 04:11:48 INFO - building 'psutil._psutil_posix' extension 04:11:48 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 04:11:48 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 04:11:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:11:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:11:48 INFO - Successfully installed psutil 04:11:48 INFO - Cleaning up... 04:11:48 INFO - Return code: 0 04:11:48 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:11: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')]} 04:11:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:11:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11: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')]} 04:11:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:11:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11: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', '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 0x7fe0d8e39f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14625a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f1410>, '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 0x14f2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14f27a0>, '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-1460543755.142896-294655275', '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 04:11: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 04:11: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 mozsystemmonitor==0.0.0 04:11:48 INFO - Using env: {'DISPLAY': ':0', 04:11:48 INFO - 'HOME': '/home/cltbld', 04:11:48 INFO - 'LANG': 'en_US.UTF-8', 04:11:48 INFO - 'LANGUAGE': 'en_US:en', 04:11:48 INFO - 'LOGNAME': 'cltbld', 04:11:48 INFO - 'MAIL': '/var/mail/cltbld', 04:11:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:11:48 INFO - 'MOZ_NO_REMOTE': '1', 04:11:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:11:48 INFO - 'NO_EM_RESTART': '1', 04:11:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:11:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:11:48 INFO - 'PWD': '/builds/slave/test', 04:11:48 INFO - 'SHELL': '/bin/bash', 04:11:48 INFO - 'SHLVL': '1', 04:11:48 INFO - 'TERM': 'linux', 04:11:48 INFO - 'TMOUT': '86400', 04:11:48 INFO - 'USER': 'cltbld', 04:11:48 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1460543755.142896-294655275', 04:11:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:11:48 INFO - '_': '/tools/buildbot/bin/python'} 04:11:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:11:48 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:11:48 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 04:11:48 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 04:11:48 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 04:11:48 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 04:11:48 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 04:11:48 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 04:11:50 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:11:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:11:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:11:50 INFO - Installing collected packages: mozsystemmonitor 04:11:50 INFO - Running setup.py install for mozsystemmonitor 04:11:50 INFO - Successfully installed mozsystemmonitor 04:11:50 INFO - Cleaning up... 04:11:50 INFO - Return code: 0 04:11:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:11:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:11:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:11:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:11:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:11:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fe0d8e39f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14625a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f1410>, '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 0x14f2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14f27a0>, '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-1460543755.142896-294655275', '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 04:11:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:11:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:11:50 INFO - Using env: {'DISPLAY': ':0', 04:11:50 INFO - 'HOME': '/home/cltbld', 04:11:50 INFO - 'LANG': 'en_US.UTF-8', 04:11:50 INFO - 'LANGUAGE': 'en_US:en', 04:11:50 INFO - 'LOGNAME': 'cltbld', 04:11:50 INFO - 'MAIL': '/var/mail/cltbld', 04:11:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:11:50 INFO - 'MOZ_NO_REMOTE': '1', 04:11:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:11:50 INFO - 'NO_EM_RESTART': '1', 04:11:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:11:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:11:50 INFO - 'PWD': '/builds/slave/test', 04:11:50 INFO - 'SHELL': '/bin/bash', 04:11:50 INFO - 'SHLVL': '1', 04:11:50 INFO - 'TERM': 'linux', 04:11:50 INFO - 'TMOUT': '86400', 04:11:50 INFO - 'USER': 'cltbld', 04:11:50 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1460543755.142896-294655275', 04:11:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:11:50 INFO - '_': '/tools/buildbot/bin/python'} 04:11:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:11:51 INFO - Downloading/unpacking blobuploader==1.2.4 04:11:51 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 04:11:51 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 04:11:51 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 04:11:51 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 04:11:51 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 04:11:51 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 04:11:53 INFO - Downloading blobuploader-1.2.4.tar.gz 04:11:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:11:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:11:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:11:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:11:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:11:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:11:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:11:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:11:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:11:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:11:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:11:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:11:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:11:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:11:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:11:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:11:53 INFO - Downloading docopt-0.6.1.tar.gz 04:11:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:11:53 INFO - Installing collected packages: blobuploader, requests, docopt 04:11:53 INFO - Running setup.py install for blobuploader 04:11:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:11:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:11:53 INFO - Running setup.py install for requests 04:11:54 INFO - Running setup.py install for docopt 04:11:54 INFO - Successfully installed blobuploader requests docopt 04:11:54 INFO - Cleaning up... 04:11:54 INFO - Return code: 0 04:11:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:11: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')]} 04:11:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:11:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11: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')]} 04:11:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:11:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:54 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 0x7fe0d8e39f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14625a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f1410>, '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 0x14f2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14f27a0>, '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-1460543755.142896-294655275', '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 04:11:54 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 04:11:54 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 04:11:54 INFO - Using env: {'DISPLAY': ':0', 04:11:54 INFO - 'HOME': '/home/cltbld', 04:11:54 INFO - 'LANG': 'en_US.UTF-8', 04:11:54 INFO - 'LANGUAGE': 'en_US:en', 04:11:54 INFO - 'LOGNAME': 'cltbld', 04:11:54 INFO - 'MAIL': '/var/mail/cltbld', 04:11:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:11:54 INFO - 'MOZ_NO_REMOTE': '1', 04:11:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:11:54 INFO - 'NO_EM_RESTART': '1', 04:11:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:11:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:11:54 INFO - 'PWD': '/builds/slave/test', 04:11:54 INFO - 'SHELL': '/bin/bash', 04:11:54 INFO - 'SHLVL': '1', 04:11:54 INFO - 'TERM': 'linux', 04:11:54 INFO - 'TMOUT': '86400', 04:11:54 INFO - 'USER': 'cltbld', 04:11:54 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1460543755.142896-294655275', 04:11:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:11:54 INFO - '_': '/tools/buildbot/bin/python'} 04:11:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:11:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:11:54 INFO - Running setup.py (path:/tmp/pip-RoQo5T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:11:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:11:54 INFO - Running setup.py (path:/tmp/pip-h0arWP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:11:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:11:54 INFO - Running setup.py (path:/tmp/pip-pfXLRi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:11:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:11:54 INFO - Running setup.py (path:/tmp/pip-ghP7zC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:11:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:11:54 INFO - Running setup.py (path:/tmp/pip-cBT38D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:11:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:11:54 INFO - Running setup.py (path:/tmp/pip-b1eM_V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:11:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:11:55 INFO - Running setup.py (path:/tmp/pip-FAQdmj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:11:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:11:55 INFO - Running setup.py (path:/tmp/pip-eNbJZ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:11:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:11:55 INFO - Running setup.py (path:/tmp/pip-3K9_VL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:11:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:11:55 INFO - Running setup.py (path:/tmp/pip-Zs_dcX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:11:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:11:55 INFO - Running setup.py (path:/tmp/pip-7jX_Rl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:11:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:11:55 INFO - Running setup.py (path:/tmp/pip-foOMQq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:11:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:11:55 INFO - Running setup.py (path:/tmp/pip-uTVIR9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:11:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:11:55 INFO - Running setup.py (path:/tmp/pip-oJCUiH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:11:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:11:55 INFO - Running setup.py (path:/tmp/pip-l9qOlN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:11:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:11:55 INFO - Running setup.py (path:/tmp/pip-rw0z6Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:11:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:11:55 INFO - Running setup.py (path:/tmp/pip-KzyNqd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:11:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:11:55 INFO - Running setup.py install for manifestparser 04:11:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:11:55 INFO - Running setup.py install for mozcrash 04:11:56 INFO - Running setup.py install for mozdebug 04:11:56 INFO - Running setup.py install for mozdevice 04:11:56 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:11:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:11:56 INFO - Running setup.py install for mozfile 04:11:56 INFO - Running setup.py install for mozhttpd 04:11:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:11:56 INFO - Running setup.py install for mozinfo 04:11:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:11:56 INFO - Running setup.py install for mozInstall 04:11:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:11:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:11:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:11:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:11:56 INFO - Running setup.py install for mozleak 04:11:56 INFO - Running setup.py install for mozlog 04:11:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:11:56 INFO - Running setup.py install for moznetwork 04:11:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:11:57 INFO - Running setup.py install for mozprocess 04:11:57 INFO - Running setup.py install for mozprofile 04:11:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:11:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:11:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:11:57 INFO - Running setup.py install for mozrunner 04:11:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:11:57 INFO - Running setup.py install for mozscreenshot 04:11:57 INFO - Running setup.py install for moztest 04:11:57 INFO - Running setup.py install for mozversion 04:11:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:11:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:11:57 INFO - Cleaning up... 04:11:57 INFO - Return code: 0 04:11:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:11:57 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')]} 04:11:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:11:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:57 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')]} 04:11:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:11:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:57 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 0x7fe0d8e39f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14625a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f1410>, '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 0x14f2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14f27a0>, '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-1460543755.142896-294655275', '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 04:11:57 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 04:11:57 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 04:11:57 INFO - Using env: {'DISPLAY': ':0', 04:11:57 INFO - 'HOME': '/home/cltbld', 04:11:57 INFO - 'LANG': 'en_US.UTF-8', 04:11:57 INFO - 'LANGUAGE': 'en_US:en', 04:11:57 INFO - 'LOGNAME': 'cltbld', 04:11:57 INFO - 'MAIL': '/var/mail/cltbld', 04:11:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:11:57 INFO - 'MOZ_NO_REMOTE': '1', 04:11:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:11:57 INFO - 'NO_EM_RESTART': '1', 04:11:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:11:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:11:57 INFO - 'PWD': '/builds/slave/test', 04:11:57 INFO - 'SHELL': '/bin/bash', 04:11:57 INFO - 'SHLVL': '1', 04:11:57 INFO - 'TERM': 'linux', 04:11:57 INFO - 'TMOUT': '86400', 04:11:57 INFO - 'USER': 'cltbld', 04:11:57 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1460543755.142896-294655275', 04:11:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:11:57 INFO - '_': '/tools/buildbot/bin/python'} 04:11:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:11:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:11:57 INFO - Running setup.py (path:/tmp/pip-DMKONG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:11:57 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)) 04:11:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:11:57 INFO - Running setup.py (path:/tmp/pip-gEPmB0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:11:58 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)) 04:11:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:11:58 INFO - Running setup.py (path:/tmp/pip-D4b07W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:11:58 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)) 04:11:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:11:58 INFO - Running setup.py (path:/tmp/pip-yrhw9w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:11:58 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)) 04:11:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:11:58 INFO - Running setup.py (path:/tmp/pip-CJotNf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:11:58 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)) 04:11:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:11:58 INFO - Running setup.py (path:/tmp/pip-_RRuGy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:11:58 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)) 04:11:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:11:58 INFO - Running setup.py (path:/tmp/pip-8AOrtn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:11:58 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)) 04:11:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:11:58 INFO - Running setup.py (path:/tmp/pip-8aG3GS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:11:58 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)) 04:11:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:11:58 INFO - Running setup.py (path:/tmp/pip-oi8E2Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:11:58 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)) 04:11:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:11:58 INFO - Running setup.py (path:/tmp/pip-Fg0kcf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:11:58 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)) 04:11:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:11:58 INFO - Running setup.py (path:/tmp/pip-U2trrH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:11:58 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)) 04:11:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:11:58 INFO - Running setup.py (path:/tmp/pip-lexaIP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:11:58 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)) 04:11:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:11:58 INFO - Running setup.py (path:/tmp/pip-VADQTN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:11:58 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)) 04:11:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:11:58 INFO - Running setup.py (path:/tmp/pip-wYJJ5W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:11:58 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)) 04:11:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:11:58 INFO - Running setup.py (path:/tmp/pip-cPngiJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:11:58 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)) 04:11:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:11:59 INFO - Running setup.py (path:/tmp/pip-o11hOb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:11:59 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)) 04:11:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:11:59 INFO - Running setup.py (path:/tmp/pip-DL1Hwo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:11:59 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)) 04:11:59 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)) 04:11:59 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)) 04:11:59 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)) 04:11:59 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)) 04:11:59 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)) 04:11:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:11:59 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 04:11:59 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 04:11:59 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 04:11:59 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 04:11:59 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 04:11:59 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 04:12:00 INFO - Downloading blessings-1.6.tar.gz 04:12:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:12:01 INFO - Installing collected packages: blessings 04:12:01 INFO - Running setup.py install for blessings 04:12:01 INFO - Successfully installed blessings 04:12:01 INFO - Cleaning up... 04:12:01 INFO - Return code: 0 04:12:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:12:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:12:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:12:01 INFO - Reading from file tmpfile_stdout 04:12:01 INFO - Current package versions: 04:12:01 INFO - argparse == 1.2.1 04:12:01 INFO - blessings == 1.6 04:12:01 INFO - blobuploader == 1.2.4 04:12:01 INFO - docopt == 0.6.1 04:12:01 INFO - manifestparser == 1.1 04:12:01 INFO - mozInstall == 1.12 04:12:01 INFO - mozcrash == 0.17 04:12:01 INFO - mozdebug == 0.1 04:12:01 INFO - mozdevice == 0.48 04:12:01 INFO - mozfile == 1.2 04:12:01 INFO - mozhttpd == 0.7 04:12:01 INFO - mozinfo == 0.9 04:12:01 INFO - mozleak == 0.1 04:12:01 INFO - mozlog == 3.1 04:12:01 INFO - moznetwork == 0.27 04:12:01 INFO - mozprocess == 0.22 04:12:01 INFO - mozprofile == 0.28 04:12:01 INFO - mozrunner == 6.11 04:12:01 INFO - mozscreenshot == 0.1 04:12:01 INFO - mozsystemmonitor == 0.0 04:12:01 INFO - moztest == 0.7 04:12:01 INFO - mozversion == 1.4 04:12:01 INFO - psutil == 3.1.1 04:12:01 INFO - requests == 1.2.3 04:12:01 INFO - wsgiref == 0.1.2 04:12:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:12:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:12:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:12:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:12:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:12:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:01 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 0x7fe0d8e39f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14625a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f1410>, '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 0x14f2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14f27a0>, '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-1460543755.142896-294655275', '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 04:12:01 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 04:12:01 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 04:12:01 INFO - Using env: {'DISPLAY': ':0', 04:12:01 INFO - 'HOME': '/home/cltbld', 04:12:01 INFO - 'LANG': 'en_US.UTF-8', 04:12:01 INFO - 'LANGUAGE': 'en_US:en', 04:12:01 INFO - 'LOGNAME': 'cltbld', 04:12:01 INFO - 'MAIL': '/var/mail/cltbld', 04:12:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:12:01 INFO - 'MOZ_NO_REMOTE': '1', 04:12:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:12:01 INFO - 'NO_EM_RESTART': '1', 04:12:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:12:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:12:01 INFO - 'PWD': '/builds/slave/test', 04:12:01 INFO - 'SHELL': '/bin/bash', 04:12:01 INFO - 'SHLVL': '1', 04:12:01 INFO - 'TERM': 'linux', 04:12:01 INFO - 'TMOUT': '86400', 04:12:01 INFO - 'USER': 'cltbld', 04:12:01 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1460543755.142896-294655275', 04:12:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:12:01 INFO - '_': '/tools/buildbot/bin/python'} 04:12:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:12:01 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)) 04:12:01 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)) 04:12:01 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)) 04:12:01 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)) 04:12:01 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)) 04:12:01 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)) 04:12:01 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)) 04:12:01 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)) 04:12:01 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)) 04:12:01 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)) 04:12:01 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)) 04:12:01 INFO - Cleaning up... 04:12:01 INFO - Return code: 0 04:12:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:12:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:12:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:12:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:12:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:12:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:01 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 0x7fe0d8e39f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14625a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f1410>, '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 0x14f2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14f27a0>, '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-1460543755.142896-294655275', '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 04:12:01 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 04:12:01 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 04:12:01 INFO - Using env: {'DISPLAY': ':0', 04:12:01 INFO - 'HOME': '/home/cltbld', 04:12:01 INFO - 'LANG': 'en_US.UTF-8', 04:12:01 INFO - 'LANGUAGE': 'en_US:en', 04:12:01 INFO - 'LOGNAME': 'cltbld', 04:12:01 INFO - 'MAIL': '/var/mail/cltbld', 04:12:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:12:01 INFO - 'MOZ_NO_REMOTE': '1', 04:12:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:12:01 INFO - 'NO_EM_RESTART': '1', 04:12:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:12:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:12:01 INFO - 'PWD': '/builds/slave/test', 04:12:01 INFO - 'SHELL': '/bin/bash', 04:12:01 INFO - 'SHLVL': '1', 04:12:01 INFO - 'TERM': 'linux', 04:12:01 INFO - 'TMOUT': '86400', 04:12:01 INFO - 'USER': 'cltbld', 04:12:01 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1460543755.142896-294655275', 04:12:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:12:01 INFO - '_': '/tools/buildbot/bin/python'} 04:12:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:12:01 INFO - Downloading/unpacking jsonschema 04:12:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:12:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:12:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:12:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:12:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:12:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:12:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:12:03 INFO - Downloading/unpacking functools32 (from jsonschema) 04:12: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 04:12: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 04:12: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 04:12: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 04:12: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 04:12: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 04:12:04 INFO - Downloading functools32-3.2.3-2.tar.gz 04:12:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:12:04 INFO - warning: no files found matching '*.txt' 04:12:04 INFO - no previously-included directories found matching 'build' 04:12:04 INFO - no previously-included directories found matching 'dist' 04:12:04 INFO - no previously-included directories found matching '.git*' 04:12:04 INFO - Installing collected packages: jsonschema, functools32 04:12:04 INFO - Running setup.py install for functools32 04:12:04 INFO - warning: no files found matching '*.txt' 04:12:04 INFO - no previously-included directories found matching 'build' 04:12:04 INFO - no previously-included directories found matching 'dist' 04:12:04 INFO - no previously-included directories found matching '.git*' 04:12:04 INFO - Successfully installed jsonschema functools32 04:12:04 INFO - Cleaning up... 04:12:04 INFO - Return code: 0 04:12:04 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:12:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:12:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:12:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:12:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:12:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:04 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 0x7fe0d8e39f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14625a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f1410>, '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 0x14f2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14f27a0>, '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-1460543755.142896-294655275', '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 04:12:04 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 04:12:04 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 04:12:04 INFO - Using env: {'DISPLAY': ':0', 04:12:04 INFO - 'HOME': '/home/cltbld', 04:12:04 INFO - 'LANG': 'en_US.UTF-8', 04:12:04 INFO - 'LANGUAGE': 'en_US:en', 04:12:04 INFO - 'LOGNAME': 'cltbld', 04:12:04 INFO - 'MAIL': '/var/mail/cltbld', 04:12:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:12:04 INFO - 'MOZ_NO_REMOTE': '1', 04:12:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:12:04 INFO - 'NO_EM_RESTART': '1', 04:12:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:12:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:12:04 INFO - 'PWD': '/builds/slave/test', 04:12:04 INFO - 'SHELL': '/bin/bash', 04:12:04 INFO - 'SHLVL': '1', 04:12:04 INFO - 'TERM': 'linux', 04:12:04 INFO - 'TMOUT': '86400', 04:12:04 INFO - 'USER': 'cltbld', 04:12:04 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1460543755.142896-294655275', 04:12:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:12:04 INFO - '_': '/tools/buildbot/bin/python'} 04:12:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:12:04 INFO - Downloading/unpacking flake8 04:12:04 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 04:12:04 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 04:12:04 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 04:12:04 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 04:12:04 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 04:12:04 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 04:12:06 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:12:06 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:12:06 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 04:12:06 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 04:12:06 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 04:12:06 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 04:12:06 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 04:12:06 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 04:12:06 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:12:06 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:12:06 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 04:12:06 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 04:12:06 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 04:12:06 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 04:12:06 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 04:12:06 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 04:12:06 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:12:06 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 04:12:06 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 04:12:06 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 04:12:06 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 04:12:06 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 04:12:06 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 04:12:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:12:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:12:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:12:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:12:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:12:07 INFO - no previously-included directories found matching 'docs/_build' 04:12:07 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:12:07 INFO - Running setup.py install for pep8 04:12:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:12:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:12:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:12:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:12:07 INFO - no previously-included directories found matching 'docs/_build' 04:12:07 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:12:07 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:12:07 INFO - Cleaning up... 04:12:07 INFO - Return code: 0 04:12:07 INFO - Running post-action listener: _resource_record_post_action 04:12:07 INFO - Running post-action listener: _start_resource_monitoring 04:12:07 INFO - Starting resource monitoring. 04:12:07 INFO - ##### 04:12:07 INFO - ##### Running install step. 04:12:07 INFO - ##### 04:12:07 INFO - Running pre-action listener: _resource_record_pre_action 04:12:07 INFO - Running main action method: install 04:12:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:12:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:12:07 INFO - Reading from file tmpfile_stdout 04:12:07 INFO - Detecting whether we're running mozinstall >=1.0... 04:12:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:12:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:12:07 INFO - Reading from file tmpfile_stdout 04:12:07 INFO - Output received: 04:12:07 INFO - Usage: mozinstall [options] installer 04:12:07 INFO - Options: 04:12:07 INFO - -h, --help show this help message and exit 04:12:07 INFO - -d DEST, --destination=DEST 04:12:07 INFO - Directory to install application into. [default: 04:12:07 INFO - "/builds/slave/test"] 04:12:07 INFO - --app=APP Application being installed. [default: firefox] 04:12:07 INFO - mkdir: /builds/slave/test/build/application 04:12:07 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'] 04:12:07 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 04:12:23 INFO - Reading from file tmpfile_stdout 04:12:23 INFO - Output received: 04:12:23 INFO - /builds/slave/test/build/application/firefox/firefox 04:12:23 INFO - Running post-action listener: _resource_record_post_action 04:12:23 INFO - ##### 04:12:23 INFO - ##### Running run-tests step. 04:12:23 INFO - ##### 04:12:23 INFO - Running pre-action listener: _resource_record_pre_action 04:12:23 INFO - Running main action method: run_tests 04:12:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:12:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:12:23 INFO - Python 2.7.3 04:12:23 INFO - Return code: 0 04:12:23 INFO - grabbing minidump binary from tooltool 04:12:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:12:23 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 0x14f1410>, '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 0x14f2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14f27a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:12:23 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 04:12:23 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 04:12:23 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:12:23 INFO - Return code: 0 04:12:23 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:12:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:12:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:12:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:12:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:12:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:12:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:12:24 INFO - Return code: 0 04:12:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Nb9cKTHgSZyScC6jY5zW5Q/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 04:12:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Nb9cKTHgSZyScC6jY5zW5Q/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 04:12:24 INFO - Using env: {'DISPLAY': ':0', 04:12:24 INFO - 'HOME': '/home/cltbld', 04:12:24 INFO - 'LANG': 'en_US.UTF-8', 04:12:24 INFO - 'LANGUAGE': 'en_US:en', 04:12:24 INFO - 'LOGNAME': 'cltbld', 04:12:24 INFO - 'MAIL': '/var/mail/cltbld', 04:12:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:12:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:12:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:12:24 INFO - 'MOZ_NO_REMOTE': '1', 04:12:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:12:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:12:24 INFO - 'NO_EM_RESTART': '1', 04:12:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:12:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:12:24 INFO - 'PWD': '/builds/slave/test', 04:12:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:12:24 INFO - 'SHELL': '/bin/bash', 04:12:24 INFO - 'SHLVL': '1', 04:12:24 INFO - 'TERM': 'linux', 04:12:24 INFO - 'TMOUT': '86400', 04:12:24 INFO - 'USER': 'cltbld', 04:12:24 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1460543755.142896-294655275', 04:12:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:12:24 INFO - '_': '/tools/buildbot/bin/python'} 04:12:24 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Nb9cKTHgSZyScC6jY5zW5Q/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 04:12:24 INFO - mozversion application_buildid: 20160413024753 04:12:24 INFO - mozversion application_changeset: ea707a9243907d2e89337d01ecf7c66f5f543a86 04:12:24 INFO - mozversion application_display_name: Nightly 04:12:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:12:24 INFO - mozversion application_name: Firefox 04:12:24 INFO - mozversion application_remotingname: firefox 04:12:24 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:12:24 INFO - mozversion application_vendor: Mozilla 04:12:24 INFO - mozversion application_version: 48.0a1 04:12:24 INFO - mozversion platform_buildid: 20160413024753 04:12:24 INFO - mozversion platform_changeset: ea707a9243907d2e89337d01ecf7c66f5f543a86 04:12:24 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:12:24 INFO - mozversion platform_version: 48.0a1 04:12:24 INFO - using testdate: 1460545944 04:12:24 INFO - actual date: 1460545944 04:12:24 INFO - starting webserver on 'localhost:52674' 04:12:24 INFO - SUITE-START | Running 2 tests 04:12:24 INFO - TEST-START | dromaeo_css 04:12:24 INFO - operating with platform_type : linux_ 04:12:24 INFO - Initialising browser for dromaeo_css test... 04:12:24 INFO - TEST-INFO | started process 29577 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpb4op7u/profile http://localhost:52674/getInfo.html) 04:12:28 INFO - PROCESS | 29577 | 04:12:28 INFO - PROCESS | 29577 | (process:29646): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:12:28 INFO - PROCESS | 29577 | 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] 04:12:29 INFO - PROCESS | 29577 | __metrics Screen width/height:1600/1200 04:12:29 INFO - PROCESS | 29577 | colorDepth:24 04:12:29 INFO - PROCESS | 29577 | Browser inner width/height: 1024/697 04:12:29 INFO - PROCESS | 29577 | __metrics 04:12:30 ERROR - PROCESS | 29577 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 04:12:30 INFO - TEST-INFO | 29577: exit 0 04:12:30 INFO - Browser initialized. 04:12:30 INFO - Running cycle 1/1 for dromaeo_css test... 04:12:30 INFO - TEST-INFO | started process 29697 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpb4op7u/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:12:32 INFO - PROCESS | 29697 | 04:12:32 INFO - PROCESS | 29697 | (process:29758): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:12:42 INFO - PROCESS | 29697 | RSS: Main: 164274176 04:12:42 INFO - PROCESS | 29697 | 04:13:32 INFO - PROCESS | 29697 | 1460546012518 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] 04:15:44 INFO - PROCESS | 29697 | Cycle 1(1): loaded http://localhost:52674/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52674/tests/dromaeo/cssquery-ext.html) 04:15:45 INFO - PROCESS | 29697 | RSS: Main: 169312256 04:15:45 INFO - PROCESS | 29697 | 04:18:47 INFO - PROCESS | 29697 | Cycle 1(1): loaded http://localhost:52674/tests/dromaeo/cssquery-ext.html (next: http://localhost:52674/tests/dromaeo/cssquery-jquery.html) 04:18:47 INFO - PROCESS | 29697 | RSS: Main: 165281792 04:18:47 INFO - PROCESS | 29697 | 04:21:49 INFO - PROCESS | 29697 | Cycle 1(1): loaded http://localhost:52674/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52674/tests/dromaeo/cssquery-mootools.html) 04:21:50 INFO - PROCESS | 29697 | RSS: Main: 166477824 04:21:50 INFO - PROCESS | 29697 | 04:24:52 INFO - PROCESS | 29697 | Cycle 1(1): loaded http://localhost:52674/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52674/tests/dromaeo/cssquery-prototype.html) 04:24:52 INFO - PROCESS | 29697 | RSS: Main: 164331520 04:24:52 INFO - PROCESS | 29697 | 04:27:55 INFO - PROCESS | 29697 | Cycle 1(1): loaded http://localhost:52674/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52674/tests/dromaeo/cssquery-yui.html) 04:27:56 INFO - PROCESS | 29697 | RSS: Main: 166055936 04:27:56 INFO - PROCESS | 29697 | 04:30:58 INFO - PROCESS | 29697 | Cycle 1(1): loaded http://localhost:52674/tests/dromaeo/cssquery-yui.html (next: http://localhost:52674/tests/dromaeo/cssquery-dojo.html) 04:30:59 INFO - PROCESS | 29697 | RSS: Main: 167665664 04:30:59 INFO - PROCESS | 29697 | 04:30:59 INFO - PROCESS | 29697 | __start_tp_report 04:30:59 INFO - PROCESS | 29697 | _x_x_mozilla_page_load 04:30:59 INFO - PROCESS | 29697 | _x_x_mozilla_page_load_details 04:30:59 INFO - PROCESS | 29697 | |i|pagename|runs| 04:30:59 INFO - PROCESS | 29697 | |0;dojo.html;2618.4632150409166;2695.5282825505533;2696.568549032155;2741.7121202273747;2744.286485513766;4719.669623126382;4728.716277023381;4753.643476739246;4770.522947705236;4796.304535842305;4693.084848454553;4736.478987311393;4751.216049351861;4811.783469743861;4852.927206091911;4393.824247030115;4442.3558584005295;4465.419495465585;4537.3647689323525;4567.862964111066;4374.12517496502;4381.233284175272;4432.601065904068;4436.179306828231;4489.349044388562;4285.9571404286025;4379.08039311745;4397.406350142754;4425.800838962255;4432.822687092513;4407.493138289105;4418.977905110486;4434.800433980478;4440.600345968846;4484.237679594444;4362.454693163355;4409.779511024468;4417.977910110461;4436.933445998313;4446.5331140230455;4602.723836569783;4652.441706995149;4668.50980647034;4682.1338052460405;4723.338732577442;5094.2103973884105;5105.5915526758145;5106;5130.4613015633195;5156.303898973628;4981.327520784684;5079.720615366154;5115.028144652504;5176.5858731301405;5183.3261675981885;4798.448178459452;4830.879228019257;4843.9515604843855;4845.563899249085;4866.099771542276;5263.7894484220205;5292.682439053592;5293.338332708411;5295.179247216687;5299.947000529945;4898.755062246873;4911.214205727067;4986.925196122061;4988.977259661833;5049.267856160836;4970.378702662168;5082.796688132507;5137.998090372342;5165.638405311667;5198.402183748917;5062.443131255559;5096.082705113041;5106.5358270682555;5107.974460127675;5166.767495462713;4869.196582563908;4967.056259310792;5077.060743762416;5078.060558796635;5099.745012749422;4183.790810459464;4186.204621121977;4227.936580951288;4234;4248.91502169961;3660.9816950915074;3671.8531258749886;3684.6315368463474;3693.8153092345274;3711.888643340704;4369.300911854088;4440.844570440019;4443.555644435531;4480;4496.235639941217;5067.290579318898;5069.518395752398;5100.48995100487;5106.514881086365;5111.821086262037;4475.7985890635;4476.529964353696;4486.955130448719;4490.932636010462;4535.433070866142;4392.978035109804;4481.215787237221;4539.72761634303;4566.931496027562;4594.678372513892;4847.515248475124;4853.0779151961015;4854;4881.609471242363;4948.1835497142565;5145.485451454824;5187.066328060985;5195.272661827272;5196.116660167705;5220.347456567929;4674.252119660974;4855.198892182751;4865.9756701216265;4905.656604037826;4927.088488629472;5028.2960385546785;5028.522290382408;5033.119204139334;5046.116929537389;5080.974595127149;5007.349044624176;5111.821086262112;5133.383993920754;5137.974310128426;5144.151215049475;4810.783514741775;4917.852464426073;4919.754012299442;4983.426905905867;5015.072211640858;4877.780499877585;4896.706197628154;4905.90188196227;4910.383757273468;4954;4799.736014519235;4822.831200907952;4839;4885.022995401005;4896;4861.562459378673;4980.800767969386;5023;5057.31726216956;5062.139436295912;4856.902861942812;4861.1979023460735;4910.21436570147;4929.359183306147;4970.378702662168 04:30:59 INFO - PROCESS | 29697 | |1;ext.html;596.1653684841222;622.9595076320039;625.4277336237343;635.2726128582772;658.8254112660143;33860.15349616261;34920.12699682509;35311.64688353115;35392.11519712008;35411.4688279676;35977.28045439096;36495.45256821143;36635.450468243;36665.45001824975;36809.631903681024;7492.737754178618;7621.8475630487355;7646.235376462365;7674.695301798708;7691.807704807368;7593.2027137150635;7721.150673425918;7721.65252563636;7725.961370193141;7855.450118491708;7848.803779905491;7856.685732570691;7876.842463150733;7887.171846956073;7887.526748395115;7523.924760752405;7549.169591344975;7550.9622451887935;7553.093628764528;7573.772786816405;7744.070711514598;7848.7645370638975;7902.130765615778;7929.207079292082;7931.167227441151;28205.576916346272;35887.28225435503;36124.81937590295;36279.81860090709;36318.63681363179;2955.733983941456;2981.2993946422575;2985.7163569460868;3279.918002049944;3555.5555555555557;24725.752742472705;25588.744112558823;25642.48715025689;26176.214713558624;26371.34071648205;3047.4971629681077;3068.171593669697;3128.7966282191583;3160.5259211118287;3176.6188057433255;182406;184256;186637;186876;187090;31670.366592668477;31925.361492770015;31928;31946.361072778414;31961.680383196337;58775.11837322444;60044;60364.698176508835;60432.39567604267;60787;12651.114421990556;12745;12776.361181941053;12818.423170957329;12903.612891613267;9470.242380609672;9540.427574345422;9545.140937315675;9565.330426870192;9601.567929443192;17836.46490605284;17994.460166195036;18184.272629094954;18638.068096595114;18653.90673046626;7138.571685698875;7224.602646854369;7338.486305958531;7344.339009489172;7393.445491588152;878.8286284174525;928.572856486024;942.0532364973158;993.7366597851575;1011.2769369900557;26986.865065674545;28023.859880700875;28081;28087.157385278475;28181.71818281791;987.6444479987199;1018.4296793795498;1045.2892033417197;1084.4198353880636;1133.2350663302238;14518.854811451962;14911.254437278092;15003.474878379204;15077.623059423382;15163.317650705745;319860;321403;322486;324752;325569;46375.76812115918;47435;47530;47651.76174119107;47672.76163619159;1197.3297250335734;1220.8718084601167;1244.9875501245053;1263.2546797389584;1268.2707443220186;25730.742692572836;27111.59332610052;27377.178684639493;27686;27830.44339113166;40479.1904161921;40992.79503602463;41196.79401602973;41295.7935210322;41372.379414308205;292493;298394;300652;300699;301395;23228.76771232266;23329.53340933138;23425.648615271126;23449.882750586137;25313.62029569521;39360.6063939357;40149.59850401458;40767.388489172095;41250;41372.1725565493;33644.663553365135;35516.82241588879;35829.64170358367;35860.282794344486;36277.09307267234;35233.29533409266;35278.29443411169;35471;35583;35716.28567428689;32074.83962580172;35387.11532211612;35607;35912.82043589765;36671.63328366682;29386.161492415995;31062.534061988637;31126.68873311238;31135.68864311328;31282.843585781924;23578.882105589364;23732.288031359087;23943.683022702906;24060.639090414006;24438.63342049835 04:30:59 INFO - PROCESS | 29697 | |2;jquery.html;378.53251234725127;383.1341168958154;383.53400618248827;389.3789405897592;390.6074395232791;14496.130232186062;15071.095734255938;15211.315490802912;15229.543113706579;15305.1582162981;10285.177185825134;10599.894001059987;10896.564137434492;10913.618023369183;10937;4578.404807375036;4718.976405117986;4758.619310455173;4760.071786001731;5180.792768289264;5114.462981386957;5145.74271286436;5149.922751158736;5167.069927413064;5171.844844654666;4978.825741099062;5067.290579318898;5112.846614601568;5118.974405127988;5128.076946149691;5212.791488340462;5221.738913054351;5256.92114618281;5258.579313654898;5269.130593452076;4919.77860996256;5360.678359298455;5443.727813609304;5448.046591846411;5453.727313634303;11907.523699052113;12103.939480302543;12200.145989780718;14973.775393369107;19677.524185686132;1873.8688291819578;1954.5895361974003;2015.7077223802467;2069.8758074515576;2082.854200205986;8801.383903126783;9364.157225849638;10936.507857146367;13106.27915464649;13190.208587484782;1531;1543.074155506687;1552.7593223050333;1565.3190861975077;1573.4021071992684;62609.37390626081;64499;66166;66402.66798665976;66856.33143668549;9803.313768036169;9818.852717209247;9977.002299769965;10277.331973421704;10397.688069357931;14121.505747298796;14252.073615214978;14286;14321.713565728627;14323.928380358031;6772;6840.863182736417;6870.31296870309;6890.069840571559;6978.267281935425;6087.752010837768;6167.136600875881;6340.397662222082;6346.11154438379;6351.460125889351;4212.768297743653;4338.696291259582;4350.673699472489;4428.180786554498;4457.77711114443;1806.756087928139;1841.8526517878538;1892.48902796247;1902.7526421565385;1926.8554858385678;888.1917455115813;904.7894510449545;928.3640706116197;982.9606815727291;994.1897353656747;16312.836871631369;16369.672606547801;16544.50366489007;16812.621663737482;16890.069717732946;872.2106493623281;874.5627186406797;883.8409086364387;884.4074470105045;928.1785619726455;8874.517823807042;9308.674196403093;9325.533723313807;9376.48429336393;9488.810223795623;258847;394963.0251848722;397183;399630;415374;59584.40415595875;70429.29570704227;72369;73026;74730.62634686792;920.0431551186691;921.6037104045191;936.7143021378408;953.8330792111353;958.4776296918056;14881.404743810126;15016.92491537579;15057.17185554805;15153.318100685276;15514.146721930401;31783.364332713678;32098.35803283968;32945.67054329522;33189.83405082959;33999.32001360008;44580.32295489251;46510.76744616255;46888.765556172;47360.7631961838;47611.52388476071;7137.464690148156;7255.4921155520715;7397.852042959218;7429.517081389692;7842.137364889972;10272.178225742073;10857.782844343226;10899.455027248765;10976.176786740867;10995.615153469591;9475.57359918819;9698.127168554864;9701.611935522782;9724.173445257233;9819.509024548886;9451.952740236255;9758.658446954607;9809.460479673686;9810.215182785218;9848.113669769755;5882.176495290748;8025.719099831478;9671.17794987434;9672.75818104553;9898.901010989797;7406.629668516445;7462.10454745434;7599.050118735158;7614.390848731978;7636.694532218649;9026.638934442548;9473.384230025027;9494.335396522178;9719.125278724949;9743.561539730586 04:30:59 INFO - PROCESS | 29697 | |3;mootools.html;1455.7234125516154;1478.9778153327698;1624.2771966474922;1734.7137722275825;1790.167572078983;6761.1210542629515;7419.220981796914;7443.441741869361;7741.535507869525;7771.339436147927;7510.173880873113;7540.8114797129965;7546.547207167574;7584.203658615848;7626.275503827142;2199.912003519857;2242.3385101395047;2248.3142641494337;2251.0658076898067;2257.3566533537946;2169.913203471859;2177.042101475354;2190.660447630612;2191.616467118256;2192.4738062864876;2228.65455854342;2239.3393948785147;2246.9438264043447;2252.8986195621155;2278.3506700590333;2158.56828634273;2160.48148444373;2161.5784921940226;2176.4232478393237;2177.858439201447;2167.9132834686593;2172.543765809182;2176.5320456101854;2187.387531491185;2197.615417301966;7583.696652133908;7638.236176382317;7728.227177282227;7738.806529836743;7742.690292388298;4391.143726973241;4560.771961401917;4563.863084107482;4583.747893865836;4584.724916505021;2885.4373397187555;2953.3945541164226;2991.626046744157;3001.1746769638526;3015.095471358584;892.4154678685471;908.3006085314271;913.9314551408671;920.7559996600907;924.0297687428174;9862.65480708179;10115.039071288216;10120.392776433364;10153.390796552156;10182.898171018343;4028.7582745035393;4064.7357921734992;4146.523149837747;4176.895577610523;4202.243596152722;8107.1892810718455;8118.75643730689;8129.227723366271;8129.959350203211;8152.6331315090965;4352.455943007124;4384.364267181241;4399.670024748157;4475.977620111878;4481.417415735934;3525.206828463575;3994.660453861396;4126.814293356806;4164.229617520768;4172.4784401949755;3398.150462384404;3436.570428696413;3491.5635545556806;3504.737144714157;3530.717542596586;1003.1423133221136;1020.3214862116757;1024.359775140537;1037.061459379263;1049.239301506417;1160.7562411893598;1177.5760726138583;1206.6802297391198;1211.4427363412929;1227.1961864978275;7103.822404439827;7109.324614161646;7248.782536523912;7275.454340924452;7486.438517111238;985.6008316631776;1000.5897581991348;1003.708924411927;1012.711377257478;1092.4537731134433;5519.69641669704;5571.66570005801;5673.574481913873;5703.657780533182;5715.799947001835;8967.775805604912;9421.434713917188;9444.197243234403;9486.857697134548;9511;9351.158395744416;9536.475493847765;9546.236301095896;9582.616695332248;9584;7238.638068096574;7273.16358618755;7288.198298187195;7320.341169294789;7339.155997060299;7033.472489563405;7063.046488723957;7114.395276401564;7138.892916606359;7169.677364518505;8238.83522329562;8623.913760862311;8672.609732561923;8776.692815751418;8816.86774698393;8547.61535730906;8677.913220867711;8902.510361929897;8912;8959.328050396116;5817.214676018683;6518.804435866931;6541.542092053511;6637.037629543785;6772.661366931535;7305.3425191732995;7331.04696389466;7331.74338898136;7336.633168341668;7364.96317518409;6312.6528040956355;6333.65164915934;6342.746290148342;6556.573822701509;6645.534812563074;6697.464202863662;6697.53117281805;6700.865982680417;6720.663966801738;6752.209922752266;6976.790696279119;7001.334873187039;7053.753118640823;7064.752733654297;7065.964670176616;6143.354947730424;6176.81469555914;6201.937980620136;6209.720562574605;6288.685565721604;6231.563790534619;6316.336784637547;6322.430981211713;6325.082862984934;6334.42990130872 04:30:59 INFO - PROCESS | 29697 | |4;prototype.html;311.7147809754075;317.1120861587554;318.287037037037;320.7321886225002;324.40147927074554;5080.974595127024;5331.57347412207;5396.919046214305;5416.187571864212;5429.56563474922;5208.192730126827;5237.86905327367;5279.234510995913;5286.65636733613;5305.230741542484;3864.2271545690833;3958.386450100239;4062.3703325984447;4073.063195465045;4080.510338759353;4066.9796651016704;4070.409790580364;4078.8368465261356;4082.1631565528996;4091.3249313863175;4043.2519983802945;4059.2084543514025;4061.3298805697173;4063.553009168989;4079.7552146871135;3844.730868839182;4059.188162367509;4060.776657283848;4063.3904914262803;4070.5929407059352;3488.773229740084;3521.5774107107054;3533.469979503069;3543.4153364695053;3548.254866478043;4951.697460680764;4959.355283813081;4964.925526117111;4979.377577802775;4990.3762029746285;4666.393368862026;4668.649851261135;4679.64902632304;4685.4143232095985;4688.789004494772;5410.323709536308;5452.672839629635;5507.504324610764;5522.696251706155;5530.336359636829;3836.827342769582;3837.597052309495;3843.9231215375535;3845.557760857509;3848.730588858781;5721.856953576153;5747.304545159188;5847.766089356421;5860.941390586039;5873.089671100986;3843.8846834595006;3912.9608703912595;3915.0799562102884;3931.1548017176447;3949.170674158459;3973.6225058619384;4011;4017.337139371971;4021.2560676274397;4023.994001499625;4577.542245775462;4627.30590411441;4647.814087436533;4654.6741728078705;4672.322513235562;5253.106971814725;5549.084401073777;5561.6663000220115;5563.944360556424;5564.33228012641;1381.951631692886;1397.9720405591831;1402.978955315671;1403.073971179017;1403.7052219033912;919.558611866308;935.4574346878794;944.5230158769778;948.9715308540755;955.6511873166244;4760.952390476051;4790.568848803624;4974.577160941288;4979.975100124476;5010.173321401928;5692.6299790513485;5777.913331300034;5784.421557844182;5793.94206057934;5814.738336774855;4672.415948006499;4925.975370123127;4926.359573255526;4976.800927962841;4981.476944920803;3058.266016156151;3083;3084.706952839477;3099.6900309969274;3104.130843363862;5359.866003349869;5395.865103372447;5411;5435.402105768362;5458.8908221835345;5759.395263497357;5846.590738648339;5881.2942446906645;5899.646021238739;5914.172015917775;5401.648892821954;5408.378036525771;5420.457954204627;5442.5645948323245;5459.672419654833;5591.6365436246515;5742.483176514133;5773.509251713652;5774.42255774436;5779.190913272229;5615.298087739033;5647.3505546861;5662.631928924607;5674.716264186856;5699.287589051369;5404.459554044564;5409;5413.83758487246;5420.891582168413;5435.374931882884;3991.461152744342;4003.699722520764;4013.618706222904;4054.7430296608145;4068.715189936676;5577.386487486455;5600.439956004367;5613.242212301287;5635.0702134147405;5639.3232812062815;5395.514403703685;5412.215228791882;5423.728813559227;5440.29276194108;5456.072467680583;5136.640435169652;5399.5950303726595;5401.135818269058;5427.945720542902;5428.918566221589;5330.440303768203;5335.759890804846;5347.786088556414;5354.303940487712;5374.731263436891;5278.762455689426;5418.214358918013;5544.861378465571;5560.833175004756;5570.693611851387;5416.783328666809;5447.727613619382;5460.31746031746;5493.642913210629;5502.202180683858 04:30:59 INFO - PROCESS | 29697 | |5;yui.html;625.7434451874731;710.2045708806138;781.8123650323922;781.9530828150308;795.0459448661608;12209.633710988674;12295.508179672825;12322.199057061307;12373.319467429288;12401;11823.172377933548;12110.697232569168;12193.207441516295;12217.755644887096;12283.385830708474;807.6769292283075;814.4054839966827;816.008549612221;819.0867183090841;824.9546274954876;651.029965351625;803.3091541274499;831.4927893984665;832.4422636833336;832.5213002523543;857.995710021449;860.9053004169537;863.2489733931488;863.6804382378498;868.522312727997;846.2426128614917;851.6550796927254;853.3727710133016;853.4665833853842;858.3433673239977;627.231641239478;628.7547856336032;629.9401556852092;631.8294060603612;632.936706329368;11522.539098436053;11530.308181509052;11531.48108335127;11612.419379031015;11642.010429113536;12543.623691289276;12734.108612397136;12770.106092573524;12961.222326660336;13268.071235013553;9878.90121098787;10027.197824174049;10064.245181611408;10317.638882639072;10547.525361358757;4205.390218418343;4209.2633789086785;4209.915801683949;4218.936715949232;4219.831206751757;47026.529734702555;47029.52970470286;47106;48968.755156224346;49269.75365123187;9536.761580960532;9715.125638692552;9992.662660876182;10084.798304033879;10261.897381026243;17761.644767104586;18105.094745262948;18124.27502899869;18127.72808407875;18169.273229070954;6853.554518956252;6920.550164239308;7139.107611548557;7252.057232559733;7278.526895751759;3970.8014599269923;3999.060220848098;4030.0730831908827;4033.737807042533;4036.91926161481;2812.4937511247763;2877.136858942309;2877.985610071978;2885.0623547346777;2901.15866398742;517.7721802406929;517.816175257778;519.8570393141916;520.3391692550515;533.9359276886721;565.6888711208819;591.3524690463935;596.4244504053609;606.4329851588778;612.3937302070917;7430.851382972419;7925.722599708983;8228.876566851503;8270.131636178236;8297.672372420384;554.3181886279898;629;630.0895206426669;635.3519410201568;641.4868105515569;3525.665061819123;3592.191756854739;3660.04838741929;3660.7620504667643;3896.7272290939927;49642;49650.503494964585;49652.531272185675;49868.25197622039;50891;44127.77936110363;44422.33366499505;45037.54962450399;45728.77135614301;46042.76978615086;39356.80321598374;39910.401343979865;40498.59501405007;41270.58729412667;42533.36199957003;7832.960835195788;7916.44584879076;8323.250907418362;8366.414350995372;8574.185452382013;27800.44399111966;28938.710612893603;28951;29865.701342987162;31415.21461963469;36896.81551592225;36941.815290923376;41574.376384354866;42484;42849.35725964175;11133.165012624248;11217.66347009591;11284.605038823602;11430.428478576205;11522.769544608893;11198.552057917917;12079.939600301943;12382.380880956096;12819.615411537296;13328.733425331633;10401.635942741968;10511.264211505428;10643.361398316125;10669.35983840972;10961.12311015101;11062.778744425228;11470.426478675867;11491.942540287246;12062.215955962834;12090.93954530257;10929.78140437171;11456.713582160513;11496.770064598828;11551.595694150665;12147.696307592381;9321.953390233006;9353.719388418358;9644.565994530403;9710.417374957242;9751.951240243754;9871.309008369346;10063.345882517613;10120.645777397756;10136.645217417356;10138 04:30:59 INFO - PROCESS | 29697 | __end_tp_report 04:30:59 INFO - PROCESS | 29697 | __start_cc_report 04:30:59 INFO - PROCESS | 29697 | _x_x_mozilla_cycle_collect,373 04:30:59 INFO - PROCESS | 29697 | __end_cc_report 04:30:59 INFO - PROCESS | 29697 | __startTimestamp1460547059039__endTimestamp 04:30:59 INFO - PROCESS | 29697 | 04:30:59 INFO - PROCESS | 29697 | ------- Summary: start ------- 04:30:59 INFO - PROCESS | 29697 | Number of tests: 6 04:30:59 INFO - PROCESS | 29697 | 04:30:59 INFO - PROCESS | 29697 | [#0] dojo.html Cycles:165 Average:4717.62 Median:4855.20 stddev:495.49 (10.2%) stddev-sans-first:468.85 04:30:59 INFO - PROCESS | 29697 | Values: 2618.5 2695.5 2696.6 2741.7 2744.3 4719.7 4728.7 4753.6 4770.5 4796.3 4693.1 4736.5 4751.2 4811.8 4852.9 4393.8 4442.4 4465.4 4537.4 4567.9 4374.1 4381.2 4432.6 4436.2 4489.3 4286.0 4379.1 4397.4 4425.8 4432.8 4407.5 4419.0 4434.8 4440.6 4484.2 4362.5 4409.8 4418.0 4436.9 4446.5 4602.7 4652.4 4668.5 4682.1 4723.3 5094.2 5105.6 5106.0 5130.5 5156.3 4981.3 5079.7 5115.0 5176.6 5183.3 4798.4 4830.9 4844.0 4845.6 4866.1 5263.8 5292.7 5293.3 5295.2 5299.9 4898.8 4911.2 4986.9 4989.0 5049.3 4970.4 5082.8 5138.0 5165.6 5198.4 5062.4 5096.1 5106.5 5108.0 5166.8 4869.2 4967.1 5077.1 5078.1 5099.7 4183.8 4186.2 4227.9 4234.0 4248.9 3661.0 3671.9 3684.6 3693.8 3711.9 4369.3 4440.8 4443.6 4480.0 4496.2 5067.3 5069.5 5100.5 5106.5 5111.8 4475.8 4476.5 4487.0 4490.9 4535.4 4393.0 4481.2 4539.7 4566.9 4594.7 4847.5 4853.1 4854.0 4881.6 4948.2 5145.5 5187.1 5195.3 5196.1 5220.3 4674.3 4855.2 4866.0 4905.7 4927.1 5028.3 5028.5 5033.1 5046.1 5081.0 5007.3 5111.8 5133.4 5138.0 5144.2 4810.8 4917.9 4919.8 4983.4 5015.1 4877.8 4896.7 4905.9 4910.4 4954.0 4799.7 4822.8 4839.0 4885.0 4896.0 4861.6 4980.8 5023.0 5057.3 5062.1 4856.9 4861.2 4910.2 4929.4 4970.4 04:30:59 INFO - PROCESS | 29697 | 04:30:59 INFO - PROCESS | 29697 | [#1] ext.html Cycles:180 Average:41967.24 Median:35294.97 stddev:72392.42 (205.1%) stddev-sans-first:72528.86 04:30:59 INFO - PROCESS | 29697 | Values: 596.2 623.0 625.4 635.3 658.8 33860.2 34920.1 35311.6 35392.1 35411.5 35977.3 36495.5 36635.5 36665.5 36809.6 7492.7 7621.8 7646.2 7674.7 7691.8 7593.2 7721.2 7721.7 7726.0 7855.5 7848.8 7856.7 7876.8 7887.2 7887.5 7523.9 7549.2 7551.0 7553.1 7573.8 7744.1 7848.8 7902.1 7929.2 7931.2 28205.6 35887.3 36124.8 36279.8 36318.6 2955.7 2981.3 2985.7 3279.9 3555.6 24725.8 25588.7 25642.5 26176.2 26371.3 3047.5 3068.2 3128.8 3160.5 3176.6 182406.0 184256.0 186637.0 186876.0 187090.0 31670.4 31925.4 31928.0 31946.4 31961.7 58775.1 60044.0 60364.7 60432.4 60787.0 12651.1 12745.0 12776.4 12818.4 12903.6 9470.2 9540.4 9545.1 9565.3 9601.6 17836.5 17994.5 18184.3 18638.1 18653.9 7138.6 7224.6 7338.5 7344.3 7393.4 878.8 928.6 942.1 993.7 1011.3 26986.9 28023.9 28081.0 28087.2 28181.7 987.6 1018.4 1045.3 1084.4 1133.2 14518.9 14911.3 15003.5 15077.6 15163.3 319860.0 321403.0 322486.0 324752.0 325569.0 46375.8 47435.0 47530.0 47651.8 47672.8 1197.3 1220.9 1245.0 1263.3 1268.3 25730.7 27111.6 27377.2 27686.0 27830.4 40479.2 40992.8 41196.8 41295.8 41372.4 292493.0 298394.0 300652.0 300699.0 301395.0 23228.8 23329.5 23425.6 23449.9 25313.6 39360.6 40149.6 40767.4 41250.0 41372.2 33644.7 35516.8 35829.6 35860.3 36277.1 35233.3 35278.3 35471.0 35583.0 35716.3 32074.8 35387.1 35607.0 35912.8 36671.6 29386.2 31062.5 31126.7 31135.7 31282.8 23578.9 23732.3 23943.7 24060.6 24438.6 04:30:59 INFO - PROCESS | 29697 | 04:30:59 INFO - PROCESS | 29697 | [#2] jquery.html Cycles:180 Average:22756.44 Median:5136.91 stddev:62268.68 (1212.2%) stddev-sans-first:62420.69 04:30:59 INFO - PROCESS | 29697 | Values: 378.5 383.1 383.5 389.4 390.6 14496.1 15071.1 15211.3 15229.5 15305.2 10285.2 10599.9 10896.6 10913.6 10937.0 4578.4 4719.0 4758.6 4760.1 5180.8 5114.5 5145.7 5149.9 5167.1 5171.8 4978.8 5067.3 5112.8 5119.0 5128.1 5212.8 5221.7 5256.9 5258.6 5269.1 4919.8 5360.7 5443.7 5448.0 5453.7 11907.5 12103.9 12200.1 14973.8 19677.5 1873.9 1954.6 2015.7 2069.9 2082.9 8801.4 9364.2 10936.5 13106.3 13190.2 1531.0 1543.1 1552.8 1565.3 1573.4 62609.4 64499.0 66166.0 66402.7 66856.3 9803.3 9818.9 9977.0 10277.3 10397.7 14121.5 14252.1 14286.0 14321.7 14323.9 6772.0 6840.9 6870.3 6890.1 6978.3 6087.8 6167.1 6340.4 6346.1 6351.5 4212.8 4338.7 4350.7 4428.2 4457.8 1806.8 1841.9 1892.5 1902.8 1926.9 888.2 904.8 928.4 983.0 994.2 16312.8 16369.7 16544.5 16812.6 16890.1 872.2 874.6 883.8 884.4 928.2 8874.5 9308.7 9325.5 9376.5 9488.8 258847.0 394963.0 397183.0 399630.0 415374.0 59584.4 70429.3 72369.0 73026.0 74730.6 920.0 921.6 936.7 953.8 958.5 14881.4 15016.9 15057.2 15153.3 15514.1 31783.4 32098.4 32945.7 33189.8 33999.3 44580.3 46510.8 46888.8 47360.8 47611.5 7137.5 7255.5 7397.9 7429.5 7842.1 10272.2 10857.8 10899.5 10976.2 10995.6 9475.6 9698.1 9701.6 9724.2 9819.5 9452.0 9758.7 9809.5 9810.2 9848.1 5882.2 8025.7 9671.2 9672.8 9898.9 7406.6 7462.1 7599.1 7614.4 7636.7 9026.6 9473.4 9494.3 9719.1 9743.6 04:30:59 INFO - PROCESS | 29697 | 04:30:59 INFO - PROCESS | 29697 | [#3] mootools.html Cycles:180 Average:5313.19 Median:6314.49 stddev:2779.24 (44.0%) stddev-sans-first:2771.91 04:30:59 INFO - PROCESS | 29697 | Values: 1455.7 1479.0 1624.3 1734.7 1790.2 6761.1 7419.2 7443.4 7741.5 7771.3 7510.2 7540.8 7546.5 7584.2 7626.3 2199.9 2242.3 2248.3 2251.1 2257.4 2169.9 2177.0 2190.7 2191.6 2192.5 2228.7 2239.3 2246.9 2252.9 2278.4 2158.6 2160.5 2161.6 2176.4 2177.9 2167.9 2172.5 2176.5 2187.4 2197.6 7583.7 7638.2 7728.2 7738.8 7742.7 4391.1 4560.8 4563.9 4583.7 4584.7 2885.4 2953.4 2991.6 3001.2 3015.1 892.4 908.3 913.9 920.8 924.0 9862.7 10115.0 10120.4 10153.4 10182.9 4028.8 4064.7 4146.5 4176.9 4202.2 8107.2 8118.8 8129.2 8130.0 8152.6 4352.5 4384.4 4399.7 4476.0 4481.4 3525.2 3994.7 4126.8 4164.2 4172.5 3398.2 3436.6 3491.6 3504.7 3530.7 1003.1 1020.3 1024.4 1037.1 1049.2 1160.8 1177.6 1206.7 1211.4 1227.2 7103.8 7109.3 7248.8 7275.5 7486.4 985.6 1000.6 1003.7 1012.7 1092.5 5519.7 5571.7 5673.6 5703.7 5715.8 8967.8 9421.4 9444.2 9486.9 9511.0 9351.2 9536.5 9546.2 9582.6 9584.0 7238.6 7273.2 7288.2 7320.3 7339.2 7033.5 7063.0 7114.4 7138.9 7169.7 8238.8 8623.9 8672.6 8776.7 8816.9 8547.6 8677.9 8902.5 8912.0 8959.3 5817.2 6518.8 6541.5 6637.0 6772.7 7305.3 7331.0 7331.7 7336.6 7365.0 6312.7 6333.7 6342.7 6556.6 6645.5 6697.5 6697.5 6700.9 6720.7 6752.2 6976.8 7001.3 7053.8 7064.8 7066.0 6143.4 6176.8 6201.9 6209.7 6288.7 6231.6 6316.3 6322.4 6325.1 6334.4 04:30:59 INFO - PROCESS | 29697 | 04:30:59 INFO - PROCESS | 29697 | [#4] prototype.html Cycles:180 Average:4573.94 Median:5279.00 stddev:1343.10 (25.4%) stddev-sans-first:1308.22 04:30:59 INFO - PROCESS | 29697 | Values: 311.7 317.1 318.3 320.7 324.4 5081.0 5331.6 5396.9 5416.2 5429.6 5208.2 5237.9 5279.2 5286.7 5305.2 3864.2 3958.4 4062.4 4073.1 4080.5 4067.0 4070.4 4078.8 4082.2 4091.3 4043.3 4059.2 4061.3 4063.6 4079.8 3844.7 4059.2 4060.8 4063.4 4070.6 3488.8 3521.6 3533.5 3543.4 3548.3 4951.7 4959.4 4964.9 4979.4 4990.4 4666.4 4668.6 4679.6 4685.4 4688.8 5410.3 5452.7 5507.5 5522.7 5530.3 3836.8 3837.6 3843.9 3845.6 3848.7 5721.9 5747.3 5847.8 5860.9 5873.1 3843.9 3913.0 3915.1 3931.2 3949.2 3973.6 4011.0 4017.3 4021.3 4024.0 4577.5 4627.3 4647.8 4654.7 4672.3 5253.1 5549.1 5561.7 5563.9 5564.3 1382.0 1398.0 1403.0 1403.1 1403.7 919.6 935.5 944.5 949.0 955.7 4761.0 4790.6 4974.6 4980.0 5010.2 5692.6 5777.9 5784.4 5793.9 5814.7 4672.4 4926.0 4926.4 4976.8 4981.5 3058.3 3083.0 3084.7 3099.7 3104.1 5359.9 5395.9 5411.0 5435.4 5458.9 5759.4 5846.6 5881.3 5899.6 5914.2 5401.6 5408.4 5420.5 5442.6 5459.7 5591.6 5742.5 5773.5 5774.4 5779.2 5615.3 5647.4 5662.6 5674.7 5699.3 5404.5 5409.0 5413.8 5420.9 5435.4 3991.5 4003.7 4013.6 4054.7 4068.7 5577.4 5600.4 5613.2 5635.1 5639.3 5395.5 5412.2 5423.7 5440.3 5456.1 5136.6 5399.6 5401.1 5427.9 5428.9 5330.4 5335.8 5347.8 5354.3 5374.7 5278.8 5418.2 5544.9 5560.8 5570.7 5416.8 5447.7 5460.3 5493.6 5502.2 04:30:59 INFO - PROCESS | 29697 | 04:30:59 INFO - PROCESS | 29697 | [#5] yui.html Cycles:180 Average:12826.84 Median:4219.38 stddev:14244.88 (337.6%) stddev-sans-first:14255.37 04:30:59 INFO - PROCESS | 29697 | Values: 625.7 710.2 781.8 782.0 795.0 12209.6 12295.5 12322.2 12373.3 12401.0 11823.2 12110.7 12193.2 12217.8 12283.4 807.7 814.4 816.0 819.1 825.0 651.0 803.3 831.5 832.4 832.5 858.0 860.9 863.2 863.7 868.5 846.2 851.7 853.4 853.5 858.3 627.2 628.8 629.9 631.8 632.9 11522.5 11530.3 11531.5 11612.4 11642.0 12543.6 12734.1 12770.1 12961.2 13268.1 9878.9 10027.2 10064.2 10317.6 10547.5 4205.4 4209.3 4209.9 4218.9 4219.8 47026.5 47029.5 47106.0 48968.8 49269.8 9536.8 9715.1 9992.7 10084.8 10261.9 17761.6 18105.1 18124.3 18127.7 18169.3 6853.6 6920.6 7139.1 7252.1 7278.5 3970.8 3999.1 4030.1 4033.7 4036.9 2812.5 2877.1 2878.0 2885.1 2901.2 517.8 517.8 519.9 520.3 533.9 565.7 591.4 596.4 606.4 612.4 7430.9 7925.7 8228.9 8270.1 8297.7 554.3 629.0 630.1 635.4 641.5 3525.7 3592.2 3660.0 3660.8 3896.7 49642.0 49650.5 49652.5 49868.3 50891.0 44127.8 44422.3 45037.5 45728.8 46042.8 39356.8 39910.4 40498.6 41270.6 42533.4 7833.0 7916.4 8323.3 8366.4 8574.2 27800.4 28938.7 28951.0 29865.7 31415.2 36896.8 36941.8 41574.4 42484.0 42849.4 11133.2 11217.7 11284.6 11430.4 11522.8 11198.6 12079.9 12382.4 12819.6 13328.7 10401.6 10511.3 10643.4 10669.4 10961.1 11062.8 11470.4 11491.9 12062.2 12090.9 10929.8 11456.7 11496.8 11551.6 12147.7 9322.0 9353.7 9644.6 9710.4 9752.0 9871.3 10063.3 10120.6 10136.6 10138.0 04:30:59 INFO - PROCESS | 29697 | -------- Summary: end -------- 04:30:59 INFO - PROCESS | 29697 | 04:30:59 INFO - TEST-INFO | 29697: exit 0 04:30:59 INFO - TEST-OK | dromaeo_css | took 1115119ms 04:30:59 INFO - TEST-START | kraken 04:30:59 INFO - operating with platform_type : linux_ 04:30:59 INFO - Initialising browser for kraken test... 04:30:59 INFO - TEST-INFO | started process 29933 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4ggQT2/profile http://localhost:52674/getInfo.html) 04:31:03 INFO - PROCESS | 29933 | 04:31:03 INFO - PROCESS | 29933 | (process:29999): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:31:03 INFO - PROCESS | 29933 | 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] 04:31:04 INFO - PROCESS | 29933 | __metrics Screen width/height:1600/1200 04:31:04 INFO - PROCESS | 29933 | colorDepth:24 04:31:04 INFO - PROCESS | 29933 | Browser inner width/height: 1024/697 04:31:04 INFO - PROCESS | 29933 | __metrics 04:31:05 ERROR - PROCESS | 29933 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 04:31:06 INFO - TEST-INFO | 29933: exit 0 04:31:06 INFO - Browser initialized. 04:31:06 INFO - Running cycle 1/1 for kraken test... 04:31:06 INFO - TEST-INFO | started process 30050 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4ggQT2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:31:08 INFO - PROCESS | 30050 | 04:31:08 INFO - PROCESS | 30050 | (process:30110): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:31:18 INFO - PROCESS | 30050 | RSS: Main: 164573184 04:31:18 INFO - PROCESS | 30050 | 04:31:20 INFO - PROCESS | 30050 | Cycle 1(1): loaded http://localhost:52674/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52674/tests/kraken/driver.html?testName=audio-beat-detection) 04:31:21 INFO - PROCESS | 30050 | RSS: Main: 169304064 04:31:21 INFO - PROCESS | 30050 | 04:31:24 INFO - PROCESS | 30050 | Cycle 1(1): loaded http://localhost:52674/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52674/tests/kraken/driver.html?testName=audio-dft) 04:31:25 INFO - PROCESS | 30050 | RSS: Main: 172580864 04:31:25 INFO - PROCESS | 30050 | 04:31:28 INFO - PROCESS | 30050 | Cycle 1(1): loaded http://localhost:52674/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52674/tests/kraken/driver.html?testName=audio-fft) 04:31:28 INFO - PROCESS | 30050 | RSS: Main: 162676736 04:31:28 INFO - PROCESS | 30050 | 04:31:30 INFO - PROCESS | 30050 | Cycle 1(1): loaded http://localhost:52674/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52674/tests/kraken/driver.html?testName=audio-oscillator) 04:31:31 INFO - PROCESS | 30050 | RSS: Main: 163430400 04:31:31 INFO - PROCESS | 30050 | 04:31:33 INFO - PROCESS | 30050 | Cycle 1(1): loaded http://localhost:52674/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52674/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:31:34 INFO - PROCESS | 30050 | RSS: Main: 164696064 04:31:34 INFO - PROCESS | 30050 | 04:31:37 INFO - PROCESS | 30050 | Cycle 1(1): loaded http://localhost:52674/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52674/tests/kraken/driver.html?testName=imaging-darkroom) 04:31:38 INFO - PROCESS | 30050 | RSS: Main: 165019648 04:31:38 INFO - PROCESS | 30050 | 04:31:41 INFO - PROCESS | 30050 | Cycle 1(1): loaded http://localhost:52674/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52674/tests/kraken/driver.html?testName=imaging-desaturate) 04:31:42 INFO - PROCESS | 30050 | RSS: Main: 164564992 04:31:42 INFO - PROCESS | 30050 | 04:31:45 INFO - PROCESS | 30050 | Cycle 1(1): loaded http://localhost:52674/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52674/tests/kraken/driver.html?testName=json-parse-financial) 04:31:45 INFO - PROCESS | 30050 | RSS: Main: 164806656 04:31:45 INFO - PROCESS | 30050 | 04:31:47 INFO - PROCESS | 30050 | Cycle 1(1): loaded http://localhost:52674/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52674/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:31:48 INFO - PROCESS | 30050 | RSS: Main: 165056512 04:31:48 INFO - PROCESS | 30050 | 04:31:50 INFO - PROCESS | 30050 | Cycle 1(1): loaded http://localhost:52674/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52674/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:31:50 INFO - PROCESS | 30050 | RSS: Main: 165380096 04:31:50 INFO - PROCESS | 30050 | 04:31:52 INFO - PROCESS | 30050 | Cycle 1(1): loaded http://localhost:52674/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52674/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:31:53 INFO - PROCESS | 30050 | RSS: Main: 165568512 04:31:53 INFO - PROCESS | 30050 | 04:31:56 INFO - PROCESS | 30050 | Cycle 1(1): loaded http://localhost:52674/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52674/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:31:57 INFO - PROCESS | 30050 | RSS: Main: 166023168 04:31:57 INFO - PROCESS | 30050 | 04:32:00 INFO - PROCESS | 30050 | Cycle 1(1): loaded http://localhost:52674/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52674/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:32:00 INFO - PROCESS | 30050 | RSS: Main: 165605376 04:32:00 INFO - PROCESS | 30050 | 04:32:02 INFO - PROCESS | 30050 | Cycle 1(1): loaded http://localhost:52674/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52674/tests/kraken/driver.html?testName=ai-astar) 04:32:02 INFO - PROCESS | 30050 | RSS: Main: 166809600 04:32:02 INFO - PROCESS | 30050 | 04:32:02 INFO - PROCESS | 30050 | __start_tp_report 04:32:02 INFO - PROCESS | 30050 | _x_x_mozilla_page_load 04:32:02 INFO - PROCESS | 30050 | _x_x_mozilla_page_load_details 04:32:02 INFO - PROCESS | 30050 | |i|pagename|runs| 04:32:02 INFO - PROCESS | 30050 | |0;ai-astar;117;108;115;114;116;127;115;115;114;116 04:32:02 INFO - PROCESS | 30050 | |1;audio-beat-detection;159;132;158;198;136;162;163;134;199;136 04:32:02 INFO - PROCESS | 30050 | |2;audio-dft;164;164;166;176;164;161;163;163;165;164 04:32:02 INFO - PROCESS | 30050 | |3;audio-fft;79;75;74;160;77;74;74;74;151;75 04:32:02 INFO - PROCESS | 30050 | |4;audio-oscillator;95;95;140;94;94;94;139;94;94;136 04:32:02 INFO - PROCESS | 30050 | |5;imaging-gaussian-blur;117;117;117;122;118;122;117;118;118;118 04:32:02 INFO - PROCESS | 30050 | |6;imaging-darkroom;148;148;146;147;147;147;147;147;147;148 04:32:02 INFO - PROCESS | 30050 | |7;imaging-desaturate;96;97;96;96;96;96;96;95;96;96 04:32:02 INFO - PROCESS | 30050 | |8;json-parse-financial;65;64;66;64;65;66;65;86;63;62 04:32:02 INFO - PROCESS | 30050 | |9;json-stringify-tinderbox;64;64;64;64;65;64;65;65;65;64 04:32:02 INFO - PROCESS | 30050 | |10;stanford-crypto-aes;87;85;84;84;85;86;87;88;84;86 04:32:02 INFO - PROCESS | 30050 | |11;stanford-crypto-ccm;139;141;139;145;157;137;137;146;178;141 04:32:02 INFO - PROCESS | 30050 | |12;stanford-crypto-pbkdf2;181;183;182;176;177;175;188;183;178;174 04:32:02 INFO - PROCESS | 30050 | |13;stanford-crypto-sha256-iterative;75;77;72;73;74;73;72;75;73;74 04:32:02 INFO - PROCESS | 30050 | __end_tp_report 04:32:02 INFO - PROCESS | 30050 | __start_cc_report 04:32:02 INFO - PROCESS | 30050 | _x_x_mozilla_cycle_collect,905 04:32:02 INFO - PROCESS | 30050 | __end_cc_report 04:32:02 INFO - PROCESS | 30050 | __startTimestamp1460547122722__endTimestamp 04:32:02 INFO - PROCESS | 30050 | 04:32:02 INFO - PROCESS | 30050 | ------- Summary: start ------- 04:32:02 INFO - PROCESS | 30050 | Number of tests: 14 04:32:02 INFO - PROCESS | 30050 | 04:32:02 INFO - PROCESS | 30050 | [#0] ai-astar Cycles:10 Average:115.70 Median:115.50 stddev:4.67 (4.0%) stddev-sans-first:4.93 04:32:02 INFO - PROCESS | 30050 | Values: 117.0 108.0 115.0 114.0 116.0 127.0 115.0 115.0 114.0 116.0 04:32:02 INFO - PROCESS | 30050 | 04:32:02 INFO - PROCESS | 30050 | [#1] audio-beat-detection Cycles:10 Average:157.70 Median:160.50 stddev:24.82 (15.5%) stddev-sans-first:26.32 04:32:02 INFO - PROCESS | 30050 | Values: 159.0 132.0 158.0 198.0 136.0 162.0 163.0 134.0 199.0 136.0 04:32:02 INFO - PROCESS | 30050 | 04:32:02 INFO - PROCESS | 30050 | [#2] audio-dft Cycles:10 Average:165.00 Median:164.00 stddev:4.08 (2.5%) stddev-sans-first:4.31 04:32:02 INFO - PROCESS | 30050 | Values: 164.0 164.0 166.0 176.0 164.0 161.0 163.0 163.0 165.0 164.0 04:32:02 INFO - PROCESS | 30050 | 04:32:02 INFO - PROCESS | 30050 | [#3] audio-fft Cycles:10 Average:91.30 Median:74.50 stddev:33.94 (45.6%) stddev-sans-first:35.71 04:32:02 INFO - PROCESS | 30050 | Values: 79.0 75.0 74.0 160.0 77.0 74.0 74.0 74.0 151.0 75.0 04:32:02 INFO - PROCESS | 30050 | 04:32:02 INFO - PROCESS | 30050 | [#4] audio-oscillator Cycles:10 Average:107.50 Median:94.00 stddev:21.30 (22.7%) stddev-sans-first:22.11 04:32:02 INFO - PROCESS | 30050 | Values: 95.0 95.0 140.0 94.0 94.0 94.0 139.0 94.0 94.0 136.0 04:32:02 INFO - PROCESS | 30050 | 04:32:02 INFO - PROCESS | 30050 | [#5] imaging-gaussian-blur Cycles:10 Average:118.40 Median:118.00 stddev:1.96 (1.7%) stddev-sans-first:2.01 04:32:02 INFO - PROCESS | 30050 | Values: 117.0 117.0 117.0 122.0 118.0 122.0 117.0 118.0 118.0 118.0 04:32:02 INFO - PROCESS | 30050 | 04:32:02 INFO - PROCESS | 30050 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.00 stddev:0.63 (0.4%) stddev-sans-first:0.60 04:32:02 INFO - PROCESS | 30050 | Values: 148.0 148.0 146.0 147.0 147.0 147.0 147.0 147.0 147.0 148.0 04:32:02 INFO - PROCESS | 30050 | 04:32:02 INFO - PROCESS | 30050 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 04:32:02 INFO - PROCESS | 30050 | Values: 96.0 97.0 96.0 96.0 96.0 96.0 96.0 95.0 96.0 96.0 04:32:02 INFO - PROCESS | 30050 | 04:32:02 INFO - PROCESS | 30050 | [#8] json-parse-financial Cycles:10 Average:66.60 Median:65.00 stddev:6.93 (10.7%) stddev-sans-first:7.33 04:32:02 INFO - PROCESS | 30050 | Values: 65.0 64.0 66.0 64.0 65.0 66.0 65.0 86.0 63.0 62.0 04:32:02 INFO - PROCESS | 30050 | 04:32:02 INFO - PROCESS | 30050 | [#9] json-stringify-tinderbox Cycles:10 Average:64.40 Median:64.50 stddev:0.52 (0.8%) stddev-sans-first:0.53 04:32:02 INFO - PROCESS | 30050 | Values: 64.0 64.0 64.0 64.0 65.0 64.0 65.0 65.0 65.0 64.0 04:32:02 INFO - PROCESS | 30050 | 04:32:02 INFO - PROCESS | 30050 | [#10] stanford-crypto-aes Cycles:10 Average:85.60 Median:86.00 stddev:1.43 (1.7%) stddev-sans-first:1.42 04:32:02 INFO - PROCESS | 30050 | Values: 87.0 85.0 84.0 84.0 85.0 86.0 87.0 88.0 84.0 86.0 04:32:02 INFO - PROCESS | 30050 | 04:32:02 INFO - PROCESS | 30050 | [#11] stanford-crypto-ccm Cycles:10 Average:146.00 Median:143.00 stddev:12.72 (8.9%) stddev-sans-first:13.24 04:32:02 INFO - PROCESS | 30050 | Values: 139.0 141.0 139.0 145.0 157.0 137.0 137.0 146.0 178.0 141.0 04:32:02 INFO - PROCESS | 30050 | 04:32:02 INFO - PROCESS | 30050 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.70 Median:181.50 stddev:4.42 (2.4%) stddev-sans-first:4.67 04:32:02 INFO - PROCESS | 30050 | Values: 181.0 183.0 182.0 176.0 177.0 175.0 188.0 183.0 178.0 174.0 04:32:02 INFO - PROCESS | 30050 | 04:32:02 INFO - PROCESS | 30050 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.80 Median:74.00 stddev:1.55 (2.1%) stddev-sans-first:1.58 04:32:02 INFO - PROCESS | 30050 | Values: 75.0 77.0 72.0 73.0 74.0 73.0 72.0 75.0 73.0 74.0 04:32:02 INFO - PROCESS | 30050 | -------- Summary: end -------- 04:32:02 INFO - PROCESS | 30050 | 04:32:03 INFO - TEST-INFO | 30050: exit 0 04:32:03 INFO - TEST-OK | kraken | took 63992ms 04:32:03 INFO - SUITE-END | took 1179s 04:32:03 INFO - Completed test suite (00:19:39) 04:32:03 INFO - javascript benchmark 04:32:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2618.4632150409166, 2695.5282825505533, 2696.568549032155, 2741.7121202273747, 2744.286485513766, 4719.669623126382, 4728.716277023381, 4753.643476739246, 4770.522947705236, 4796.304535842305, 4693.084848454553, 4736.478987311393, 4751.216049351861, 4811.783469743861, 4852.927206091911, 4393.824247030115, 4442.3558584005295, 4465.419495465585, 4537.3647689323525, 4567.862964111066, 4374.12517496502, 4381.233284175272, 4432.601065904068, 4436.179306828231, 4489.349044388562, 4285.9571404286025, 4379.08039311745, 4397.406350142754, 4425.800838962255, 4432.822687092513, 4407.493138289105, 4418.977905110486, 4434.800433980478, 4440.600345968846, 4484.237679594444, 4362.454693163355, 4409.779511024468, 4417.977910110461, 4436.933445998313, 4446.5331140230455, 4602.723836569783, 4652.441706995149, 4668.50980647034, 4682.1338052460405, 4723.338732577442, 5094.2103973884105, 5105.5915526758145, 5106.0, 5130.4613015633195, 5156.303898973628, 4981.327520784684, 5079.720615366154, 5115.028144652504, 5176.5858731301405, 5183.3261675981885, 4798.448178459452, 4830.879228019257, 4843.9515604843855, 4845.563899249085, 4866.099771542276, 5263.7894484220205, 5292.682439053592, 5293.338332708411, 5295.179247216687, 5299.947000529945, 4898.755062246873, 4911.214205727067, 4986.925196122061, 4988.977259661833, 5049.267856160836, 4970.378702662168, 5082.796688132507, 5137.998090372342, 5165.638405311667, 5198.402183748917, 5062.443131255559, 5096.082705113041, 5106.5358270682555, 5107.974460127675, 5166.767495462713, 4869.196582563908, 4967.056259310792, 5077.060743762416, 5078.060558796635, 5099.745012749422, 4183.790810459464, 4186.204621121977, 4227.936580951288, 4234.0, 4248.91502169961, 3660.9816950915074, 3671.8531258749886, 3684.6315368463474, 3693.8153092345274, 3711.888643340704, 4369.300911854088, 4440.844570440019, 4443.555644435531, 4480.0, 4496.235639941217, 5067.290579318898, 5069.518395752398, 5100.48995100487, 5106.514881086365, 5111.821086262037, 4475.7985890635, 4476.529964353696, 4486.955130448719, 4490.932636010462, 4535.433070866142, 4392.978035109804, 4481.215787237221, 4539.72761634303, 4566.931496027562, 4594.678372513892, 4847.515248475124, 4853.0779151961015, 4854.0, 4881.609471242363, 4948.1835497142565, 5145.485451454824, 5187.066328060985, 5195.272661827272, 5196.116660167705, 5220.347456567929, 4674.252119660974, 4855.198892182751, 4865.9756701216265, 4905.656604037826, 4927.088488629472, 5028.2960385546785, 5028.522290382408, 5033.119204139334, 5046.116929537389, 5080.974595127149, 5007.349044624176, 5111.821086262112, 5133.383993920754, 5137.974310128426, 5144.151215049475, 4810.783514741775, 4917.852464426073, 4919.754012299442, 4983.426905905867, 5015.072211640858, 4877.780499877585, 4896.706197628154, 4905.90188196227, 4910.383757273468, 4954.0, 4799.736014519235, 4822.831200907952, 4839.0, 4885.022995401005, 4896.0, 4861.562459378673, 4980.800767969386, 5023.0, 5057.31726216956, 5062.139436295912, 4856.902861942812, 4861.1979023460735, 4910.21436570147, 4929.359183306147, 4970.378702662168], "value": 4686.143726408569, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [596.1653684841222, 622.9595076320039, 625.4277336237343, 635.2726128582772, 658.8254112660143, 33860.15349616261, 34920.12699682509, 35311.64688353115, 35392.11519712008, 35411.4688279676, 35977.28045439096, 36495.45256821143, 36635.450468243, 36665.45001824975, 36809.631903681024, 7492.737754178618, 7621.8475630487355, 7646.235376462365, 7674.695301798708, 7691.807704807368, 7593.2027137150635, 7721.150673425918, 7721.65252563636, 7725.961370193141, 7855.450118491708, 7848.803779905491, 7856.685732570691, 7876.842463150733, 7887.171846956073, 7887.526748395115, 7523.924760752405, 7549.169591344975, 7550.9622451887935, 7553.093628764528, 7573.772786816405, 7744.070711514598, 7848.7645370638975, 7902.130765615778, 7929.207079292082, 7931.167227441151, 28205.576916346272, 35887.28225435503, 36124.81937590295, 36279.81860090709, 36318.63681363179, 2955.733983941456, 2981.2993946422575, 2985.7163569460868, 3279.918002049944, 3555.5555555555557, 24725.752742472705, 25588.744112558823, 25642.48715025689, 26176.214713558624, 26371.34071648205, 3047.4971629681077, 3068.171593669697, 3128.7966282191583, 3160.5259211118287, 3176.6188057433255, 182406.0, 184256.0, 186637.0, 186876.0, 187090.0, 31670.366592668477, 31925.361492770015, 31928.0, 31946.361072778414, 31961.680383196337, 58775.11837322444, 60044.0, 60364.698176508835, 60432.39567604267, 60787.0, 12651.114421990556, 12745.0, 12776.361181941053, 12818.423170957329, 12903.612891613267, 9470.242380609672, 9540.427574345422, 9545.140937315675, 9565.330426870192, 9601.567929443192, 17836.46490605284, 17994.460166195036, 18184.272629094954, 18638.068096595114, 18653.90673046626, 7138.571685698875, 7224.602646854369, 7338.486305958531, 7344.339009489172, 7393.445491588152, 878.8286284174525, 928.572856486024, 942.0532364973158, 993.7366597851575, 1011.2769369900557, 26986.865065674545, 28023.859880700875, 28081.0, 28087.157385278475, 28181.71818281791, 987.6444479987199, 1018.4296793795498, 1045.2892033417197, 1084.4198353880636, 1133.2350663302238, 14518.854811451962, 14911.254437278092, 15003.474878379204, 15077.623059423382, 15163.317650705745, 319860.0, 321403.0, 322486.0, 324752.0, 325569.0, 46375.76812115918, 47435.0, 47530.0, 47651.76174119107, 47672.76163619159, 1197.3297250335734, 1220.8718084601167, 1244.9875501245053, 1263.2546797389584, 1268.2707443220186, 25730.742692572836, 27111.59332610052, 27377.178684639493, 27686.0, 27830.44339113166, 40479.1904161921, 40992.79503602463, 41196.79401602973, 41295.7935210322, 41372.379414308205, 292493.0, 298394.0, 300652.0, 300699.0, 301395.0, 23228.76771232266, 23329.53340933138, 23425.648615271126, 23449.882750586137, 25313.62029569521, 39360.6063939357, 40149.59850401458, 40767.388489172095, 41250.0, 41372.1725565493, 33644.663553365135, 35516.82241588879, 35829.64170358367, 35860.282794344486, 36277.09307267234, 35233.29533409266, 35278.29443411169, 35471.0, 35583.0, 35716.28567428689, 32074.83962580172, 35387.11532211612, 35607.0, 35912.82043589765, 36671.63328366682, 29386.161492415995, 31062.534061988637, 31126.68873311238, 31135.68864311328, 31282.843585781924, 23578.882105589364, 23732.288031359087, 23943.683022702906, 24060.639090414006, 24438.63342049835], "value": 16642.95314339989, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [378.53251234725127, 383.1341168958154, 383.53400618248827, 389.3789405897592, 390.6074395232791, 14496.130232186062, 15071.095734255938, 15211.315490802912, 15229.543113706579, 15305.1582162981, 10285.177185825134, 10599.894001059987, 10896.564137434492, 10913.618023369183, 10937.0, 4578.404807375036, 4718.976405117986, 4758.619310455173, 4760.071786001731, 5180.792768289264, 5114.462981386957, 5145.74271286436, 5149.922751158736, 5167.069927413064, 5171.844844654666, 4978.825741099062, 5067.290579318898, 5112.846614601568, 5118.974405127988, 5128.076946149691, 5212.791488340462, 5221.738913054351, 5256.92114618281, 5258.579313654898, 5269.130593452076, 4919.77860996256, 5360.678359298455, 5443.727813609304, 5448.046591846411, 5453.727313634303, 11907.523699052113, 12103.939480302543, 12200.145989780718, 14973.775393369107, 19677.524185686132, 1873.8688291819578, 1954.5895361974003, 2015.7077223802467, 2069.8758074515576, 2082.854200205986, 8801.383903126783, 9364.157225849638, 10936.507857146367, 13106.27915464649, 13190.208587484782, 1531.0, 1543.074155506687, 1552.7593223050333, 1565.3190861975077, 1573.4021071992684, 62609.37390626081, 64499.0, 66166.0, 66402.66798665976, 66856.33143668549, 9803.313768036169, 9818.852717209247, 9977.002299769965, 10277.331973421704, 10397.688069357931, 14121.505747298796, 14252.073615214978, 14286.0, 14321.713565728627, 14323.928380358031, 6772.0, 6840.863182736417, 6870.31296870309, 6890.069840571559, 6978.267281935425, 6087.752010837768, 6167.136600875881, 6340.397662222082, 6346.11154438379, 6351.460125889351, 4212.768297743653, 4338.696291259582, 4350.673699472489, 4428.180786554498, 4457.77711114443, 1806.756087928139, 1841.8526517878538, 1892.48902796247, 1902.7526421565385, 1926.8554858385678, 888.1917455115813, 904.7894510449545, 928.3640706116197, 982.9606815727291, 994.1897353656747, 16312.836871631369, 16369.672606547801, 16544.50366489007, 16812.621663737482, 16890.069717732946, 872.2106493623281, 874.5627186406797, 883.8409086364387, 884.4074470105045, 928.1785619726455, 8874.517823807042, 9308.674196403093, 9325.533723313807, 9376.48429336393, 9488.810223795623, 258847.0, 394963.0251848722, 397183.0, 399630.0, 415374.0, 59584.40415595875, 70429.29570704227, 72369.0, 73026.0, 74730.62634686792, 920.0431551186691, 921.6037104045191, 936.7143021378408, 953.8330792111353, 958.4776296918056, 14881.404743810126, 15016.92491537579, 15057.17185554805, 15153.318100685276, 15514.146721930401, 31783.364332713678, 32098.35803283968, 32945.67054329522, 33189.83405082959, 33999.32001360008, 44580.32295489251, 46510.76744616255, 46888.765556172, 47360.7631961838, 47611.52388476071, 7137.464690148156, 7255.4921155520715, 7397.852042959218, 7429.517081389692, 7842.137364889972, 10272.178225742073, 10857.782844343226, 10899.455027248765, 10976.176786740867, 10995.615153469591, 9475.57359918819, 9698.127168554864, 9701.611935522782, 9724.173445257233, 9819.509024548886, 9451.952740236255, 9758.658446954607, 9809.460479673686, 9810.215182785218, 9848.113669769755, 5882.176495290748, 8025.719099831478, 9671.17794987434, 9672.75818104553, 9898.901010989797, 7406.629668516445, 7462.10454745434, 7599.050118735158, 7614.390848731978, 7636.694532218649, 9026.638934442548, 9473.384230025027, 9494.335396522178, 9719.125278724949, 9743.561539730586], "value": 7781.031592913966, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1455.7234125516154, 1478.9778153327698, 1624.2771966474922, 1734.7137722275825, 1790.167572078983, 6761.1210542629515, 7419.220981796914, 7443.441741869361, 7741.535507869525, 7771.339436147927, 7510.173880873113, 7540.8114797129965, 7546.547207167574, 7584.203658615848, 7626.275503827142, 2199.912003519857, 2242.3385101395047, 2248.3142641494337, 2251.0658076898067, 2257.3566533537946, 2169.913203471859, 2177.042101475354, 2190.660447630612, 2191.616467118256, 2192.4738062864876, 2228.65455854342, 2239.3393948785147, 2246.9438264043447, 2252.8986195621155, 2278.3506700590333, 2158.56828634273, 2160.48148444373, 2161.5784921940226, 2176.4232478393237, 2177.858439201447, 2167.9132834686593, 2172.543765809182, 2176.5320456101854, 2187.387531491185, 2197.615417301966, 7583.696652133908, 7638.236176382317, 7728.227177282227, 7738.806529836743, 7742.690292388298, 4391.143726973241, 4560.771961401917, 4563.863084107482, 4583.747893865836, 4584.724916505021, 2885.4373397187555, 2953.3945541164226, 2991.626046744157, 3001.1746769638526, 3015.095471358584, 892.4154678685471, 908.3006085314271, 913.9314551408671, 920.7559996600907, 924.0297687428174, 9862.65480708179, 10115.039071288216, 10120.392776433364, 10153.390796552156, 10182.898171018343, 4028.7582745035393, 4064.7357921734992, 4146.523149837747, 4176.895577610523, 4202.243596152722, 8107.1892810718455, 8118.75643730689, 8129.227723366271, 8129.959350203211, 8152.6331315090965, 4352.455943007124, 4384.364267181241, 4399.670024748157, 4475.977620111878, 4481.417415735934, 3525.206828463575, 3994.660453861396, 4126.814293356806, 4164.229617520768, 4172.4784401949755, 3398.150462384404, 3436.570428696413, 3491.5635545556806, 3504.737144714157, 3530.717542596586, 1003.1423133221136, 1020.3214862116757, 1024.359775140537, 1037.061459379263, 1049.239301506417, 1160.7562411893598, 1177.5760726138583, 1206.6802297391198, 1211.4427363412929, 1227.1961864978275, 7103.822404439827, 7109.324614161646, 7248.782536523912, 7275.454340924452, 7486.438517111238, 985.6008316631776, 1000.5897581991348, 1003.708924411927, 1012.711377257478, 1092.4537731134433, 5519.69641669704, 5571.66570005801, 5673.574481913873, 5703.657780533182, 5715.799947001835, 8967.775805604912, 9421.434713917188, 9444.197243234403, 9486.857697134548, 9511.0, 9351.158395744416, 9536.475493847765, 9546.236301095896, 9582.616695332248, 9584.0, 7238.638068096574, 7273.16358618755, 7288.198298187195, 7320.341169294789, 7339.155997060299, 7033.472489563405, 7063.046488723957, 7114.395276401564, 7138.892916606359, 7169.677364518505, 8238.83522329562, 8623.913760862311, 8672.609732561923, 8776.692815751418, 8816.86774698393, 8547.61535730906, 8677.913220867711, 8902.510361929897, 8912.0, 8959.328050396116, 5817.214676018683, 6518.804435866931, 6541.542092053511, 6637.037629543785, 6772.661366931535, 7305.3425191732995, 7331.04696389466, 7331.74338898136, 7336.633168341668, 7364.96317518409, 6312.6528040956355, 6333.65164915934, 6342.746290148342, 6556.573822701509, 6645.534812563074, 6697.464202863662, 6697.53117281805, 6700.865982680417, 6720.663966801738, 6752.209922752266, 6976.790696279119, 7001.334873187039, 7053.753118640823, 7064.752733654297, 7065.964670176616, 6143.354947730424, 6176.81469555914, 6201.937980620136, 6209.720562574605, 6288.685565721604, 6231.563790534619, 6316.336784637547, 6322.430981211713, 6325.082862984934, 6334.42990130872], "value": 4345.990553001767, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [311.7147809754075, 317.1120861587554, 318.287037037037, 320.7321886225002, 324.40147927074554, 5080.974595127024, 5331.57347412207, 5396.919046214305, 5416.187571864212, 5429.56563474922, 5208.192730126827, 5237.86905327367, 5279.234510995913, 5286.65636733613, 5305.230741542484, 3864.2271545690833, 3958.386450100239, 4062.3703325984447, 4073.063195465045, 4080.510338759353, 4066.9796651016704, 4070.409790580364, 4078.8368465261356, 4082.1631565528996, 4091.3249313863175, 4043.2519983802945, 4059.2084543514025, 4061.3298805697173, 4063.553009168989, 4079.7552146871135, 3844.730868839182, 4059.188162367509, 4060.776657283848, 4063.3904914262803, 4070.5929407059352, 3488.773229740084, 3521.5774107107054, 3533.469979503069, 3543.4153364695053, 3548.254866478043, 4951.697460680764, 4959.355283813081, 4964.925526117111, 4979.377577802775, 4990.3762029746285, 4666.393368862026, 4668.649851261135, 4679.64902632304, 4685.4143232095985, 4688.789004494772, 5410.323709536308, 5452.672839629635, 5507.504324610764, 5522.696251706155, 5530.336359636829, 3836.827342769582, 3837.597052309495, 3843.9231215375535, 3845.557760857509, 3848.730588858781, 5721.856953576153, 5747.304545159188, 5847.766089356421, 5860.941390586039, 5873.089671100986, 3843.8846834595006, 3912.9608703912595, 3915.0799562102884, 3931.1548017176447, 3949.170674158459, 3973.6225058619384, 4011.0, 4017.337139371971, 4021.2560676274397, 4023.994001499625, 4577.542245775462, 4627.30590411441, 4647.814087436533, 4654.6741728078705, 4672.322513235562, 5253.106971814725, 5549.084401073777, 5561.6663000220115, 5563.944360556424, 5564.33228012641, 1381.951631692886, 1397.9720405591831, 1402.978955315671, 1403.073971179017, 1403.7052219033912, 919.558611866308, 935.4574346878794, 944.5230158769778, 948.9715308540755, 955.6511873166244, 4760.952390476051, 4790.568848803624, 4974.577160941288, 4979.975100124476, 5010.173321401928, 5692.6299790513485, 5777.913331300034, 5784.421557844182, 5793.94206057934, 5814.738336774855, 4672.415948006499, 4925.975370123127, 4926.359573255526, 4976.800927962841, 4981.476944920803, 3058.266016156151, 3083.0, 3084.706952839477, 3099.6900309969274, 3104.130843363862, 5359.866003349869, 5395.865103372447, 5411.0, 5435.402105768362, 5458.8908221835345, 5759.395263497357, 5846.590738648339, 5881.2942446906645, 5899.646021238739, 5914.172015917775, 5401.648892821954, 5408.378036525771, 5420.457954204627, 5442.5645948323245, 5459.672419654833, 5591.6365436246515, 5742.483176514133, 5773.509251713652, 5774.42255774436, 5779.190913272229, 5615.298087739033, 5647.3505546861, 5662.631928924607, 5674.716264186856, 5699.287589051369, 5404.459554044564, 5409.0, 5413.83758487246, 5420.891582168413, 5435.374931882884, 3991.461152744342, 4003.699722520764, 4013.618706222904, 4054.7430296608145, 4068.715189936676, 5577.386487486455, 5600.439956004367, 5613.242212301287, 5635.0702134147405, 5639.3232812062815, 5395.514403703685, 5412.215228791882, 5423.728813559227, 5440.29276194108, 5456.072467680583, 5136.640435169652, 5399.5950303726595, 5401.135818269058, 5427.945720542902, 5428.918566221589, 5330.440303768203, 5335.759890804846, 5347.786088556414, 5354.303940487712, 5374.731263436891, 5278.762455689426, 5418.214358918013, 5544.861378465571, 5560.833175004756, 5570.693611851387, 5416.783328666809, 5447.727613619382, 5460.31746031746, 5493.642913210629, 5502.202180683858], "value": 4146.005423522612, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [625.7434451874731, 710.2045708806138, 781.8123650323922, 781.9530828150308, 795.0459448661608, 12209.633710988674, 12295.508179672825, 12322.199057061307, 12373.319467429288, 12401.0, 11823.172377933548, 12110.697232569168, 12193.207441516295, 12217.755644887096, 12283.385830708474, 807.6769292283075, 814.4054839966827, 816.008549612221, 819.0867183090841, 824.9546274954876, 651.029965351625, 803.3091541274499, 831.4927893984665, 832.4422636833336, 832.5213002523543, 857.995710021449, 860.9053004169537, 863.2489733931488, 863.6804382378498, 868.522312727997, 846.2426128614917, 851.6550796927254, 853.3727710133016, 853.4665833853842, 858.3433673239977, 627.231641239478, 628.7547856336032, 629.9401556852092, 631.8294060603612, 632.936706329368, 11522.539098436053, 11530.308181509052, 11531.48108335127, 11612.419379031015, 11642.010429113536, 12543.623691289276, 12734.108612397136, 12770.106092573524, 12961.222326660336, 13268.071235013553, 9878.90121098787, 10027.197824174049, 10064.245181611408, 10317.638882639072, 10547.525361358757, 4205.390218418343, 4209.2633789086785, 4209.915801683949, 4218.936715949232, 4219.831206751757, 47026.529734702555, 47029.52970470286, 47106.0, 48968.755156224346, 49269.75365123187, 9536.761580960532, 9715.125638692552, 9992.662660876182, 10084.798304033879, 10261.897381026243, 17761.644767104586, 18105.094745262948, 18124.27502899869, 18127.72808407875, 18169.273229070954, 6853.554518956252, 6920.550164239308, 7139.107611548557, 7252.057232559733, 7278.526895751759, 3970.8014599269923, 3999.060220848098, 4030.0730831908827, 4033.737807042533, 4036.91926161481, 2812.4937511247763, 2877.136858942309, 2877.985610071978, 2885.0623547346777, 2901.15866398742, 517.7721802406929, 517.816175257778, 519.8570393141916, 520.3391692550515, 533.9359276886721, 565.6888711208819, 591.3524690463935, 596.4244504053609, 606.4329851588778, 612.3937302070917, 7430.851382972419, 7925.722599708983, 8228.876566851503, 8270.131636178236, 8297.672372420384, 554.3181886279898, 629.0, 630.0895206426669, 635.3519410201568, 641.4868105515569, 3525.665061819123, 3592.191756854739, 3660.04838741929, 3660.7620504667643, 3896.7272290939927, 49642.0, 49650.503494964585, 49652.531272185675, 49868.25197622039, 50891.0, 44127.77936110363, 44422.33366499505, 45037.54962450399, 45728.77135614301, 46042.76978615086, 39356.80321598374, 39910.401343979865, 40498.59501405007, 41270.58729412667, 42533.36199957003, 7832.960835195788, 7916.44584879076, 8323.250907418362, 8366.414350995372, 8574.185452382013, 27800.44399111966, 28938.710612893603, 28951.0, 29865.701342987162, 31415.21461963469, 36896.81551592225, 36941.815290923376, 41574.376384354866, 42484.0, 42849.35725964175, 11133.165012624248, 11217.66347009591, 11284.605038823602, 11430.428478576205, 11522.769544608893, 11198.552057917917, 12079.939600301943, 12382.380880956096, 12819.615411537296, 13328.733425331633, 10401.635942741968, 10511.264211505428, 10643.361398316125, 10669.35983840972, 10961.12311015101, 11062.778744425228, 11470.426478675867, 11491.942540287246, 12062.215955962834, 12090.93954530257, 10929.78140437171, 11456.713582160513, 11496.770064598828, 11551.595694150665, 12147.696307592381, 9321.953390233006, 9353.719388418358, 9644.565994530403, 9710.417374957242, 9751.951240243754, 9871.309008369346, 10063.345882517613, 10120.645777397756, 10136.645217417356, 10138.0], "value": 6054.680714336782, "unit": "score"}], "name": "dromaeo_css", "value": 6360.467834604127, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 108.0, 115.0, 114.0, 116.0, 127.0, 115.0, 115.0, 114.0, 116.0], "value": 115.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 132.0, 158.0, 198.0, 136.0, 162.0, 163.0, 134.0, 199.0, 136.0], "value": 157.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 166.0, 176.0, 164.0, 161.0, 163.0, 163.0, 165.0, 164.0], "value": 165.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 75.0, 74.0, 160.0, 77.0, 74.0, 74.0, 74.0, 151.0, 75.0], "value": 91.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 140.0, 94.0, 94.0, 94.0, 139.0, 94.0, 94.0, 136.0], "value": 107.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 122.0, 118.0, 122.0, 117.0, 118.0, 118.0, 118.0], "value": 118.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 146.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0, 148.0], "value": 147.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 66.0, 64.0, 65.0, 66.0, 65.0, 86.0, 63.0, 62.0], "value": 66.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 64.0, 65.0, 64.0, 65.0, 65.0, 65.0, 64.0], "value": 64.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 84.0, 84.0, 85.0, 86.0, 87.0, 88.0, 84.0, 86.0], "value": 85.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 141.0, 139.0, 145.0, 157.0, 137.0, 137.0, 146.0, 178.0, 141.0], "value": 146.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 183.0, 182.0, 176.0, 177.0, 175.0, 188.0, 183.0, 178.0, 174.0], "value": 179.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 72.0, 73.0, 74.0, 73.0, 72.0, 75.0, 73.0, 74.0], "value": 73.8, "unit": "score"}], "name": "kraken", "value": 1614.8999999999999, "alertThreshold": 2.0}]} 04:32:03 INFO - Return code: 0 04:32:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:32:04 ERROR - # TBPL SUCCESS # 04:32:04 INFO - Running post-action listener: _resource_record_post_action 04:32:04 INFO - Running post-run listener: _resource_record_post_run 04:32:05 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 0; Write bytes: 518791168; Read time: 0; Write time: 480392 04:32:05 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 232947712; Read time: 0; Write time: 287292 04:32:05 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 0; Write bytes: 285102080; Read time: 0; Write time: 193092 04:32:05 INFO - Running post-run listener: _upload_blobber_files 04:32:05 INFO - Blob upload gear active. 04:32:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:32:05 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 04:32:05 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', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:32:05 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 Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:32:05 INFO - (blobuploader) - INFO - Open directory for files ... 04:32:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:32:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:32:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:32:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:32:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:32:06 INFO - (blobuploader) - INFO - Done attempting. 04:32:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:32:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:32:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:32:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:32:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:32:07 INFO - (blobuploader) - INFO - Done attempting. 04:32:07 INFO - (blobuploader) - INFO - Iteration through files over. 04:32:07 INFO - Return code: 0 04:32:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:32:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:32:07 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7877e2fb0c20322907edeef6e63196444c55ad09f08e529de369a6919beb05a06cf47794ce098362a439b6f16df4268887bdb2f6530db5b1986ff9cfffa74279", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/edf90a56193df787441c4a7e9bb4a4e45729c82d05f743449089db26116ce39d8070fc34895e7844f28776cc1aea437f37fa86270b93bd653cbe14b514535594"} 04:32:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:32:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:32:07 INFO - Contents: 04:32:07 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7877e2fb0c20322907edeef6e63196444c55ad09f08e529de369a6919beb05a06cf47794ce098362a439b6f16df4268887bdb2f6530db5b1986ff9cfffa74279", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/edf90a56193df787441c4a7e9bb4a4e45729c82d05f743449089db26116ce39d8070fc34895e7844f28776cc1aea437f37fa86270b93bd653cbe14b514535594"} 04:32:07 INFO - Running post-run listener: copy_logs_to_upload_dir 04:32:07 INFO - Copying logs to upload dir... 04:32:07 INFO - mkdir: /builds/slave/test/build/upload/logs 04:32:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.414330 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-04-13 04:32:06.766178) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-13 04:32:06.769748) ========= 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-1460543755.142896-294655275 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/Firefox-Non-PGO/sha512/7877e2fb0c20322907edeef6e63196444c55ad09f08e529de369a6919beb05a06cf47794ce098362a439b6f16df4268887bdb2f6530db5b1986ff9cfffa74279", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/edf90a56193df787441c4a7e9bb4a4e45729c82d05f743449089db26116ce39d8070fc34895e7844f28776cc1aea437f37fa86270b93bd653cbe14b514535594"} build_url:https://queue.taskcluster.net/v1/task/Nb9cKTHgSZyScC6jY5zW5Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011405 build_url: 'https://queue.taskcluster.net/v1/task/Nb9cKTHgSZyScC6jY5zW5Q/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/Firefox-Non-PGO/sha512/7877e2fb0c20322907edeef6e63196444c55ad09f08e529de369a6919beb05a06cf47794ce098362a439b6f16df4268887bdb2f6530db5b1986ff9cfffa74279", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/edf90a56193df787441c4a7e9bb4a4e45729c82d05f743449089db26116ce39d8070fc34895e7844f28776cc1aea437f37fa86270b93bd653cbe14b514535594"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-13 04:32:06.796142) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 04:32:06.796626) ========= 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-1460543755.142896-294655275 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004583 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 04:32:06.880711) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-13 04:32:06.881064) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-13 04:32:06.881466) ========= ========= Total master_lag: 0.30 =========