builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-019 starttime: 1459918062.08 results: success (0) buildid: 20160405205712 builduid: 4d2d89e2037845a5b863216d0ee20430 revision: 75bef7c5fd91e42e5cfa5337f02f48942b568996 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-05 21:47:42.081179) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-05 21:47:42.081587) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-05 21:47:42.081894) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1459909530.8227-861680776 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006355 basedir: '/builds/slave/test' ========= master_lag: 0.05 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-05 21:47:42.140255) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-05 21:47:42.140590) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-05 21:47:42.246021) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 21:47:42.246328) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1459909530.8227-861680776 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004564 ========= master_lag: 0.08 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 21:47:42.329044) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-05 21:47:42.329357) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-05 21:47:42.329730) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 21:47:42.330033) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1459909530.8227-861680776 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-05 21:47:42-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 96.1M=0s 2016-04-05 21:47:42 (96.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.182572 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 21:47:42.549684) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 21:47:42.550319) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1459909530.8227-861680776 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017043 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 21:47:42.635954) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-05 21:47:42.636732) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 75bef7c5fd91e42e5cfa5337f02f48942b568996 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 75bef7c5fd91e42e5cfa5337f02f48942b568996 --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=78329bfc0fd5309db0a6e0ac000001b4-1459909530.8227-861680776 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-05 21:47:43,026 truncating revision to first 12 chars 2016-04-05 21:47:43,026 Setting DEBUG logging. 2016-04-05 21:47:43,027 attempt 1/10 2016-04-05 21:47:43,027 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/75bef7c5fd91?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-05 21:47:44,139 unpacking tar archive at: fx-team-75bef7c5fd91/testing/mozharness/ program finished with exit code 0 elapsedTime=1.402171 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-05 21:47:44.081524) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-05 21:47:44.082045) ========= echo 75bef7c5fd91e42e5cfa5337f02f48942b568996 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'75bef7c5fd91e42e5cfa5337f02f48942b568996'] 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=78329bfc0fd5309db0a6e0ac000001b4-1459909530.8227-861680776 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 75bef7c5fd91e42e5cfa5337f02f48942b568996 program finished with exit code 0 elapsedTime=0.004725 script_repo_revision: '75bef7c5fd91e42e5cfa5337f02f48942b568996' ========= master_lag: 0.11 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-05 21:47:44.198660) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-05 21:47:44.198992) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-05 21:47:44.349903) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2016-04-05 21:47:44.350711) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=78329bfc0fd5309db0a6e0ac000001b4-1459909530.8227-861680776 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:47:44 INFO - MultiFileLogger online at 20160405 21:47:44 in /builds/slave/test 21:47:44 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 21:47:44 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:47:44 INFO - {'append_to_log': False, 21:47:44 INFO - 'base_work_dir': '/builds/slave/test', 21:47:44 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 21:47:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:47:44 INFO - 'branch': 'Fx-Team-Non-PGO', 21:47:44 INFO - 'buildbot_json_path': 'buildprops.json', 21:47:44 INFO - 'config_files': ('talos/linux_config.py',), 21:47:44 INFO - 'default_actions': ('clobber', 21:47:44 INFO - 'read-buildbot-config', 21:47:44 INFO - 'download-and-extract', 21:47:44 INFO - 'populate-webroot', 21:47:44 INFO - 'create-virtualenv', 21:47:44 INFO - 'install', 21:47:44 INFO - 'run-tests'), 21:47:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:47:44 INFO - 'download_minidump_stackwalk': True, 21:47:44 INFO - 'download_symbols': 'ondemand', 21:47:44 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:47:44 INFO - 'tooltool.py': '/tools/tooltool.py', 21:47:44 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:47:44 INFO - '/tools/misc-python/virtualenv.py')}, 21:47:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:47:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:47:44 INFO - 'installer_path': 'installer.exe', 21:47:44 INFO - 'log_level': 'info', 21:47:44 INFO - 'log_name': 'talos', 21:47:44 INFO - 'log_to_console': True, 21:47:44 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:47:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:47:44 INFO - 'opt_config_files': (), 21:47:44 INFO - 'pip_index': False, 21:47:44 INFO - 'sps_profile': False, 21:47:44 INFO - 'sps_profile_interval': 0, 21:47:44 INFO - 'suite': 'dromaeojs', 21:47:44 INFO - 'system_bits': '32', 21:47:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:47:44 INFO - 'title': 'talos-linux64-ix-019', 21:47:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:47:44 INFO - 'use_talos_json': True, 21:47:44 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:47:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:47:44 INFO - 'work_dir': 'build'} 21:47:44 INFO - ##### 21:47:44 INFO - ##### Running clobber step. 21:47:44 INFO - ##### 21:47:44 INFO - Running pre-action listener: _resource_record_pre_action 21:47:44 INFO - Running main action method: clobber 21:47:44 INFO - rmtree: /builds/slave/test/build 21:47:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:47:45 INFO - Running post-action listener: _resource_record_post_action 21:47:45 INFO - ##### 21:47:45 INFO - ##### Running read-buildbot-config step. 21:47:45 INFO - ##### 21:47:45 INFO - Running pre-action listener: _resource_record_pre_action 21:47:45 INFO - Running main action method: read_buildbot_config 21:47:45 INFO - Using buildbot properties: 21:47:45 INFO - { 21:47:45 INFO - "project": "", 21:47:45 INFO - "product": "firefox", 21:47:45 INFO - "script_repo_revision": "production", 21:47:45 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 21:47:45 INFO - "repository": "", 21:47:45 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 21:47:45 INFO - "buildid": "20160405205712", 21:47:45 INFO - "pgo_build": "False", 21:47:45 INFO - "basedir": "/builds/slave/test", 21:47:45 INFO - "buildnumber": 1616, 21:47:45 INFO - "slavename": "talos-linux64-ix-019", 21:47:45 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 21:47:45 INFO - "platform": "ubuntu64_hw", 21:47:45 INFO - "scheduler": "tests-fx-team-linux64-talos", 21:47:45 INFO - "branch": "fx-team", 21:47:45 INFO - "repo_path": "integration/fx-team", 21:47:45 INFO - "revision": "75bef7c5fd91e42e5cfa5337f02f48942b568996", 21:47:45 INFO - "stage_platform": "linux64", 21:47:45 INFO - "builduid": "4d2d89e2037845a5b863216d0ee20430", 21:47:45 INFO - "slavebuilddir": "test" 21:47:45 INFO - } 21:47:45 INFO - Found installer url https://queue.taskcluster.net/v1/task/XBOJ3KexRGKY_ZIkuchWtg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 21:47:45 INFO - Running post-action listener: _resource_record_post_action 21:47:45 INFO - ##### 21:47:45 INFO - ##### Running download-and-extract step. 21:47:45 INFO - ##### 21:47:45 INFO - Running pre-action listener: _resource_record_pre_action 21:47:45 INFO - Running main action method: download_and_extract 21:47:45 INFO - mkdir: /builds/slave/test/build/tests 21:47: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')]} 21:47:45 INFO - https://queue.taskcluster.net/v1/task/XBOJ3KexRGKY_ZIkuchWtg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 21:47:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XBOJ3KexRGKY_ZIkuchWtg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 21:47:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XBOJ3KexRGKY_ZIkuchWtg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 21:47:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XBOJ3KexRGKY_ZIkuchWtg/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 21:47:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XBOJ3KexRGKY_ZIkuchWtg/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 21:47:53 INFO - Downloaded 1361 bytes. 21:47:53 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 21:47:53 INFO - Using the following test package requirements: 21:47:53 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 21:47:53 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 21:47:53 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 21:47:53 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 21:47:53 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 21:47:53 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 21:47:53 INFO - u'jsshell-linux-x86_64.zip'], 21:47:53 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 21:47:53 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 21:47:53 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 21:47:53 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 21:47:53 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 21:47:53 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 21:47:53 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 21:47:53 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 21:47:53 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 21:47:53 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 21:47:53 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 21:47:53 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:47:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:47:53 INFO - https://queue.taskcluster.net/v1/task/XBOJ3KexRGKY_ZIkuchWtg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:47:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XBOJ3KexRGKY_ZIkuchWtg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 21:47:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XBOJ3KexRGKY_ZIkuchWtg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 21:47:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XBOJ3KexRGKY_ZIkuchWtg/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 21:47:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XBOJ3KexRGKY_ZIkuchWtg/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 21:48:04 INFO - Downloaded 22125485 bytes. 21:48:04 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'] 21:48:04 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 21:48:06 INFO - Return code: 0 21:48:06 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 21:48:06 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')]} 21:48:06 INFO - https://queue.taskcluster.net/v1/task/XBOJ3KexRGKY_ZIkuchWtg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:48:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XBOJ3KexRGKY_ZIkuchWtg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 21:48:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XBOJ3KexRGKY_ZIkuchWtg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 21:48:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XBOJ3KexRGKY_ZIkuchWtg/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 21:48:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XBOJ3KexRGKY_ZIkuchWtg/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 21:48:08 INFO - Downloaded 22125485 bytes. 21:48:08 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'] 21:48:08 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 21:48:10 INFO - Return code: 0 21:48:10 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')]} 21:48:10 INFO - https://queue.taskcluster.net/v1/task/XBOJ3KexRGKY_ZIkuchWtg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 21:48:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XBOJ3KexRGKY_ZIkuchWtg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 21:48:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XBOJ3KexRGKY_ZIkuchWtg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 21:48:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XBOJ3KexRGKY_ZIkuchWtg/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 21:48:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XBOJ3KexRGKY_ZIkuchWtg/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 21:48:13 INFO - Downloaded 10847584 bytes. 21:48:13 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'] 21:48:13 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 21:48:13 INFO - Return code: 0 21:48:13 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')]} 21:48:13 INFO - https://queue.taskcluster.net/v1/task/XBOJ3KexRGKY_ZIkuchWtg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 21:48:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XBOJ3KexRGKY_ZIkuchWtg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 21:48:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XBOJ3KexRGKY_ZIkuchWtg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 21:48:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XBOJ3KexRGKY_ZIkuchWtg/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 21:48:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XBOJ3KexRGKY_ZIkuchWtg/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 21:48:14 INFO - Downloaded 54097497 bytes. 21:48:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XBOJ3KexRGKY_ZIkuchWtg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 21:48:14 INFO - mkdir: /builds/slave/test/properties 21:48:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:48:14 INFO - Writing to file /builds/slave/test/properties/build_url 21:48:14 INFO - Contents: 21:48:14 INFO - build_url:https://queue.taskcluster.net/v1/task/XBOJ3KexRGKY_ZIkuchWtg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 21:48:15 INFO - Running post-action listener: _resource_record_post_action 21:48:15 INFO - Running post-action listener: set_extra_try_arguments 21:48:15 INFO - ##### 21:48:15 INFO - ##### Running populate-webroot step. 21:48:15 INFO - ##### 21:48:15 INFO - Running pre-action listener: _resource_record_pre_action 21:48:15 INFO - Running main action method: populate_webroot 21:48:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:48:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:48:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:48:15 INFO - '--tppagecycles', 21:48:15 INFO - '7'], 21:48:15 INFO - 'tests': ['tsvgm']}}, 21:48:15 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 21:48:15 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 21:48:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:48:15 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 21:48:15 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 21:48:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:48:15 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:48:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:48:15 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:48:15 INFO - 'talos_options': ['--e10s'], 21:48:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:48:15 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:48:15 INFO - 'tests': ['damp', 'tps']}, 21:48:15 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:48:15 INFO - 'talos_options': ['--e10s'], 21:48:15 INFO - 'tests': ['damp', 'tps']}, 21:48:15 INFO - 'g3': {'tests': ['dromaeo_dom']}, 21:48:15 INFO - 'g3-e10s': {'talos_options': ['--e10s'], 21:48:15 INFO - 'tests': ['dromaeo_dom']}, 21:48:15 INFO - 'other': {'tests': ['a11yr', 21:48:15 INFO - 'ts_paint', 21:48:15 INFO - 'tpaint', 21:48:15 INFO - 'sessionrestore', 21:48:15 INFO - 'sessionrestore_no_auto_restore', 21:48:15 INFO - 'tabpaint']}, 21:48:15 INFO - 'other-e10s': {'talos_options': ['--e10s'], 21:48:15 INFO - 'tests': ['a11yr', 21:48:15 INFO - 'ts_paint', 21:48:15 INFO - 'tpaint', 21:48:15 INFO - 'sessionrestore', 21:48:15 INFO - 'sessionrestore_no_auto_restore', 21:48:15 INFO - 'tabpaint']}, 21:48:15 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 21:48:15 INFO - 'tests': ['a11yr', 21:48:15 INFO - 'ts_paint', 21:48:15 INFO - 'tpaint', 21:48:15 INFO - 'sessionrestore', 21:48:15 INFO - 'sessionrestore_no_auto_restore', 21:48:15 INFO - 'tabpaint']}, 21:48:15 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 21:48:15 INFO - 'tests': ['a11yr', 21:48:15 INFO - 'ts_paint', 21:48:15 INFO - 'tpaint', 21:48:15 INFO - 'sessionrestore', 21:48:15 INFO - 'sessionrestore_no_auto_restore', 21:48:15 INFO - 'tabpaint']}, 21:48:15 INFO - 'other_l64': {'tests': ['a11yr', 21:48:15 INFO - 'ts_paint', 21:48:15 INFO - 'tpaint', 21:48:15 INFO - 'sessionrestore', 21:48:15 INFO - 'sessionrestore_no_auto_restore', 21:48:15 INFO - 'tabpaint']}, 21:48:15 INFO - 'other_nol64': {'tests': ['a11yr', 21:48:15 INFO - 'ts_paint', 21:48:15 INFO - 'tpaint', 21:48:15 INFO - 'sessionrestore', 21:48:15 INFO - 'sessionrestore_no_auto_restore', 21:48:15 INFO - 'tabpaint']}, 21:48:15 INFO - 'svgr': {'tests': ['tsvgx', 21:48:15 INFO - 'tsvgr_opacity', 21:48:15 INFO - 'tart', 21:48:15 INFO - 'tscrollx', 21:48:15 INFO - 'cart']}, 21:48:15 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 21:48:15 INFO - 'tests': ['tsvgx', 21:48:15 INFO - 'tsvgr_opacity', 21:48:15 INFO - 'tart', 21:48:15 INFO - 'tscrollx', 21:48:15 INFO - 'cart']}, 21:48:15 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:48:15 INFO - 'tests': ['tp5o']}, 21:48:15 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:48:15 INFO - 'talos_options': ['--e10s'], 21:48:15 INFO - 'tests': ['tp5o']}, 21:48:15 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:48:15 INFO - 'talos_options': ['--xperf_path', 21:48:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:48:15 INFO - 'tests': ['tp5n']}, 21:48:15 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:48:15 INFO - 'talos_options': ['--e10s', 21:48:15 INFO - '--xperf_path', 21:48:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:48:15 INFO - 'tests': ['tp5n']}}, 21:48:15 INFO - 'talos.zip': {'path': '', 21:48:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:48:15 INFO - Running post-action listener: _resource_record_post_action 21:48:15 INFO - ##### 21:48:15 INFO - ##### Running create-virtualenv step. 21:48:15 INFO - ##### 21:48:15 INFO - Running pre-action listener: _resource_record_pre_action 21:48:15 INFO - Running main action method: create_virtualenv 21:48:15 INFO - Creating virtualenv /builds/slave/test/build/venv 21:48:15 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 21:48:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:48:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:48:15 INFO - Using real prefix '/usr' 21:48:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:48:16 INFO - Installing distribute.............................................................................................................................................................................................done. 21:48:18 INFO - Installing pip.................done. 21:48:18 INFO - Return code: 0 21:48:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:48:18 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')]} 21:48:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:48:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:48:18 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')]} 21:48:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:48:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:48:18 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 0x7f92eede1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x162f7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16be640>, '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 0x16bf540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16bf9d0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1459909530.8227-861680776', '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 21:48:18 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 21:48:18 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 21:48:18 INFO - Using env: {'DISPLAY': ':0', 21:48:18 INFO - 'HOME': '/home/cltbld', 21:48:18 INFO - 'LANG': 'en_US.UTF-8', 21:48:18 INFO - 'LANGUAGE': 'en_US:en', 21:48:18 INFO - 'LOGNAME': 'cltbld', 21:48:18 INFO - 'MAIL': '/var/mail/cltbld', 21:48:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:48:18 INFO - 'MOZ_NO_REMOTE': '1', 21:48:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:48:18 INFO - 'NO_EM_RESTART': '1', 21:48:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:48:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:48:18 INFO - 'PWD': '/builds/slave/test', 21:48:18 INFO - 'SHELL': '/bin/bash', 21:48:18 INFO - 'SHLVL': '1', 21:48:18 INFO - 'TERM': 'linux', 21:48:18 INFO - 'TMOUT': '86400', 21:48:18 INFO - 'USER': 'cltbld', 21:48:18 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1459909530.8227-861680776', 21:48:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:48:18 INFO - '_': '/tools/buildbot/bin/python'} 21:48:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:48:18 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 21:48:18 INFO - Cleaning up... 21:48:18 INFO - Return code: 0 21:48:18 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 21:48:18 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')]} 21:48:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:48:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:48:18 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')]} 21:48:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:48:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:48:18 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 0x7f92eede1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x162f7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16be640>, '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 0x16bf540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16bf9d0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1459909530.8227-861680776', '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 21:48:18 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 21:48:18 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 21:48:18 INFO - Using env: {'DISPLAY': ':0', 21:48:18 INFO - 'HOME': '/home/cltbld', 21:48:18 INFO - 'LANG': 'en_US.UTF-8', 21:48:18 INFO - 'LANGUAGE': 'en_US:en', 21:48:18 INFO - 'LOGNAME': 'cltbld', 21:48:18 INFO - 'MAIL': '/var/mail/cltbld', 21:48:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:48:18 INFO - 'MOZ_NO_REMOTE': '1', 21:48:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:48:18 INFO - 'NO_EM_RESTART': '1', 21:48:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:48:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:48:18 INFO - 'PWD': '/builds/slave/test', 21:48:18 INFO - 'SHELL': '/bin/bash', 21:48:18 INFO - 'SHLVL': '1', 21:48:18 INFO - 'TERM': 'linux', 21:48:18 INFO - 'TMOUT': '86400', 21:48:18 INFO - 'USER': 'cltbld', 21:48:18 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1459909530.8227-861680776', 21:48:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:48:18 INFO - '_': '/tools/buildbot/bin/python'} 21:48:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:48:18 INFO - Downloading/unpacking psutil>=0.7.1 21:48:18 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 21:48:18 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 21:48:18 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 21:48:18 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 21:48:18 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 21:48:18 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 21:48:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:48:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:48:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:48:20 INFO - Installing collected packages: psutil 21:48:20 INFO - Running setup.py install for psutil 21:48:20 INFO - building 'psutil._psutil_linux' extension 21:48:20 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 21:48:20 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 21:48:20 INFO - building 'psutil._psutil_posix' extension 21:48:20 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 21:48:20 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 21:48:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:48:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:48:21 INFO - Successfully installed psutil 21:48:21 INFO - Cleaning up... 21:48:21 INFO - Return code: 0 21:48:21 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 21:48:21 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')]} 21:48:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:48:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:48:21 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')]} 21:48:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:48:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:48:21 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 0x7f92eede1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x162f7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16be640>, '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 0x16bf540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16bf9d0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1459909530.8227-861680776', '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 21:48:21 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 21:48:21 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 21:48:21 INFO - Using env: {'DISPLAY': ':0', 21:48:21 INFO - 'HOME': '/home/cltbld', 21:48:21 INFO - 'LANG': 'en_US.UTF-8', 21:48:21 INFO - 'LANGUAGE': 'en_US:en', 21:48:21 INFO - 'LOGNAME': 'cltbld', 21:48:21 INFO - 'MAIL': '/var/mail/cltbld', 21:48:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:48:21 INFO - 'MOZ_NO_REMOTE': '1', 21:48:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:48:21 INFO - 'NO_EM_RESTART': '1', 21:48:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:48:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:48:21 INFO - 'PWD': '/builds/slave/test', 21:48:21 INFO - 'SHELL': '/bin/bash', 21:48:21 INFO - 'SHLVL': '1', 21:48:21 INFO - 'TERM': 'linux', 21:48:21 INFO - 'TMOUT': '86400', 21:48:21 INFO - 'USER': 'cltbld', 21:48:21 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1459909530.8227-861680776', 21:48:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:48:21 INFO - '_': '/tools/buildbot/bin/python'} 21:48:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:48:21 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 21:48:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:48:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:48:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:48:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:48:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:48:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:48:23 INFO - Downloading mozsystemmonitor-0.0.tar.gz 21:48:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:48:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 21:48:23 INFO - Installing collected packages: mozsystemmonitor 21:48:23 INFO - Running setup.py install for mozsystemmonitor 21:48:23 INFO - Successfully installed mozsystemmonitor 21:48:23 INFO - Cleaning up... 21:48:23 INFO - Return code: 0 21:48:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:48: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')]} 21:48:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:48:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:48: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')]} 21:48:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:48:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:48:23 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 0x7f92eede1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x162f7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16be640>, '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 0x16bf540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16bf9d0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1459909530.8227-861680776', '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 21:48:23 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 21:48:23 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 21:48:23 INFO - Using env: {'DISPLAY': ':0', 21:48:23 INFO - 'HOME': '/home/cltbld', 21:48:23 INFO - 'LANG': 'en_US.UTF-8', 21:48:23 INFO - 'LANGUAGE': 'en_US:en', 21:48:23 INFO - 'LOGNAME': 'cltbld', 21:48:23 INFO - 'MAIL': '/var/mail/cltbld', 21:48:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:48:23 INFO - 'MOZ_NO_REMOTE': '1', 21:48:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:48:23 INFO - 'NO_EM_RESTART': '1', 21:48:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:48:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:48:23 INFO - 'PWD': '/builds/slave/test', 21:48:23 INFO - 'SHELL': '/bin/bash', 21:48:23 INFO - 'SHLVL': '1', 21:48:23 INFO - 'TERM': 'linux', 21:48:23 INFO - 'TMOUT': '86400', 21:48:23 INFO - 'USER': 'cltbld', 21:48:23 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1459909530.8227-861680776', 21:48:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:48:23 INFO - '_': '/tools/buildbot/bin/python'} 21:48:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:48:23 INFO - Downloading/unpacking blobuploader==1.2.4 21:48:23 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 21:48:23 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 21:48:23 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 21:48:23 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 21:48:23 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 21:48:23 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 21:48:25 INFO - Downloading blobuploader-1.2.4.tar.gz 21:48:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:48:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:48:25 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 21:48:25 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 21:48:25 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 21:48:25 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 21:48:25 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 21:48:25 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 21:48:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:48:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:48:26 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 21:48:26 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 21:48:26 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 21:48:26 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 21:48:26 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 21:48:26 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 21:48:26 INFO - Downloading docopt-0.6.1.tar.gz 21:48:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:48:26 INFO - Installing collected packages: blobuploader, requests, docopt 21:48:26 INFO - Running setup.py install for blobuploader 21:48:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:48:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:48:26 INFO - Running setup.py install for requests 21:48:27 INFO - Running setup.py install for docopt 21:48:27 INFO - Successfully installed blobuploader requests docopt 21:48:27 INFO - Cleaning up... 21:48:27 INFO - Return code: 0 21:48:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:48:27 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')]} 21:48:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:48:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:48:27 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')]} 21:48:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:48:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:48:27 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 0x7f92eede1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x162f7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16be640>, '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 0x16bf540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16bf9d0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1459909530.8227-861680776', '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 21:48:27 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 21:48:27 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 21:48:27 INFO - Using env: {'DISPLAY': ':0', 21:48:27 INFO - 'HOME': '/home/cltbld', 21:48:27 INFO - 'LANG': 'en_US.UTF-8', 21:48:27 INFO - 'LANGUAGE': 'en_US:en', 21:48:27 INFO - 'LOGNAME': 'cltbld', 21:48:27 INFO - 'MAIL': '/var/mail/cltbld', 21:48:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:48:27 INFO - 'MOZ_NO_REMOTE': '1', 21:48:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:48:27 INFO - 'NO_EM_RESTART': '1', 21:48:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:48:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:48:27 INFO - 'PWD': '/builds/slave/test', 21:48:27 INFO - 'SHELL': '/bin/bash', 21:48:27 INFO - 'SHLVL': '1', 21:48:27 INFO - 'TERM': 'linux', 21:48:27 INFO - 'TMOUT': '86400', 21:48:27 INFO - 'USER': 'cltbld', 21:48:27 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1459909530.8227-861680776', 21:48:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:48:27 INFO - '_': '/tools/buildbot/bin/python'} 21:48:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:48:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:48:27 INFO - Running setup.py (path:/tmp/pip-cffkP3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:48:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:48:27 INFO - Running setup.py (path:/tmp/pip-P2ZKJ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:48:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:48:27 INFO - Running setup.py (path:/tmp/pip-t3EqzT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:48:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:48:27 INFO - Running setup.py (path:/tmp/pip-Ot6Iwd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:48:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:48:27 INFO - Running setup.py (path:/tmp/pip-yFMU0r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:48:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:48:28 INFO - Running setup.py (path:/tmp/pip-yyofYI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:48:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:48:28 INFO - Running setup.py (path:/tmp/pip-WO_LLh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:48:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:48:28 INFO - Running setup.py (path:/tmp/pip-YErKxY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:48:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:48:28 INFO - Running setup.py (path:/tmp/pip-k6nany-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:48:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:48:28 INFO - Running setup.py (path:/tmp/pip-oPXeCp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:48:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:48:28 INFO - Running setup.py (path:/tmp/pip-wTdnA1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:48:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:48:28 INFO - Running setup.py (path:/tmp/pip-Psayx1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:48:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:48:28 INFO - Running setup.py (path:/tmp/pip-cMDQ5T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:48:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:48:28 INFO - Running setup.py (path:/tmp/pip-4IK1Cw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:48:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:48:28 INFO - Running setup.py (path:/tmp/pip-JxVSem-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:48:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:48:28 INFO - Running setup.py (path:/tmp/pip-cYYYms-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:48:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:48:28 INFO - Running setup.py (path:/tmp/pip-uReN7I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:48:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:48:28 INFO - Running setup.py install for manifestparser 21:48:29 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:48:29 INFO - Running setup.py install for mozcrash 21:48:29 INFO - Running setup.py install for mozdebug 21:48:29 INFO - Running setup.py install for mozdevice 21:48:29 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:48:29 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:48:29 INFO - Running setup.py install for mozfile 21:48:29 INFO - Running setup.py install for mozhttpd 21:48:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:48:29 INFO - Running setup.py install for mozinfo 21:48:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:48:29 INFO - Running setup.py install for mozInstall 21:48:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:48:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:48:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:48:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:48:29 INFO - Running setup.py install for mozleak 21:48:29 INFO - Running setup.py install for mozlog 21:48:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:48:29 INFO - Running setup.py install for moznetwork 21:48:30 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:48:30 INFO - Running setup.py install for mozprocess 21:48:30 INFO - Running setup.py install for mozprofile 21:48:30 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:48:30 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:48:30 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:48:30 INFO - Running setup.py install for mozrunner 21:48:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:48:30 INFO - Running setup.py install for mozscreenshot 21:48:30 INFO - Running setup.py install for moztest 21:48:30 INFO - Running setup.py install for mozversion 21:48:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:48:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:48:30 INFO - Cleaning up... 21:48:30 INFO - Return code: 0 21:48:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:48:30 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')]} 21:48:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:48:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:48:30 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')]} 21:48:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:48:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:48:30 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 0x7f92eede1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x162f7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16be640>, '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 0x16bf540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16bf9d0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1459909530.8227-861680776', '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 21:48:30 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 21:48:30 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 21:48:30 INFO - Using env: {'DISPLAY': ':0', 21:48:30 INFO - 'HOME': '/home/cltbld', 21:48:30 INFO - 'LANG': 'en_US.UTF-8', 21:48:30 INFO - 'LANGUAGE': 'en_US:en', 21:48:30 INFO - 'LOGNAME': 'cltbld', 21:48:30 INFO - 'MAIL': '/var/mail/cltbld', 21:48:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:48:30 INFO - 'MOZ_NO_REMOTE': '1', 21:48:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:48:30 INFO - 'NO_EM_RESTART': '1', 21:48:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:48:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:48:30 INFO - 'PWD': '/builds/slave/test', 21:48:30 INFO - 'SHELL': '/bin/bash', 21:48:30 INFO - 'SHLVL': '1', 21:48:30 INFO - 'TERM': 'linux', 21:48:30 INFO - 'TMOUT': '86400', 21:48:30 INFO - 'USER': 'cltbld', 21:48:30 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1459909530.8227-861680776', 21:48:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:48:30 INFO - '_': '/tools/buildbot/bin/python'} 21:48:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:48:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:48:30 INFO - Running setup.py (path:/tmp/pip-IxRJna-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:48:30 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)) 21:48:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:48:30 INFO - Running setup.py (path:/tmp/pip-SXG9eY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:48:31 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)) 21:48:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:48:31 INFO - Running setup.py (path:/tmp/pip-btneYI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:48:31 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)) 21:48:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:48:31 INFO - Running setup.py (path:/tmp/pip-Q0rgdO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:48:31 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)) 21:48:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:48:31 INFO - Running setup.py (path:/tmp/pip-btOv0v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:48:31 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)) 21:48:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:48:31 INFO - Running setup.py (path:/tmp/pip-IDThLf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:48:31 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)) 21:48:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:48:31 INFO - Running setup.py (path:/tmp/pip-r7zJg4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:48:31 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)) 21:48:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:48:31 INFO - Running setup.py (path:/tmp/pip-ExbqLq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:48:31 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)) 21:48:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:48:31 INFO - Running setup.py (path:/tmp/pip-_RS76N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:48:31 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)) 21:48:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:48:31 INFO - Running setup.py (path:/tmp/pip-KVJo4i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:48:31 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)) 21:48:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:48:31 INFO - Running setup.py (path:/tmp/pip-l7K73p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:48:31 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)) 21:48:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:48:31 INFO - Running setup.py (path:/tmp/pip-nXN1fN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:48:31 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)) 21:48:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:48:31 INFO - Running setup.py (path:/tmp/pip-x_Il9I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:48:31 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)) 21:48:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:48:31 INFO - Running setup.py (path:/tmp/pip-iGU2_m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:48:31 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)) 21:48:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:48:31 INFO - Running setup.py (path:/tmp/pip-yLWHvh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:48:32 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)) 21:48:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:48:32 INFO - Running setup.py (path:/tmp/pip-FwLAEo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:48:32 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)) 21:48:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:48:32 INFO - Running setup.py (path:/tmp/pip-knL1LY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:48:32 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)) 21:48:32 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)) 21:48:32 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)) 21:48:32 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)) 21:48:32 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)) 21:48:32 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)) 21:48:32 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:48:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:48:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:48:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:48:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:48:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:48:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:48:34 INFO - Downloading blessings-1.6.tar.gz 21:48:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:48:34 INFO - Installing collected packages: blessings 21:48:34 INFO - Running setup.py install for blessings 21:48:34 INFO - Successfully installed blessings 21:48:34 INFO - Cleaning up... 21:48:34 INFO - Return code: 0 21:48:34 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:48:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:48:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:48:34 INFO - Reading from file tmpfile_stdout 21:48:34 INFO - Current package versions: 21:48:34 INFO - argparse == 1.2.1 21:48:34 INFO - blessings == 1.6 21:48:34 INFO - blobuploader == 1.2.4 21:48:34 INFO - docopt == 0.6.1 21:48:34 INFO - manifestparser == 1.1 21:48:34 INFO - mozInstall == 1.12 21:48:34 INFO - mozcrash == 0.17 21:48:34 INFO - mozdebug == 0.1 21:48:34 INFO - mozdevice == 0.48 21:48:34 INFO - mozfile == 1.2 21:48:34 INFO - mozhttpd == 0.7 21:48:34 INFO - mozinfo == 0.9 21:48:34 INFO - mozleak == 0.1 21:48:34 INFO - mozlog == 3.1 21:48:34 INFO - moznetwork == 0.27 21:48:34 INFO - mozprocess == 0.22 21:48:34 INFO - mozprofile == 0.28 21:48:34 INFO - mozrunner == 6.11 21:48:34 INFO - mozscreenshot == 0.1 21:48:34 INFO - mozsystemmonitor == 0.0 21:48:34 INFO - moztest == 0.7 21:48:34 INFO - mozversion == 1.4 21:48:34 INFO - psutil == 3.1.1 21:48:34 INFO - requests == 1.2.3 21:48:34 INFO - wsgiref == 0.1.2 21:48:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:48:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:48:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:48:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:48:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:48:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:48:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:48:34 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 0x7f92eede1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x162f7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16be640>, '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 0x16bf540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16bf9d0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1459909530.8227-861680776', '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 21:48:34 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 21:48:34 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 21:48:34 INFO - Using env: {'DISPLAY': ':0', 21:48:34 INFO - 'HOME': '/home/cltbld', 21:48:34 INFO - 'LANG': 'en_US.UTF-8', 21:48:34 INFO - 'LANGUAGE': 'en_US:en', 21:48:34 INFO - 'LOGNAME': 'cltbld', 21:48:34 INFO - 'MAIL': '/var/mail/cltbld', 21:48:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:48:34 INFO - 'MOZ_NO_REMOTE': '1', 21:48:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:48:34 INFO - 'NO_EM_RESTART': '1', 21:48:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:48:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:48:34 INFO - 'PWD': '/builds/slave/test', 21:48:34 INFO - 'SHELL': '/bin/bash', 21:48:34 INFO - 'SHLVL': '1', 21:48:34 INFO - 'TERM': 'linux', 21:48:34 INFO - 'TMOUT': '86400', 21:48:34 INFO - 'USER': 'cltbld', 21:48:34 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1459909530.8227-861680776', 21:48:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:48:34 INFO - '_': '/tools/buildbot/bin/python'} 21:48:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:48:34 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)) 21:48:34 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)) 21:48:34 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)) 21:48:34 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)) 21:48:34 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)) 21:48:34 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)) 21:48:34 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)) 21:48:34 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)) 21:48:34 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)) 21:48:34 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)) 21:48:34 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)) 21:48:34 INFO - Cleaning up... 21:48:34 INFO - Return code: 0 21:48:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:48:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:48:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:48:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:48:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:48:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:48:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:48:34 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 0x7f92eede1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x162f7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16be640>, '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 0x16bf540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16bf9d0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1459909530.8227-861680776', '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 21:48:34 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 21:48:34 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 21:48:34 INFO - Using env: {'DISPLAY': ':0', 21:48:34 INFO - 'HOME': '/home/cltbld', 21:48:34 INFO - 'LANG': 'en_US.UTF-8', 21:48:34 INFO - 'LANGUAGE': 'en_US:en', 21:48:34 INFO - 'LOGNAME': 'cltbld', 21:48:34 INFO - 'MAIL': '/var/mail/cltbld', 21:48:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:48:34 INFO - 'MOZ_NO_REMOTE': '1', 21:48:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:48:34 INFO - 'NO_EM_RESTART': '1', 21:48:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:48:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:48:34 INFO - 'PWD': '/builds/slave/test', 21:48:34 INFO - 'SHELL': '/bin/bash', 21:48:34 INFO - 'SHLVL': '1', 21:48:34 INFO - 'TERM': 'linux', 21:48:34 INFO - 'TMOUT': '86400', 21:48:34 INFO - 'USER': 'cltbld', 21:48:34 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1459909530.8227-861680776', 21:48:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:48:34 INFO - '_': '/tools/buildbot/bin/python'} 21:48:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:48:34 INFO - Downloading/unpacking jsonschema 21:48:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:48:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:48:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:48:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:48:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:48:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:48:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:48:36 INFO - Downloading/unpacking functools32 (from jsonschema) 21:48:36 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 21:48:36 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 21:48:36 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 21:48:36 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 21:48:36 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 21:48:36 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 21:48:37 INFO - Downloading functools32-3.2.3-2.tar.gz 21:48:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:48:37 INFO - warning: no files found matching '*.txt' 21:48:37 INFO - no previously-included directories found matching 'build' 21:48:37 INFO - no previously-included directories found matching 'dist' 21:48:37 INFO - no previously-included directories found matching '.git*' 21:48:37 INFO - Installing collected packages: jsonschema, functools32 21:48:37 INFO - Running setup.py install for functools32 21:48:37 INFO - warning: no files found matching '*.txt' 21:48:37 INFO - no previously-included directories found matching 'build' 21:48:37 INFO - no previously-included directories found matching 'dist' 21:48:37 INFO - no previously-included directories found matching '.git*' 21:48:37 INFO - Successfully installed jsonschema functools32 21:48:37 INFO - Cleaning up... 21:48:37 INFO - Return code: 0 21:48:37 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 21:48:37 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')]} 21:48:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:48:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:48:37 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')]} 21:48:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:48:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:48:37 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 0x7f92eede1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x162f7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16be640>, '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 0x16bf540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16bf9d0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1459909530.8227-861680776', '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 21:48:37 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 21:48:37 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 21:48:37 INFO - Using env: {'DISPLAY': ':0', 21:48:37 INFO - 'HOME': '/home/cltbld', 21:48:37 INFO - 'LANG': 'en_US.UTF-8', 21:48:37 INFO - 'LANGUAGE': 'en_US:en', 21:48:37 INFO - 'LOGNAME': 'cltbld', 21:48:37 INFO - 'MAIL': '/var/mail/cltbld', 21:48:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:48:37 INFO - 'MOZ_NO_REMOTE': '1', 21:48:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:48:37 INFO - 'NO_EM_RESTART': '1', 21:48:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:48:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:48:37 INFO - 'PWD': '/builds/slave/test', 21:48:37 INFO - 'SHELL': '/bin/bash', 21:48:37 INFO - 'SHLVL': '1', 21:48:37 INFO - 'TERM': 'linux', 21:48:37 INFO - 'TMOUT': '86400', 21:48:37 INFO - 'USER': 'cltbld', 21:48:37 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1459909530.8227-861680776', 21:48:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:48:37 INFO - '_': '/tools/buildbot/bin/python'} 21:48:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:48:37 INFO - Downloading/unpacking flake8 21:48:37 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 21:48:37 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 21:48:37 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 21:48:37 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 21:48:37 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 21:48:37 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 21:48:39 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 21:48:39 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 21:48:39 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 21:48:39 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 21:48:39 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 21:48:39 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 21:48:39 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 21:48:39 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 21:48:39 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 21:48:39 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 21:48:39 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 21:48:39 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 21:48:39 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 21:48:39 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 21:48:39 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 21:48:39 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 21:48:39 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 21:48:39 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 21:48:39 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 21:48:39 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 21:48:39 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 21:48:39 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 21:48:39 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 21:48:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 21:48:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 21:48:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 21:48:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 21:48:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 21:48:40 INFO - no previously-included directories found matching 'docs/_build' 21:48:40 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 21:48:40 INFO - Running setup.py install for pep8 21:48:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 21:48:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 21:48:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 21:48:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 21:48:40 INFO - no previously-included directories found matching 'docs/_build' 21:48:40 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 21:48:40 INFO - Successfully installed flake8 mccabe pyflakes pep8 21:48:40 INFO - Cleaning up... 21:48:40 INFO - Return code: 0 21:48:40 INFO - Running post-action listener: _resource_record_post_action 21:48:40 INFO - Running post-action listener: _start_resource_monitoring 21:48:40 INFO - Starting resource monitoring. 21:48:40 INFO - ##### 21:48:40 INFO - ##### Running install step. 21:48:40 INFO - ##### 21:48:40 INFO - Running pre-action listener: _resource_record_pre_action 21:48:40 INFO - Running main action method: install 21:48:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:48:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:48:40 INFO - Reading from file tmpfile_stdout 21:48:40 INFO - Detecting whether we're running mozinstall >=1.0... 21:48:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:48:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:48:40 INFO - Reading from file tmpfile_stdout 21:48:40 INFO - Output received: 21:48:40 INFO - Usage: mozinstall [options] installer 21:48:40 INFO - Options: 21:48:40 INFO - -h, --help show this help message and exit 21:48:40 INFO - -d DEST, --destination=DEST 21:48:40 INFO - Directory to install application into. [default: 21:48:40 INFO - "/builds/slave/test"] 21:48:40 INFO - --app=APP Application being installed. [default: firefox] 21:48:40 INFO - mkdir: /builds/slave/test/build/application 21:48:40 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'] 21:48:40 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 21:48:56 INFO - Reading from file tmpfile_stdout 21:48:56 INFO - Output received: 21:48:56 INFO - /builds/slave/test/build/application/firefox/firefox 21:48:56 INFO - Running post-action listener: _resource_record_post_action 21:48:56 INFO - ##### 21:48:56 INFO - ##### Running run-tests step. 21:48:56 INFO - ##### 21:48:56 INFO - Running pre-action listener: _resource_record_pre_action 21:48:56 INFO - Running main action method: run_tests 21:48:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:48:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:48:56 INFO - Python 2.7.3 21:48:56 INFO - Return code: 0 21:48:56 INFO - grabbing minidump binary from tooltool 21:48:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:48:56 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 0x16be640>, '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 0x16bf540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16bf9d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:48:56 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 21:48:56 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 21:48:56 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:48:56 INFO - Return code: 0 21:48:56 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:48:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:48:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:48:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:48:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:48:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 21:48:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 21:48:57 INFO - Return code: 0 21:48:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XBOJ3KexRGKY_ZIkuchWtg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 21:48:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/XBOJ3KexRGKY_ZIkuchWtg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-019 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 21:48:57 INFO - Using env: {'DISPLAY': ':0', 21:48:57 INFO - 'HOME': '/home/cltbld', 21:48:57 INFO - 'LANG': 'en_US.UTF-8', 21:48:57 INFO - 'LANGUAGE': 'en_US:en', 21:48:57 INFO - 'LOGNAME': 'cltbld', 21:48:57 INFO - 'MAIL': '/var/mail/cltbld', 21:48:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:48:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:48:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:48:57 INFO - 'MOZ_NO_REMOTE': '1', 21:48:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:48:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:48:57 INFO - 'NO_EM_RESTART': '1', 21:48:57 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:48:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:48:57 INFO - 'PWD': '/builds/slave/test', 21:48:57 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:48:57 INFO - 'SHELL': '/bin/bash', 21:48:57 INFO - 'SHLVL': '1', 21:48:57 INFO - 'TERM': 'linux', 21:48:57 INFO - 'TMOUT': '86400', 21:48:57 INFO - 'USER': 'cltbld', 21:48:57 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1459909530.8227-861680776', 21:48:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:48:57 INFO - '_': '/tools/buildbot/bin/python'} 21:48:57 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XBOJ3KexRGKY_ZIkuchWtg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 21:48:57 INFO - mozversion application_buildid: 20160405205712 21:48:57 INFO - mozversion application_changeset: 75bef7c5fd91e42e5cfa5337f02f48942b568996 21:48:57 INFO - mozversion application_display_name: Nightly 21:48:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:48:57 INFO - mozversion application_name: Firefox 21:48:57 INFO - mozversion application_remotingname: firefox 21:48:57 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 21:48:57 INFO - mozversion application_vendor: Mozilla 21:48:57 INFO - mozversion application_version: 48.0a1 21:48:57 INFO - mozversion platform_buildid: 20160405205712 21:48:57 INFO - mozversion platform_changeset: 75bef7c5fd91e42e5cfa5337f02f48942b568996 21:48:57 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 21:48:57 INFO - mozversion platform_version: 48.0a1 21:48:57 INFO - using testdate: 1459918137 21:48:57 INFO - actual date: 1459918137 21:48:57 INFO - starting webserver on 'localhost:57940' 21:48:57 INFO - SUITE-START | Running 2 tests 21:48:57 INFO - TEST-START | dromaeo_css 21:48:57 INFO - operating with platform_type : linux_ 21:48:57 INFO - Initialising browser for dromaeo_css test... 21:48:57 INFO - TEST-INFO | started process 29415 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQeNUEL/profile http://localhost:57940/getInfo.html) 21:49:02 INFO - PROCESS | 29415 | __metrics Screen width/height:1600/1200 21:49:02 INFO - PROCESS | 29415 | colorDepth:24 21:49:02 INFO - PROCESS | 29415 | Browser inner width/height: 1024/697 21:49:02 INFO - PROCESS | 29415 | __metrics 21:49:03 ERROR - PROCESS | 29415 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 21:49:04 INFO - TEST-INFO | 29415: exit 0 21:49:04 INFO - Browser initialized. 21:49:04 INFO - Running cycle 1/1 for dromaeo_css test... 21:49:04 INFO - TEST-INFO | started process 29494 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQeNUEL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:49:16 INFO - PROCESS | 29494 | RSS: Main: 154161152 21:49:16 INFO - PROCESS | 29494 | 21:50:07 INFO - PROCESS | 29494 | 1459918207161 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] 21:52:18 INFO - PROCESS | 29494 | Cycle 1(1): loaded http://localhost:57940/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57940/tests/dromaeo/cssquery-ext.html) 21:52:19 INFO - PROCESS | 29494 | RSS: Main: 235290624 21:52:19 INFO - PROCESS | 29494 | 21:55:21 INFO - PROCESS | 29494 | Cycle 1(1): loaded http://localhost:57940/tests/dromaeo/cssquery-ext.html (next: http://localhost:57940/tests/dromaeo/cssquery-jquery.html) 21:55:22 INFO - PROCESS | 29494 | RSS: Main: 232882176 21:55:22 INFO - PROCESS | 29494 | 21:58:23 INFO - PROCESS | 29494 | Cycle 1(1): loaded http://localhost:57940/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57940/tests/dromaeo/cssquery-mootools.html) 21:58:24 INFO - PROCESS | 29494 | RSS: Main: 223019008 21:58:24 INFO - PROCESS | 29494 | 22:01:26 INFO - PROCESS | 29494 | Cycle 1(1): loaded http://localhost:57940/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57940/tests/dromaeo/cssquery-prototype.html) 22:01:27 INFO - PROCESS | 29494 | RSS: Main: 221622272 22:01:27 INFO - PROCESS | 29494 | 22:04:29 INFO - PROCESS | 29494 | Cycle 1(1): loaded http://localhost:57940/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57940/tests/dromaeo/cssquery-yui.html) 22:04:30 INFO - PROCESS | 29494 | RSS: Main: 199602176 22:04:30 INFO - PROCESS | 29494 | 22:07:32 INFO - PROCESS | 29494 | Cycle 1(1): loaded http://localhost:57940/tests/dromaeo/cssquery-yui.html (next: http://localhost:57940/tests/dromaeo/cssquery-dojo.html) 22:07:33 INFO - PROCESS | 29494 | RSS: Main: 249004032 22:07:33 INFO - PROCESS | 29494 | 22:07:33 INFO - PROCESS | 29494 | __start_tp_report 22:07:33 INFO - PROCESS | 29494 | _x_x_mozilla_page_load 22:07:33 INFO - PROCESS | 29494 | _x_x_mozilla_page_load_details 22:07:33 INFO - PROCESS | 29494 | |i|pagename|runs| 22:07:33 INFO - PROCESS | 29494 | |0;dojo.html;2568.9999999999995;2660.50780605588;2667.6932152802433;2675.57190849464;2687.0326682394334;4582.1064892346;4652.674312798105;4661.044485880395;4673.252279635259;4699.4595621503495;4649.279361698934;4673.135469938055;4686.320483529886;4691.319758634996;4744.810207591692;4228.450301460805;4286.76422796746;4292.377605247245;4294.828206871722;4357.368181613664;4271.9359209611885;4300.3764454154125;4317.503487098977;4327.350897365389;4385.407969924051;4221.662267018631;4259.914801703949;4315.762633055181;4363.367311739812;4366.257736184856;4264.1471705659;4287.957120428787;4291.270484017725;4323.092150648367;4334.263175260214;4112.650424713903;4265.893352666209;4273.274350390561;4279.251131052053;4313.331433627793;4489.057297967431;4544.659150563721;4554.795034223468;4578.496365399803;4592.334111553806;4913.852584422473;4946.2580612908;4946.431160416562;4946.802127914879;4999.3000979862845;4851.126797176506;4952.702837829742;4957.231629097496;4964.652474326798;5015.84952451427;4645.558671926162;4669.509701481364;4682.789274482657;4725.881852953669;4737.076270127292;5053.898922021613;5061.8228362007885;5071.797128114834;5073.467285934998;5116.769745361467;4776.355192049098;4842.491538388489;4848.345473361122;4861.562459378673;4899.363082799213;4892.755362231874;4949.183384741549;4960.950390496121;4987.476314986874;5002.59979201663;4881.267809828554;4911.214205727067;4911.4106307243355;4912.484189160158;4958.057968985881;4831.178699621073;4886.804527818918;4892.657513974059;4925.408950925912;4981.078500477423;4297.548757380492;4302.118065796567;4302.419173411612;4327.134573085333;4329;3724.2551489701627;3747.9625203747614;3748.83130259139;3787.962120378816;3794.6774524165203;4163.250614889288;4234.237837189274;4254.127903779718;4308.267594508941;4363.040131171138;4953.504649535018;4971.2543118531785;4975.4527002029745;4979.875503112451;5005.199168133154;4304.246756817544;4306.20335237982;4309.569043095666;4335.111302183045;4356.76037817923;4418.668599854959;4482.21561226784;4515.277555591089;4555.794989225493;4583.702059366131;4712.081144176853;4715.7877895494785;4728.739919304402;4738.549837765407;4777.665563410528;4995.2507123930245;5007.248912662984;5017.347744793154;5017.899642007066;5069.188929771219;4537.523560026149;4689.648276379217;4732.787024583971;4761.523847615211;4776.808927642855;4893.632977526629;4899.387576552931;4906.509349065065;4929.630277729113;4973.776180071833;4832.806687732451;4979.601631869514;4986.426560945538;4988.1270777613045;5029.622778291569;4750.8337208197545;4803.231482962709;4820.517948205152;4824.734639594856;4862.708237505761;4759.714417134983;4778;4787.305840653155;4790.5448982346625;4836.733979631154;4630.606398456169;4698.530146985411;4721.339012538178;4723.858284251341;4773.570378665937;4823.27650852375;4834.8791280218275;4843.588294994965;4852.95147048525;4885.413750349981;4743.644226682944;4746.477887432311;4749.786259618395;4750.073735621659;4776.928346074881 22:07:33 INFO - PROCESS | 29494 | |1;ext.html;517.629894625343;517.9715115668638;529.9216095246175;536.3965538768884;543.0930346321643;30072;30642.84678576604;30675.38649227014;30695;35413.11467213321;38340.424893626616;38910.22179556407;38976.22047559047;38995.80502097493;39022;7605.505642133271;7813.101493328255;7826.452148349618;7828.452008359417;7828.530288182699;7857.057153141603;8014.438989270753;8023.839523209533;8023.879641805378;8027.3578113751055;8018.959905200466;8085.151059138794;8087.069986951487;8088.231617996281;8090.959545202295;7987.720429784929;8036.357091432671;8064.032316122044;8065;8069.556174410405;7957.5225486471;8063.27430531255;8075.3539716822515;8083.797905052362;8093.838123237502;37905.62094379076;38354.23291534182;38418.80790596029;38423.423648645294;38464;3057.7706671999467;3505.789652620851;3818.5417749870194;3834.482344883433;3991.381335892941;29517;29878.551821722693;29991.850040749658;30065.398692026254;30243.18363875516;3565.3938830398893;3565.750397472178;3580.337637537038;3586.6413358664186;3595.442706380515;248221;249161;249183;249662;250187;43320;53153.46846531485;53694.73152634212;53739.73130134324;53753.462465375625;42329.365059524134;42466.78766606147;42560;42600.57399426028;42619.36070958938;14095.929520352538;14337.713245735027;14347.210903400204;14348;14355.425782968565;11260.549578016788;11261.43692815356;11336.149788765875;11347.092232621371;11354.148438867118;14628.341724622418;14656.193909335088;15043.398264069314;15100.39598416051;15204.923975380052;5573.637713548606;5843.18195452637;5867.765289388462;5872.559558033165;5879.353271140171;853.6926706385697;921.6820197032014;963.3545524498603;975.9365641233439;1021.4228960637216;27009.324766880593;27711.44577108487;27851.44297114087;28202.15393538197;28260.576091358645;914.3371055984358;932.4451951089092;983.8425851863667;986.40815510693;995.5615372816018;13642.454301828015;14052.156870587798;14168.291585420688;14447.85552144486;14464.27678616065;284339;285156;285895;288112;288861;47093.29360059602;47548.28677569839;47554.76222618865;47607.76196118997;47662;1058.3702696895334;1137.9203455758018;1228.1955319265894;1239.5723475400973;1240.1814802230485;25944.8702756485;27359.58960615632;27797.722022779515;27889.58165627558;28252.293692657848;38477.422838658;38544.42183367308;38773.41839872348;38787.2242555153;38793.22413551657;199663;200692;200859;201232;201410;32773.34453310968;32823.67176328206;33009.50485742668;33271.83364083164;33932.32135357329;41408;41647.58352416558;42098.368524471545;42343;42451.575484246;35929.46105808362;35946.64053359433;36234.8188259057;36466.8176659115;36490.45264320984;35381.82309088438;35770.28459430849;35875.641243588274;35907.820460898576;35944.101397465274;35000.47499287462;36414;36432.27135457329;37835.24329513339;38649.22701545897;28944.42111157807;29300.56049159307;29521.409571808872;29534.556981644862;29664.851675741484;24877.87561062183;25054.62418063767;25242.873785630953;25319.873400633616;25329 22:07:33 INFO - PROCESS | 29494 | |2;jquery.html;341.6037396619921;341.8991397537727;349.3205714884549;353.64988661225397;364.7300997262027;14721.705565888677;15419.614509637264;16087.51737447877;16095.195240238;16112.516624501255;15464.381424743025;15521.146336951464;15696.921515392436;16006.679866402694;16037.759433608506;4581.152486789946;4610.815567377318;4703.600193983499;4703.764811759415;4728.574428301452;5063.79744810209;5077.492250774912;5099.515546023122;5124.462661201644;5128;5092.694438333693;5093.821716239932;5096;5102.795888164487;5103.642745007851;5098.133317336062;5121.078205922932;5332.893342133174;5346.4118946915805;5351.625386222947;5141.948580514184;5149.9485005149845;5155.278261043457;5161.045206636784;5175.689458632494;16547.84165108443;17917.641647167115;20089.497762555908;20094;20113.09491072905;1873.4847916822846;1955.5795503966715;2012.4365177750108;2307.849989750661;2343.8397992993578;9102.408343457653;9163.908360916372;9452.763680907963;9558.761030974212;12733;1665.4504013675457;1678.2783403136646;1680.5882558773178;1719.6302794899157;1745.1623220853935;44940.550594493965;59065;63095;63132.36867631357;64116.679416602616;9159.679411220575;9203.447793132433;9349.158575728217;9364.812703746024;9428.952855235817;11736;12436.626901192978;12937.094403391673;12948.611541653765;12973;7038.92961070393;7115.786526404217;7218.927810721931;7235.2764723527225;7297.1608265049135;6917.481188910851;6959.721611135498;7038.92961070393;7072.8939065914055;7082.716691332392;4110.8561200358445;4120.320147175742;4219.915601687949;4288.7212331199;4314.827406903689;1783.2777725021388;1821.7813862336338;1823.389164629864;1825.6896327624336;1869.9065046747608;836.3768992100923;881.9955900220458;927.3879239701764;960.1454705312277;1001.5643195210107;15275.770863437057;15587.766183507256;15986.520404387888;16097.11465869365;16385;854.786303424144;867.1935100356603;898.4474548152839;898.8831451911341;929.4330458420358;9060.864087038699;9147.588358523883;9172.082791720908;9221.446713197229;9305.95347023274;312404;319638;376266;376924;380318;71987.2801271991;73372.63313683397;74161;74242;74553.62723186458;958.1711819276276;975.4683697384942;985.211830535583;985.7042887133831;989.3618615992644;11989.76020479603;14797.260136993322;14834;15118.697626047637;15331.923340383226;33367.33265334728;33614.49578256279;33742.66257337493;34270.14324641904;34786.65213347834;38504;40240.396394053525;40499.59500405076;40706;41002.58997409988;7407.740729074457;7450.441216908862;7477;7478.663460144197;7556.811079723051;10391.480425978822;11414.258073225214;11858.11064170208;11958.940205298917;12026.338551379758;9839.754006149904;9975.102240798364;10171.898281017095;10223.568700381804;10443.94778026105;9583.952080239833;9684.95157524208;9685.6610018649;10135.49322533885;10338.431386273827;10551.41967191781;10575.629852955417;10590.8411373831;10668.733281668021;10897.891021089688;7456.51532650376;7512.436567257369;7545.886811697719;7549.849003020019;7687.154413014452;10278.383297002203;10534.262601617813;10616.416097114425;10728.51721672511;10759.63288076622 22:07:33 INFO - PROCESS | 29494 | |3;mootools.html;1372.951946681866;1376.8691974262442;1475.7565001774708;1682.646644204717;1690.949271521854;7141.85716285674;7287.708491660327;7311.086114235721;7311.268873112686;7327.487075904689;6252.562320637558;6947.374736273734;7059.7882063538045;7090.149182098143;7244.746433874815;2205.040807248844;2230.3754948614414;2232.10715713715;2232.6762619420174;2235.1953296813135;2160.978390216101;2201.0535469748;2202.48241663209;2207.23850271656;2209.3151123151874;1886.7924528301944;1937.6221636780833;1937.7384053152855;2116.0689296709475;2156.579467003935;2142.3572928121503;2171.6742488626674;2173.880436575988;2175.7715439878903;2177.499175189715;2144.1852096203343;2177.085624037908;2186.562687462514;2187.814035806958;2191.22211614876;7211;7321.926780732178;7330.083739532559;7330.157031941341;7333.633318334116;4309.849155279581;4429.579189976947;4437.534058923831;4438.60052595268;4444.155610434007;2791.7068707785593;2857.5999360089604;2871.985640071807;2885.5960165576835;2893.088677066717;940.6754669639032;972.8492083727034;976.7899901521135;980.5097451274363;996.9102780749695;9293.628254869796;9302.488363140092;9319.813603727887;9319.953400232955;9331.253499720005;3951.585083566242;4008.5189777226337;4044.7775372354804;4065.593440655911;4079.8776036718946;8100.270975612223;8112.553809540532;8133.75598732039;8145.307648849915;8153.306968907709;4384.4519435070615;4408.647308215399;4444.088961762831;4452.621527170227;4452.755098469551;4028.67770578353;4035.6771458283265;4038.1519880824767;4038.192361527706;4044.3933409988736;3409.4715319125576;3586.5875424326537;3618.6924111450294;3620.2940426616556;3621.764585301947;1114.821628539446;1130.4008875296106;1135.4436326200268;1138.5673444091192;1142.7200335917753;917.775145089444;956.9712908612753;1010.5604062232952;1010.696790962723;1135.6876858863714;6667.766628168088;6702.36327548882;6743.9325606743305;6754.0881980931945;6770.627615481098;1000.1798525209258;1007.6876168387823;1018.495844556949;1032.200044965143;1057.6139709006156;5201.921971170435;5276.973615131977;5310.097283461821;5317.1226747586215;5318.228856815817;8313.16868313176;8496.447730897595;8513.787155321043;8840.425372350777;8845.513496757612;8355.289800366916;8386.580670966427;8504.107068757816;8508.234258916727;8522.275606573387;7024.964875175591;7054.4003759681;7092.290770922867;7098.964505177441;7154.570725756367;6888.690008949509;6912.4815638828295;6965.686544105426;7015.6842942066705;7016.5790052597;7819.374450044096;7822.608869556613;8175.959120204361;8182.631781569725;8261.339092872435;8182.918170818216;8361.749147525585;8374.748757537283;8499.702510412106;8505.979282486142;6349.333320001333;6556.901646475211;6667.66661666905;6674;6678.432333251728;6925.549839260432;7020.262872398529;7022.262662420372;7022.824429389306;7025.2272250053475;6071.939280607137;6119.969400152971;6165.3526379731275;6221.844453888689;6270.310265870659;4929.852104436729;6268.874622507433;6295.622262664255;6314.242290925118;6415.262244841903;6501.187351581052;6528.967355163194;6563.1796025496815;6563.245226798979;6575.408213260829;6067.757289708539;6112.663803490851;6112.694365281629;6117.204763380732;6123.877522449615;5695.686737229492;5712.685802280915;5758.3090029196765;5760.049591817471;5762.135679648086 22:07:33 INFO - PROCESS | 29494 | |4;prototype.html;309.77850836651794;315.5093829095756;318.8230532054709;324.3140757298315;324.8830421048424;5384.784608615656;5457.263269458622;5461.15352120421;5474.78100875965;5483.150111732678;5377.623566350357;5381.408045115034;5386.596005299609;5386.73066346683;5393.406725260228;4038.97980510097;4096.5903409659095;4226.809793559297;4230.7038507304505;4238.830446782125;4191.266528357541;4234.322508398657;4238.21593005295;4241.597048280424;4244.193603215394;3984.1633257015915;4204.726692764976;4209.074003719177;4209.957900420987;4212.3260278355465;4041.2927737645796;4124.8143833527565;4126.42230087788;4142.150859073898;4188.141431006637;3692.1692619160476;3695.224002959382;3698.278835627054;3705.4627079073384;3711.2206436648066;5138.640295179339;5140.614453915934;5143.459936706667;5144.5369916707305;5146.356705411824;4814.085323788504;4821.059893320804;4822.276658501218;4824.083424149436;4827.662063655545;5663;5672.695280085562;5676.631018983753;5680.11958146488;5680.176374425685;3830.9042273943096;4047.372657238133;4049.979750101231;4050.41269015991;4055.2497787909333;5906.291245050578;5953.136795164677;5980.641161530322;5981.611195272293;5984.281886173643;4061.1065565575527;4061.9796901015307;4068.1863627274665;4069.2878746219885;4071.3485842265095;4121.443605113332;4124.649404800625;4125.463689720377;4128.442660240889;4129.174165166979;4736.360591320196;4737.549932756383;4739.928901066487;4739.976300118477;4742.905141897143;5668.149777533403;5672.064109421982;5677.318721753333;5679.886402271932;5701.800436984686;1395;1431.334429490292;1456.89801713879;1460.8247010358825;1463.5828788795143;949.126803340928;959.1751094059103;959.4579062829479;963.8843338799248;969.2536746704998;4813.975930120327;4885.65800393969;4936.308916751657;4968.130577148984;4969.229769385751;5857.414258574108;5904.232449781587;5968.432998865101;6010.549208809357;6014.1580178775;5026.572741316956;5036.143855544567;5040.067587496325;5041.143005689041;5041.8487445376695;3146;3179.475386561238;3182.0931034655014;3183.5861338025907;3187.8724851006164;5563.137713654309;5567.582431317667;5569.777208911679;5571.777128914879;5574.163875418639;5860.501857342174;6087.299960504599;6125.418085281891;6130.295016073209;6140.3552626974415;5565.16522521625;5584.832455026356;5587.106063029977;5593.608447408642;5603.187537807076;5948.762049517971;5949.762009519571;5952.732127054206;5959.91060134107;5965.940340596539;5806.216160818235;5806.65160090396;5850.356460789395;5866.2373891393845;5866.50134738535;5506.1190209566275;5536.141898005815;5576.498115169654;5594.13290939905;5601.187827765033;3918.8628398005935;4058.295515883395;4093.63157315843;4101.979490102531;4104.56902025283;5839.240898683144;5856.531477481876;5865.266841644794;5865.354810970875;5888.087346461305;5632.380438151882;5639.351474580476;5647.435256474484;5648.5481161507805;5659.858503537444;5619.438056194348;5651.378348381757;5664.801731939362;5671;5679.403662615366;5400.081986062457;5586.078297081099;5595.720213989202;5599.356074051373;5602.607817452739;5751.1085781703905;5808.7095645218415;5836.824895253149;5837.299524056971;5846.883062338815;5613.298337707786;5617.775288988558;5620.8032718856275;5637;5640.54875609942 22:07:33 INFO - PROCESS | 29494 | |5;yui.html;667.3026687111967;775.5734346109638;789.9328557072648;790.1466416270429;793.9717326337174;12253.632391028272;12291.631251062483;12294.26234425934;12346.876531234684;12395;11729.589464368748;11749.588764393247;11761.764764704702;11765.941170294136;11808.645740627795;637.9968100159492;788.6056971514242;798.3692882622736;811.8863359129726;812.6058861452191;812.4597142899964;815.3314282288526;818.7298191596759;818.8730746734266;819.0171793847377;849.4563479373206;861.0356400831078;861.5562985062697;862.1249431826701;862.689431804553;670.2928410526893;680.1226417920876;851.1233429567556;853.8889944307232;855.2687452228317;498.51643905412055;617.4905702795212;626.9028300613412;629.6473974574253;630.1021045010841;11555.133364997659;11559.306441613446;11569.595064172798;11614.18700690952;11669.766604667859;11680.474378652982;12429.689257768538;12470.625881223577;12699.555515557004;12807.423665935055;9752.073553012453;9854.655087071918;9909.256805739598;10295.124914382286;10402.219833512518;3434.158631135363;3443.8450269737673;3452.067941655764;3532.717382609385;3573;41611.58388416137;42062.36906446406;42423.36364954528;42606;42623.786881065396;10127.544260508295;10161.54273057714;10225.642102526375;10276.640317588848;10397.63608273722;18077.7288340675;18100.54748631295;18140.18369173364;18328;18338.174782134836;6860.245373008965;7080.575165490087;7242.601656908815;7248.492605517668;7326.523775954546;3847.711421643388;3883.689304855605;3888.941665875014;3919.392494163409;4004;2824.7994602293943;2860.971390286112;2862.2415060009116;2867.4551835151256;2867.5411934090444;494.3672099712374;512.9100661095173;518.3028826228791;520.8359366799446;529.0529951387051;538.9137737961908;642.1331202876173;644.9762090830856;649.3538928765909;659.6569783712442;7653;7700;7784.610769461504;7966.84066318682;7993.960030199928;634.9333320001333;640.6668532363238;642.1459458919719;645.2450632759683;647.5499527828208;3603;3656.9817150914073;3746.213295208037;3758.0980564664283;3792.469054332396;48024.7598762004;49858.50141498539;50694;50825.23762143571;50938;40629.9527535436;40917.18165636671;41264;41493.79253103715;41663.166736665095;38698.226035479136;38813.223735525135;38914.6108538911;39532;39718;7881.527108373516;8057.838843222986;8092.069412017458;8118.5940702963435;8119.106898241071;29902.860199678722;30165.3966920656;30843.383132336778;31862.522062169548;32662.83668581642;36364.81074796584;36392.818035910714;39514;39672.2065558693;40005.39991900182;10077.798444031225;10119.68993475943;10173.38959662393;10290.742731431774;10580.788384232119;10994.34033957933;11162.107031437628;11231.71920701989;11245.100391968459;11994.220375675553;10069.647562335284;10103.646372377225;10165.542550585093;10234.48827558634;10275.126614237874;10647.467626618793;10734.302270352402;10920.508577114208;11114.833277501006;11134.610288639858;10052.54763535628;10108.949455252676;10119.79760404773;10165.44090075053;10172.593096276067;9153;9186.54067296646;9249;9450.291228157777;9465;9327.393719408217;9335.267005721811;9587.520623968634;9601.903980960102;9647.934834211814 22:07:33 INFO - PROCESS | 29494 | __end_tp_report 22:07:33 INFO - PROCESS | 29494 | __start_cc_report 22:07:33 INFO - PROCESS | 29494 | _x_x_mozilla_cycle_collect,821 22:07:33 INFO - PROCESS | 29494 | __end_cc_report 22:07:33 INFO - PROCESS | 29494 | __startTimestamp1459919253209__endTimestamp 22:07:33 INFO - PROCESS | 29494 | 22:07:33 INFO - PROCESS | 29494 | ------- Summary: start ------- 22:07:33 INFO - PROCESS | 29494 | Number of tests: 6 22:07:33 INFO - PROCESS | 29494 | 22:07:33 INFO - PROCESS | 29494 | [#0] dojo.html Cycles:165 Average:4597.07 Median:4732.79 stddev:460.08 (9.7%) stddev-sans-first:433.11 22:07:33 INFO - PROCESS | 29494 | Values: 2569.0 2660.5 2667.7 2675.6 2687.0 4582.1 4652.7 4661.0 4673.3 4699.5 4649.3 4673.1 4686.3 4691.3 4744.8 4228.5 4286.8 4292.4 4294.8 4357.4 4271.9 4300.4 4317.5 4327.4 4385.4 4221.7 4259.9 4315.8 4363.4 4366.3 4264.1 4288.0 4291.3 4323.1 4334.3 4112.7 4265.9 4273.3 4279.3 4313.3 4489.1 4544.7 4554.8 4578.5 4592.3 4913.9 4946.3 4946.4 4946.8 4999.3 4851.1 4952.7 4957.2 4964.7 5015.8 4645.6 4669.5 4682.8 4725.9 4737.1 5053.9 5061.8 5071.8 5073.5 5116.8 4776.4 4842.5 4848.3 4861.6 4899.4 4892.8 4949.2 4961.0 4987.5 5002.6 4881.3 4911.2 4911.4 4912.5 4958.1 4831.2 4886.8 4892.7 4925.4 4981.1 4297.5 4302.1 4302.4 4327.1 4329.0 3724.3 3748.0 3748.8 3788.0 3794.7 4163.3 4234.2 4254.1 4308.3 4363.0 4953.5 4971.3 4975.5 4979.9 5005.2 4304.2 4306.2 4309.6 4335.1 4356.8 4418.7 4482.2 4515.3 4555.8 4583.7 4712.1 4715.8 4728.7 4738.5 4777.7 4995.3 5007.2 5017.3 5017.9 5069.2 4537.5 4689.6 4732.8 4761.5 4776.8 4893.6 4899.4 4906.5 4929.6 4973.8 4832.8 4979.6 4986.4 4988.1 5029.6 4750.8 4803.2 4820.5 4824.7 4862.7 4759.7 4778.0 4787.3 4790.5 4836.7 4630.6 4698.5 4721.3 4723.9 4773.6 4823.3 4834.9 4843.6 4853.0 4885.4 4743.6 4746.5 4749.8 4750.1 4776.9 22:07:33 INFO - PROCESS | 29494 | 22:07:33 INFO - PROCESS | 29494 | [#1] ext.html Cycles:180 Average:40567.93 Median:19915.13 stddev:64590.20 (324.3%) stddev-sans-first:64701.39 22:07:33 INFO - PROCESS | 29494 | Values: 517.6 518.0 529.9 536.4 543.1 30072.0 30642.8 30675.4 30695.0 35413.1 38340.4 38910.2 38976.2 38995.8 39022.0 7605.5 7813.1 7826.5 7828.5 7828.5 7857.1 8014.4 8023.8 8023.9 8027.4 8019.0 8085.2 8087.1 8088.2 8091.0 7987.7 8036.4 8064.0 8065.0 8069.6 7957.5 8063.3 8075.4 8083.8 8093.8 37905.6 38354.2 38418.8 38423.4 38464.0 3057.8 3505.8 3818.5 3834.5 3991.4 29517.0 29878.6 29991.9 30065.4 30243.2 3565.4 3565.8 3580.3 3586.6 3595.4 248221.0 249161.0 249183.0 249662.0 250187.0 43320.0 53153.5 53694.7 53739.7 53753.5 42329.4 42466.8 42560.0 42600.6 42619.4 14095.9 14337.7 14347.2 14348.0 14355.4 11260.5 11261.4 11336.1 11347.1 11354.1 14628.3 14656.2 15043.4 15100.4 15204.9 5573.6 5843.2 5867.8 5872.6 5879.4 853.7 921.7 963.4 975.9 1021.4 27009.3 27711.4 27851.4 28202.2 28260.6 914.3 932.4 983.8 986.4 995.6 13642.5 14052.2 14168.3 14447.9 14464.3 284339.0 285156.0 285895.0 288112.0 288861.0 47093.3 47548.3 47554.8 47607.8 47662.0 1058.4 1137.9 1228.2 1239.6 1240.2 25944.9 27359.6 27797.7 27889.6 28252.3 38477.4 38544.4 38773.4 38787.2 38793.2 199663.0 200692.0 200859.0 201232.0 201410.0 32773.3 32823.7 33009.5 33271.8 33932.3 41408.0 41647.6 42098.4 42343.0 42451.6 35929.5 35946.6 36234.8 36466.8 36490.5 35381.8 35770.3 35875.6 35907.8 35944.1 35000.5 36414.0 36432.3 37835.2 38649.2 28944.4 29300.6 29521.4 29534.6 29664.9 24877.9 25054.6 25242.9 25319.9 25329.0 22:07:33 INFO - PROCESS | 29494 | 22:07:33 INFO - PROCESS | 29494 | [#2] jquery.html Cycles:180 Average:22272.09 Median:4301.77 stddev:58411.90 (1357.9%) stddev-sans-first:58552.55 22:07:33 INFO - PROCESS | 29494 | Values: 341.6 341.9 349.3 353.6 364.7 14721.7 15419.6 16087.5 16095.2 16112.5 15464.4 15521.1 15696.9 16006.7 16037.8 4581.2 4610.8 4703.6 4703.8 4728.6 5063.8 5077.5 5099.5 5124.5 5128.0 5092.7 5093.8 5096.0 5102.8 5103.6 5098.1 5121.1 5332.9 5346.4 5351.6 5141.9 5149.9 5155.3 5161.0 5175.7 16547.8 17917.6 20089.5 20094.0 20113.1 1873.5 1955.6 2012.4 2307.8 2343.8 9102.4 9163.9 9452.8 9558.8 12733.0 1665.5 1678.3 1680.6 1719.6 1745.2 44940.6 59065.0 63095.0 63132.4 64116.7 9159.7 9203.4 9349.2 9364.8 9429.0 11736.0 12436.6 12937.1 12948.6 12973.0 7038.9 7115.8 7218.9 7235.3 7297.2 6917.5 6959.7 7038.9 7072.9 7082.7 4110.9 4120.3 4219.9 4288.7 4314.8 1783.3 1821.8 1823.4 1825.7 1869.9 836.4 882.0 927.4 960.1 1001.6 15275.8 15587.8 15986.5 16097.1 16385.0 854.8 867.2 898.4 898.9 929.4 9060.9 9147.6 9172.1 9221.4 9306.0 312404.0 319638.0 376266.0 376924.0 380318.0 71987.3 73372.6 74161.0 74242.0 74553.6 958.2 975.5 985.2 985.7 989.4 11989.8 14797.3 14834.0 15118.7 15331.9 33367.3 33614.5 33742.7 34270.1 34786.7 38504.0 40240.4 40499.6 40706.0 41002.6 7407.7 7450.4 7477.0 7478.7 7556.8 10391.5 11414.3 11858.1 11958.9 12026.3 9839.8 9975.1 10171.9 10223.6 10443.9 9584.0 9685.0 9685.7 10135.5 10338.4 10551.4 10575.6 10590.8 10668.7 10897.9 7456.5 7512.4 7545.9 7549.8 7687.2 10278.4 10534.3 10616.4 10728.5 10759.6 22:07:33 INFO - PROCESS | 29494 | 22:07:33 INFO - PROCESS | 29494 | [#3] mootools.html Cycles:180 Average:5068.30 Median:6144.62 stddev:2577.41 (41.9%) stddev-sans-first:2569.67 22:07:33 INFO - PROCESS | 29494 | Values: 1373.0 1376.9 1475.8 1682.6 1690.9 7141.9 7287.7 7311.1 7311.3 7327.5 6252.6 6947.4 7059.8 7090.1 7244.7 2205.0 2230.4 2232.1 2232.7 2235.2 2161.0 2201.1 2202.5 2207.2 2209.3 1886.8 1937.6 1937.7 2116.1 2156.6 2142.4 2171.7 2173.9 2175.8 2177.5 2144.2 2177.1 2186.6 2187.8 2191.2 7211.0 7321.9 7330.1 7330.2 7333.6 4309.8 4429.6 4437.5 4438.6 4444.2 2791.7 2857.6 2872.0 2885.6 2893.1 940.7 972.8 976.8 980.5 996.9 9293.6 9302.5 9319.8 9320.0 9331.3 3951.6 4008.5 4044.8 4065.6 4079.9 8100.3 8112.6 8133.8 8145.3 8153.3 4384.5 4408.6 4444.1 4452.6 4452.8 4028.7 4035.7 4038.2 4038.2 4044.4 3409.5 3586.6 3618.7 3620.3 3621.8 1114.8 1130.4 1135.4 1138.6 1142.7 917.8 957.0 1010.6 1010.7 1135.7 6667.8 6702.4 6743.9 6754.1 6770.6 1000.2 1007.7 1018.5 1032.2 1057.6 5201.9 5277.0 5310.1 5317.1 5318.2 8313.2 8496.4 8513.8 8840.4 8845.5 8355.3 8386.6 8504.1 8508.2 8522.3 7025.0 7054.4 7092.3 7099.0 7154.6 6888.7 6912.5 6965.7 7015.7 7016.6 7819.4 7822.6 8176.0 8182.6 8261.3 8182.9 8361.7 8374.7 8499.7 8506.0 6349.3 6556.9 6667.7 6674.0 6678.4 6925.5 7020.3 7022.3 7022.8 7025.2 6071.9 6120.0 6165.4 6221.8 6270.3 4929.9 6268.9 6295.6 6314.2 6415.3 6501.2 6529.0 6563.2 6563.2 6575.4 6067.8 6112.7 6112.7 6117.2 6123.9 5695.7 5712.7 5758.3 5760.0 5762.1 22:07:33 INFO - PROCESS | 29494 | 22:07:33 INFO - PROCESS | 29494 | [#4] prototype.html Cycles:180 Average:4723.40 Median:5396.74 stddev:1392.54 (25.8%) stddev-sans-first:1356.48 22:07:33 INFO - PROCESS | 29494 | Values: 309.8 315.5 318.8 324.3 324.9 5384.8 5457.3 5461.2 5474.8 5483.2 5377.6 5381.4 5386.6 5386.7 5393.4 4039.0 4096.6 4226.8 4230.7 4238.8 4191.3 4234.3 4238.2 4241.6 4244.2 3984.2 4204.7 4209.1 4210.0 4212.3 4041.3 4124.8 4126.4 4142.2 4188.1 3692.2 3695.2 3698.3 3705.5 3711.2 5138.6 5140.6 5143.5 5144.5 5146.4 4814.1 4821.1 4822.3 4824.1 4827.7 5663.0 5672.7 5676.6 5680.1 5680.2 3830.9 4047.4 4050.0 4050.4 4055.2 5906.3 5953.1 5980.6 5981.6 5984.3 4061.1 4062.0 4068.2 4069.3 4071.3 4121.4 4124.6 4125.5 4128.4 4129.2 4736.4 4737.5 4739.9 4740.0 4742.9 5668.1 5672.1 5677.3 5679.9 5701.8 1395.0 1431.3 1456.9 1460.8 1463.6 949.1 959.2 959.5 963.9 969.3 4814.0 4885.7 4936.3 4968.1 4969.2 5857.4 5904.2 5968.4 6010.5 6014.2 5026.6 5036.1 5040.1 5041.1 5041.8 3146.0 3179.5 3182.1 3183.6 3187.9 5563.1 5567.6 5569.8 5571.8 5574.2 5860.5 6087.3 6125.4 6130.3 6140.4 5565.2 5584.8 5587.1 5593.6 5603.2 5948.8 5949.8 5952.7 5959.9 5965.9 5806.2 5806.7 5850.4 5866.2 5866.5 5506.1 5536.1 5576.5 5594.1 5601.2 3918.9 4058.3 4093.6 4102.0 4104.6 5839.2 5856.5 5865.3 5865.4 5888.1 5632.4 5639.4 5647.4 5648.5 5659.9 5619.4 5651.4 5664.8 5671.0 5679.4 5400.1 5586.1 5595.7 5599.4 5602.6 5751.1 5808.7 5836.8 5837.3 5846.9 5613.3 5617.8 5620.8 5637.0 5640.5 22:07:33 INFO - PROCESS | 29494 | 22:07:33 INFO - PROCESS | 29494 | [#5] yui.html Cycles:180 Average:12323.66 Median:22004.70 stddev:13559.40 (61.6%) stddev-sans-first:13569.18 22:07:33 INFO - PROCESS | 29494 | Values: 667.3 775.6 789.9 790.1 794.0 12253.6 12291.6 12294.3 12346.9 12395.0 11729.6 11749.6 11761.8 11765.9 11808.6 638.0 788.6 798.4 811.9 812.6 812.5 815.3 818.7 818.9 819.0 849.5 861.0 861.6 862.1 862.7 670.3 680.1 851.1 853.9 855.3 498.5 617.5 626.9 629.6 630.1 11555.1 11559.3 11569.6 11614.2 11669.8 11680.5 12429.7 12470.6 12699.6 12807.4 9752.1 9854.7 9909.3 10295.1 10402.2 3434.2 3443.8 3452.1 3532.7 3573.0 41611.6 42062.4 42423.4 42606.0 42623.8 10127.5 10161.5 10225.6 10276.6 10397.6 18077.7 18100.5 18140.2 18328.0 18338.2 6860.2 7080.6 7242.6 7248.5 7326.5 3847.7 3883.7 3888.9 3919.4 4004.0 2824.8 2861.0 2862.2 2867.5 2867.5 494.4 512.9 518.3 520.8 529.1 538.9 642.1 645.0 649.4 659.7 7653.0 7700.0 7784.6 7966.8 7994.0 634.9 640.7 642.1 645.2 647.5 3603.0 3657.0 3746.2 3758.1 3792.5 48024.8 49858.5 50694.0 50825.2 50938.0 40630.0 40917.2 41264.0 41493.8 41663.2 38698.2 38813.2 38914.6 39532.0 39718.0 7881.5 8057.8 8092.1 8118.6 8119.1 29902.9 30165.4 30843.4 31862.5 32662.8 36364.8 36392.8 39514.0 39672.2 40005.4 10077.8 10119.7 10173.4 10290.7 10580.8 10994.3 11162.1 11231.7 11245.1 11994.2 10069.6 10103.6 10165.5 10234.5 10275.1 10647.5 10734.3 10920.5 11114.8 11134.6 10052.5 10108.9 10119.8 10165.4 10172.6 9153.0 9186.5 9249.0 9450.3 9465.0 9327.4 9335.3 9587.5 9601.9 9647.9 22:07:33 INFO - PROCESS | 29494 | -------- Summary: end -------- 22:07:33 INFO - PROCESS | 29494 | 22:07:33 INFO - TEST-INFO | 29494: exit 0 22:07:33 INFO - TEST-OK | dromaeo_css | took 1116323ms 22:07:33 INFO - TEST-START | kraken 22:07:33 INFO - operating with platform_type : linux_ 22:07:33 INFO - Initialising browser for kraken test... 22:07:33 INFO - TEST-INFO | started process 29671 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIXerQT/profile http://localhost:57940/getInfo.html) 22:07:38 INFO - PROCESS | 29671 | __metrics Screen width/height:1600/1200 22:07:38 INFO - PROCESS | 29671 | colorDepth:24 22:07:38 INFO - PROCESS | 29671 | Browser inner width/height: 1024/697 22:07:38 INFO - PROCESS | 29671 | __metrics 22:07:39 ERROR - PROCESS | 29671 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 22:07:40 INFO - TEST-INFO | 29671: exit 0 22:07:40 INFO - Browser initialized. 22:07:40 INFO - Running cycle 1/1 for kraken test... 22:07:40 INFO - TEST-INFO | started process 29750 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIXerQT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:07:52 INFO - PROCESS | 29750 | RSS: Main: 153899008 22:07:52 INFO - PROCESS | 29750 | 22:07:54 INFO - PROCESS | 29750 | Cycle 1(1): loaded http://localhost:57940/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57940/tests/kraken/driver.html?testName=audio-beat-detection) 22:07:55 INFO - PROCESS | 29750 | RSS: Main: 194457600 22:07:55 INFO - PROCESS | 29750 | 22:07:58 INFO - PROCESS | 29750 | Cycle 1(1): loaded http://localhost:57940/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57940/tests/kraken/driver.html?testName=audio-dft) 22:07:58 INFO - PROCESS | 29750 | RSS: Main: 184893440 22:07:58 INFO - PROCESS | 29750 | 22:08:01 INFO - PROCESS | 29750 | Cycle 1(1): loaded http://localhost:57940/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57940/tests/kraken/driver.html?testName=audio-fft) 22:08:02 INFO - PROCESS | 29750 | RSS: Main: 171323392 22:08:02 INFO - PROCESS | 29750 | 22:08:04 INFO - PROCESS | 29750 | Cycle 1(1): loaded http://localhost:57940/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57940/tests/kraken/driver.html?testName=audio-oscillator) 22:08:05 INFO - PROCESS | 29750 | RSS: Main: 171692032 22:08:05 INFO - PROCESS | 29750 | 22:08:07 INFO - PROCESS | 29750 | Cycle 1(1): loaded http://localhost:57940/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57940/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:08:08 INFO - PROCESS | 29750 | RSS: Main: 172908544 22:08:08 INFO - PROCESS | 29750 | 22:08:11 INFO - PROCESS | 29750 | Cycle 1(1): loaded http://localhost:57940/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57940/tests/kraken/driver.html?testName=imaging-darkroom) 22:08:11 INFO - PROCESS | 29750 | RSS: Main: 173187072 22:08:11 INFO - PROCESS | 29750 | 22:08:15 INFO - PROCESS | 29750 | Cycle 1(1): loaded http://localhost:57940/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57940/tests/kraken/driver.html?testName=imaging-desaturate) 22:08:15 INFO - PROCESS | 29750 | RSS: Main: 174555136 22:08:15 INFO - PROCESS | 29750 | 22:08:18 INFO - PROCESS | 29750 | Cycle 1(1): loaded http://localhost:57940/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57940/tests/kraken/driver.html?testName=json-parse-financial) 22:08:19 INFO - PROCESS | 29750 | RSS: Main: 174522368 22:08:19 INFO - PROCESS | 29750 | 22:08:20 INFO - PROCESS | 29750 | Cycle 1(1): loaded http://localhost:57940/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57940/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:08:21 INFO - PROCESS | 29750 | RSS: Main: 183889920 22:08:21 INFO - PROCESS | 29750 | 22:08:23 INFO - PROCESS | 29750 | Cycle 1(1): loaded http://localhost:57940/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57940/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:08:23 INFO - PROCESS | 29750 | RSS: Main: 180412416 22:08:23 INFO - PROCESS | 29750 | 22:08:25 INFO - PROCESS | 29750 | Cycle 1(1): loaded http://localhost:57940/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57940/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:08:26 INFO - PROCESS | 29750 | RSS: Main: 195850240 22:08:26 INFO - PROCESS | 29750 | 22:08:29 INFO - PROCESS | 29750 | Cycle 1(1): loaded http://localhost:57940/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57940/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:08:29 INFO - PROCESS | 29750 | RSS: Main: 202358784 22:08:29 INFO - PROCESS | 29750 | 22:08:32 INFO - PROCESS | 29750 | Cycle 1(1): loaded http://localhost:57940/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57940/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:08:32 INFO - PROCESS | 29750 | RSS: Main: 201056256 22:08:32 INFO - PROCESS | 29750 | 22:08:34 INFO - PROCESS | 29750 | Cycle 1(1): loaded http://localhost:57940/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57940/tests/kraken/driver.html?testName=ai-astar) 22:08:34 INFO - PROCESS | 29750 | RSS: Main: 262742016 22:08:34 INFO - PROCESS | 29750 | 22:08:34 INFO - PROCESS | 29750 | __start_tp_report 22:08:34 INFO - PROCESS | 29750 | _x_x_mozilla_page_load 22:08:34 INFO - PROCESS | 29750 | _x_x_mozilla_page_load_details 22:08:34 INFO - PROCESS | 29750 | |i|pagename|runs| 22:08:34 INFO - PROCESS | 29750 | |0;ai-astar;111;114;108;111;113;111;105;115;113;116 22:08:34 INFO - PROCESS | 29750 | |1;audio-beat-detection;173;135;154;168;141;163;164;131;171;134 22:08:34 INFO - PROCESS | 29750 | |2;audio-dft;161;161;162;161;160;158;162;161;162;162 22:08:34 INFO - PROCESS | 29750 | |3;audio-fft;75;73;105;99;75;76;75;114;98;77 22:08:34 INFO - PROCESS | 29750 | |4;audio-oscillator;93;94;140;94;95;94;131;94;93;140 22:08:34 INFO - PROCESS | 29750 | |5;imaging-gaussian-blur;117;116;117;116;117;116;116;117;116;118 22:08:34 INFO - PROCESS | 29750 | |6;imaging-darkroom;146;146;145;146;146;146;145;146;145;146 22:08:34 INFO - PROCESS | 29750 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;95 22:08:34 INFO - PROCESS | 29750 | |8;json-parse-financial;65;65;65;65;65;65;65;74;65;62 22:08:34 INFO - PROCESS | 29750 | |9;json-stringify-tinderbox;63;64;63;64;65;64;64;64;70;64 22:08:34 INFO - PROCESS | 29750 | |10;stanford-crypto-aes;82;82;84;84;90;91;82;82;85;83 22:08:34 INFO - PROCESS | 29750 | |11;stanford-crypto-ccm;117;117;129;115;117;115;134;115;115;116 22:08:34 INFO - PROCESS | 29750 | |12;stanford-crypto-pbkdf2;142;131;142;144;146;133;140;140;146;138 22:08:34 INFO - PROCESS | 29750 | |13;stanford-crypto-sha256-iterative;68;67;68;66;68;68;66;68;75;68 22:08:34 INFO - PROCESS | 29750 | __end_tp_report 22:08:34 INFO - PROCESS | 29750 | __start_cc_report 22:08:34 INFO - PROCESS | 29750 | _x_x_mozilla_cycle_collect,1181 22:08:34 INFO - PROCESS | 29750 | __end_cc_report 22:08:34 INFO - PROCESS | 29750 | __startTimestamp1459919314772__endTimestamp 22:08:34 INFO - PROCESS | 29750 | 22:08:34 INFO - PROCESS | 29750 | ------- Summary: start ------- 22:08:34 INFO - PROCESS | 29750 | Number of tests: 14 22:08:34 INFO - PROCESS | 29750 | 22:08:34 INFO - PROCESS | 29750 | [#0] ai-astar Cycles:10 Average:111.70 Median:113.00 stddev:3.30 (2.9%) stddev-sans-first:3.49 22:08:34 INFO - PROCESS | 29750 | Values: 111.0 114.0 108.0 111.0 113.0 111.0 105.0 115.0 113.0 116.0 22:08:34 INFO - PROCESS | 29750 | 22:08:34 INFO - PROCESS | 29750 | [#1] audio-beat-detection Cycles:10 Average:153.40 Median:163.50 stddev:16.61 (10.2%) stddev-sans-first:16.03 22:08:34 INFO - PROCESS | 29750 | Values: 173.0 135.0 154.0 168.0 141.0 163.0 164.0 131.0 171.0 134.0 22:08:34 INFO - PROCESS | 29750 | 22:08:34 INFO - PROCESS | 29750 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.50 stddev:1.25 (0.8%) stddev-sans-first:1.32 22:08:34 INFO - PROCESS | 29750 | Values: 161.0 161.0 162.0 161.0 160.0 158.0 162.0 161.0 162.0 162.0 22:08:34 INFO - PROCESS | 29750 | 22:08:34 INFO - PROCESS | 29750 | [#3] audio-fft Cycles:10 Average:86.70 Median:75.50 stddev:15.51 (20.5%) stddev-sans-first:15.87 22:08:34 INFO - PROCESS | 29750 | Values: 75.0 73.0 105.0 99.0 75.0 76.0 75.0 114.0 98.0 77.0 22:08:34 INFO - PROCESS | 29750 | 22:08:34 INFO - PROCESS | 29750 | [#4] audio-oscillator Cycles:10 Average:106.80 Median:94.00 stddev:20.99 (22.3%) stddev-sans-first:21.66 22:08:34 INFO - PROCESS | 29750 | Values: 93.0 94.0 140.0 94.0 95.0 94.0 131.0 94.0 93.0 140.0 22:08:34 INFO - PROCESS | 29750 | 22:08:34 INFO - PROCESS | 29750 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.70 (0.6%) stddev-sans-first:0.73 22:08:34 INFO - PROCESS | 29750 | Values: 117.0 116.0 117.0 116.0 117.0 116.0 116.0 117.0 116.0 118.0 22:08:34 INFO - PROCESS | 29750 | 22:08:34 INFO - PROCESS | 29750 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 22:08:34 INFO - PROCESS | 29750 | Values: 146.0 146.0 145.0 146.0 146.0 146.0 145.0 146.0 145.0 146.0 22:08:34 INFO - PROCESS | 29750 | 22:08:34 INFO - PROCESS | 29750 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 22:08:34 INFO - PROCESS | 29750 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 22:08:34 INFO - PROCESS | 29750 | 22:08:34 INFO - PROCESS | 29750 | [#8] json-parse-financial Cycles:10 Average:65.60 Median:65.00 stddev:3.10 (4.8%) stddev-sans-first:3.28 22:08:34 INFO - PROCESS | 29750 | Values: 65.0 65.0 65.0 65.0 65.0 65.0 65.0 74.0 65.0 62.0 22:08:34 INFO - PROCESS | 29750 | 22:08:34 INFO - PROCESS | 29750 | [#9] json-stringify-tinderbox Cycles:10 Average:64.50 Median:64.00 stddev:2.01 (3.1%) stddev-sans-first:2.06 22:08:34 INFO - PROCESS | 29750 | Values: 63.0 64.0 63.0 64.0 65.0 64.0 64.0 64.0 70.0 64.0 22:08:34 INFO - PROCESS | 29750 | 22:08:34 INFO - PROCESS | 29750 | [#10] stanford-crypto-aes Cycles:10 Average:84.50 Median:84.00 stddev:3.34 (4.0%) stddev-sans-first:3.42 22:08:34 INFO - PROCESS | 29750 | Values: 82.0 82.0 84.0 84.0 90.0 91.0 82.0 82.0 85.0 83.0 22:08:34 INFO - PROCESS | 29750 | 22:08:34 INFO - PROCESS | 29750 | [#11] stanford-crypto-ccm Cycles:10 Average:119.00 Median:117.00 stddev:6.75 (5.8%) stddev-sans-first:7.12 22:08:34 INFO - PROCESS | 29750 | Values: 117.0 117.0 129.0 115.0 117.0 115.0 134.0 115.0 115.0 116.0 22:08:34 INFO - PROCESS | 29750 | 22:08:34 INFO - PROCESS | 29750 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:140.20 Median:142.00 stddev:5.05 (3.6%) stddev-sans-first:5.32 22:08:34 INFO - PROCESS | 29750 | Values: 142.0 131.0 142.0 144.0 146.0 133.0 140.0 140.0 146.0 138.0 22:08:34 INFO - PROCESS | 29750 | 22:08:34 INFO - PROCESS | 29750 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.20 Median:68.00 stddev:2.53 (3.7%) stddev-sans-first:2.68 22:08:34 INFO - PROCESS | 29750 | Values: 68.0 67.0 68.0 66.0 68.0 68.0 66.0 68.0 75.0 68.0 22:08:34 INFO - PROCESS | 29750 | -------- Summary: end -------- 22:08:34 INFO - PROCESS | 29750 | 22:08:35 INFO - TEST-INFO | 29750: exit 0 22:08:35 INFO - TEST-OK | kraken | took 61787ms 22:08:35 INFO - SUITE-END | took 1178s 22:08:35 INFO - Completed test suite (00:19:38) 22:08:35 INFO - javascript benchmark 22:08:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2568.9999999999995, 2660.50780605588, 2667.6932152802433, 2675.57190849464, 2687.0326682394334, 4582.1064892346, 4652.674312798105, 4661.044485880395, 4673.252279635259, 4699.4595621503495, 4649.279361698934, 4673.135469938055, 4686.320483529886, 4691.319758634996, 4744.810207591692, 4228.450301460805, 4286.76422796746, 4292.377605247245, 4294.828206871722, 4357.368181613664, 4271.9359209611885, 4300.3764454154125, 4317.503487098977, 4327.350897365389, 4385.407969924051, 4221.662267018631, 4259.914801703949, 4315.762633055181, 4363.367311739812, 4366.257736184856, 4264.1471705659, 4287.957120428787, 4291.270484017725, 4323.092150648367, 4334.263175260214, 4112.650424713903, 4265.893352666209, 4273.274350390561, 4279.251131052053, 4313.331433627793, 4489.057297967431, 4544.659150563721, 4554.795034223468, 4578.496365399803, 4592.334111553806, 4913.852584422473, 4946.2580612908, 4946.431160416562, 4946.802127914879, 4999.3000979862845, 4851.126797176506, 4952.702837829742, 4957.231629097496, 4964.652474326798, 5015.84952451427, 4645.558671926162, 4669.509701481364, 4682.789274482657, 4725.881852953669, 4737.076270127292, 5053.898922021613, 5061.8228362007885, 5071.797128114834, 5073.467285934998, 5116.769745361467, 4776.355192049098, 4842.491538388489, 4848.345473361122, 4861.562459378673, 4899.363082799213, 4892.755362231874, 4949.183384741549, 4960.950390496121, 4987.476314986874, 5002.59979201663, 4881.267809828554, 4911.214205727067, 4911.4106307243355, 4912.484189160158, 4958.057968985881, 4831.178699621073, 4886.804527818918, 4892.657513974059, 4925.408950925912, 4981.078500477423, 4297.548757380492, 4302.118065796567, 4302.419173411612, 4327.134573085333, 4329.0, 3724.2551489701627, 3747.9625203747614, 3748.83130259139, 3787.962120378816, 3794.6774524165203, 4163.250614889288, 4234.237837189274, 4254.127903779718, 4308.267594508941, 4363.040131171138, 4953.504649535018, 4971.2543118531785, 4975.4527002029745, 4979.875503112451, 5005.199168133154, 4304.246756817544, 4306.20335237982, 4309.569043095666, 4335.111302183045, 4356.76037817923, 4418.668599854959, 4482.21561226784, 4515.277555591089, 4555.794989225493, 4583.702059366131, 4712.081144176853, 4715.7877895494785, 4728.739919304402, 4738.549837765407, 4777.665563410528, 4995.2507123930245, 5007.248912662984, 5017.347744793154, 5017.899642007066, 5069.188929771219, 4537.523560026149, 4689.648276379217, 4732.787024583971, 4761.523847615211, 4776.808927642855, 4893.632977526629, 4899.387576552931, 4906.509349065065, 4929.630277729113, 4973.776180071833, 4832.806687732451, 4979.601631869514, 4986.426560945538, 4988.1270777613045, 5029.622778291569, 4750.8337208197545, 4803.231482962709, 4820.517948205152, 4824.734639594856, 4862.708237505761, 4759.714417134983, 4778.0, 4787.305840653155, 4790.5448982346625, 4836.733979631154, 4630.606398456169, 4698.530146985411, 4721.339012538178, 4723.858284251341, 4773.570378665937, 4823.27650852375, 4834.8791280218275, 4843.588294994965, 4852.95147048525, 4885.413750349981, 4743.644226682944, 4746.477887432311, 4749.786259618395, 4750.073735621659, 4776.928346074881], "unit": "score", "name": "dojo.html", "value": 4569.0730785059895}, {"lowerIsBetter": false, "replicates": [517.629894625343, 517.9715115668638, 529.9216095246175, 536.3965538768884, 543.0930346321643, 30072.0, 30642.84678576604, 30675.38649227014, 30695.0, 35413.11467213321, 38340.424893626616, 38910.22179556407, 38976.22047559047, 38995.80502097493, 39022.0, 7605.505642133271, 7813.101493328255, 7826.452148349618, 7828.452008359417, 7828.530288182699, 7857.057153141603, 8014.438989270753, 8023.839523209533, 8023.879641805378, 8027.3578113751055, 8018.959905200466, 8085.151059138794, 8087.069986951487, 8088.231617996281, 8090.959545202295, 7987.720429784929, 8036.357091432671, 8064.032316122044, 8065.0, 8069.556174410405, 7957.5225486471, 8063.27430531255, 8075.3539716822515, 8083.797905052362, 8093.838123237502, 37905.62094379076, 38354.23291534182, 38418.80790596029, 38423.423648645294, 38464.0, 3057.7706671999467, 3505.789652620851, 3818.5417749870194, 3834.482344883433, 3991.381335892941, 29517.0, 29878.551821722693, 29991.850040749658, 30065.398692026254, 30243.18363875516, 3565.3938830398893, 3565.750397472178, 3580.337637537038, 3586.6413358664186, 3595.442706380515, 248221.0, 249161.0, 249183.0, 249662.0, 250187.0, 43320.0, 53153.46846531485, 53694.73152634212, 53739.73130134324, 53753.462465375625, 42329.365059524134, 42466.78766606147, 42560.0, 42600.57399426028, 42619.36070958938, 14095.929520352538, 14337.713245735027, 14347.210903400204, 14348.0, 14355.425782968565, 11260.549578016788, 11261.43692815356, 11336.149788765875, 11347.092232621371, 11354.148438867118, 14628.341724622418, 14656.193909335088, 15043.398264069314, 15100.39598416051, 15204.923975380052, 5573.637713548606, 5843.18195452637, 5867.765289388462, 5872.559558033165, 5879.353271140171, 853.6926706385697, 921.6820197032014, 963.3545524498603, 975.9365641233439, 1021.4228960637216, 27009.324766880593, 27711.44577108487, 27851.44297114087, 28202.15393538197, 28260.576091358645, 914.3371055984358, 932.4451951089092, 983.8425851863667, 986.40815510693, 995.5615372816018, 13642.454301828015, 14052.156870587798, 14168.291585420688, 14447.85552144486, 14464.27678616065, 284339.0, 285156.0, 285895.0, 288112.0, 288861.0, 47093.29360059602, 47548.28677569839, 47554.76222618865, 47607.76196118997, 47662.0, 1058.3702696895334, 1137.9203455758018, 1228.1955319265894, 1239.5723475400973, 1240.1814802230485, 25944.8702756485, 27359.58960615632, 27797.722022779515, 27889.58165627558, 28252.293692657848, 38477.422838658, 38544.42183367308, 38773.41839872348, 38787.2242555153, 38793.22413551657, 199663.0, 200692.0, 200859.0, 201232.0, 201410.0, 32773.34453310968, 32823.67176328206, 33009.50485742668, 33271.83364083164, 33932.32135357329, 41408.0, 41647.58352416558, 42098.368524471545, 42343.0, 42451.575484246, 35929.46105808362, 35946.64053359433, 36234.8188259057, 36466.8176659115, 36490.45264320984, 35381.82309088438, 35770.28459430849, 35875.641243588274, 35907.820460898576, 35944.101397465274, 35000.47499287462, 36414.0, 36432.27135457329, 37835.24329513339, 38649.22701545897, 28944.42111157807, 29300.56049159307, 29521.409571808872, 29534.556981644862, 29664.851675741484, 24877.87561062183, 25054.62418063767, 25242.873785630953, 25319.873400633616, 25329.0], "unit": "score", "name": "ext.html", "value": 16858.46163161099}, {"lowerIsBetter": false, "replicates": [341.6037396619921, 341.8991397537727, 349.3205714884549, 353.64988661225397, 364.7300997262027, 14721.705565888677, 15419.614509637264, 16087.51737447877, 16095.195240238, 16112.516624501255, 15464.381424743025, 15521.146336951464, 15696.921515392436, 16006.679866402694, 16037.759433608506, 4581.152486789946, 4610.815567377318, 4703.600193983499, 4703.764811759415, 4728.574428301452, 5063.79744810209, 5077.492250774912, 5099.515546023122, 5124.462661201644, 5128.0, 5092.694438333693, 5093.821716239932, 5096.0, 5102.795888164487, 5103.642745007851, 5098.133317336062, 5121.078205922932, 5332.893342133174, 5346.4118946915805, 5351.625386222947, 5141.948580514184, 5149.9485005149845, 5155.278261043457, 5161.045206636784, 5175.689458632494, 16547.84165108443, 17917.641647167115, 20089.497762555908, 20094.0, 20113.09491072905, 1873.4847916822846, 1955.5795503966715, 2012.4365177750108, 2307.849989750661, 2343.8397992993578, 9102.408343457653, 9163.908360916372, 9452.763680907963, 9558.761030974212, 12733.0, 1665.4504013675457, 1678.2783403136646, 1680.5882558773178, 1719.6302794899157, 1745.1623220853935, 44940.550594493965, 59065.0, 63095.0, 63132.36867631357, 64116.679416602616, 9159.679411220575, 9203.447793132433, 9349.158575728217, 9364.812703746024, 9428.952855235817, 11736.0, 12436.626901192978, 12937.094403391673, 12948.611541653765, 12973.0, 7038.92961070393, 7115.786526404217, 7218.927810721931, 7235.2764723527225, 7297.1608265049135, 6917.481188910851, 6959.721611135498, 7038.92961070393, 7072.8939065914055, 7082.716691332392, 4110.8561200358445, 4120.320147175742, 4219.915601687949, 4288.7212331199, 4314.827406903689, 1783.2777725021388, 1821.7813862336338, 1823.389164629864, 1825.6896327624336, 1869.9065046747608, 836.3768992100923, 881.9955900220458, 927.3879239701764, 960.1454705312277, 1001.5643195210107, 15275.770863437057, 15587.766183507256, 15986.520404387888, 16097.11465869365, 16385.0, 854.786303424144, 867.1935100356603, 898.4474548152839, 898.8831451911341, 929.4330458420358, 9060.864087038699, 9147.588358523883, 9172.082791720908, 9221.446713197229, 9305.95347023274, 312404.0, 319638.0, 376266.0, 376924.0, 380318.0, 71987.2801271991, 73372.63313683397, 74161.0, 74242.0, 74553.62723186458, 958.1711819276276, 975.4683697384942, 985.211830535583, 985.7042887133831, 989.3618615992644, 11989.76020479603, 14797.260136993322, 14834.0, 15118.697626047637, 15331.923340383226, 33367.33265334728, 33614.49578256279, 33742.66257337493, 34270.14324641904, 34786.65213347834, 38504.0, 40240.396394053525, 40499.59500405076, 40706.0, 41002.58997409988, 7407.740729074457, 7450.441216908862, 7477.0, 7478.663460144197, 7556.811079723051, 10391.480425978822, 11414.258073225214, 11858.11064170208, 11958.940205298917, 12026.338551379758, 9839.754006149904, 9975.102240798364, 10171.898281017095, 10223.568700381804, 10443.94778026105, 9583.952080239833, 9684.95157524208, 9685.6610018649, 10135.49322533885, 10338.431386273827, 10551.41967191781, 10575.629852955417, 10590.8411373831, 10668.733281668021, 10897.891021089688, 7456.51532650376, 7512.436567257369, 7545.886811697719, 7549.849003020019, 7687.154413014452, 10278.383297002203, 10534.262601617813, 10616.416097114425, 10728.51721672511, 10759.63288076622], "unit": "score", "name": "jquery.html", "value": 7920.724465773988}, {"lowerIsBetter": false, "replicates": [1372.951946681866, 1376.8691974262442, 1475.7565001774708, 1682.646644204717, 1690.949271521854, 7141.85716285674, 7287.708491660327, 7311.086114235721, 7311.268873112686, 7327.487075904689, 6252.562320637558, 6947.374736273734, 7059.7882063538045, 7090.149182098143, 7244.746433874815, 2205.040807248844, 2230.3754948614414, 2232.10715713715, 2232.6762619420174, 2235.1953296813135, 2160.978390216101, 2201.0535469748, 2202.48241663209, 2207.23850271656, 2209.3151123151874, 1886.7924528301944, 1937.6221636780833, 1937.7384053152855, 2116.0689296709475, 2156.579467003935, 2142.3572928121503, 2171.6742488626674, 2173.880436575988, 2175.7715439878903, 2177.499175189715, 2144.1852096203343, 2177.085624037908, 2186.562687462514, 2187.814035806958, 2191.22211614876, 7211.0, 7321.926780732178, 7330.083739532559, 7330.157031941341, 7333.633318334116, 4309.849155279581, 4429.579189976947, 4437.534058923831, 4438.60052595268, 4444.155610434007, 2791.7068707785593, 2857.5999360089604, 2871.985640071807, 2885.5960165576835, 2893.088677066717, 940.6754669639032, 972.8492083727034, 976.7899901521135, 980.5097451274363, 996.9102780749695, 9293.628254869796, 9302.488363140092, 9319.813603727887, 9319.953400232955, 9331.253499720005, 3951.585083566242, 4008.5189777226337, 4044.7775372354804, 4065.593440655911, 4079.8776036718946, 8100.270975612223, 8112.553809540532, 8133.75598732039, 8145.307648849915, 8153.306968907709, 4384.4519435070615, 4408.647308215399, 4444.088961762831, 4452.621527170227, 4452.755098469551, 4028.67770578353, 4035.6771458283265, 4038.1519880824767, 4038.192361527706, 4044.3933409988736, 3409.4715319125576, 3586.5875424326537, 3618.6924111450294, 3620.2940426616556, 3621.764585301947, 1114.821628539446, 1130.4008875296106, 1135.4436326200268, 1138.5673444091192, 1142.7200335917753, 917.775145089444, 956.9712908612753, 1010.5604062232952, 1010.696790962723, 1135.6876858863714, 6667.766628168088, 6702.36327548882, 6743.9325606743305, 6754.0881980931945, 6770.627615481098, 1000.1798525209258, 1007.6876168387823, 1018.495844556949, 1032.200044965143, 1057.6139709006156, 5201.921971170435, 5276.973615131977, 5310.097283461821, 5317.1226747586215, 5318.228856815817, 8313.16868313176, 8496.447730897595, 8513.787155321043, 8840.425372350777, 8845.513496757612, 8355.289800366916, 8386.580670966427, 8504.107068757816, 8508.234258916727, 8522.275606573387, 7024.964875175591, 7054.4003759681, 7092.290770922867, 7098.964505177441, 7154.570725756367, 6888.690008949509, 6912.4815638828295, 6965.686544105426, 7015.6842942066705, 7016.5790052597, 7819.374450044096, 7822.608869556613, 8175.959120204361, 8182.631781569725, 8261.339092872435, 8182.918170818216, 8361.749147525585, 8374.748757537283, 8499.702510412106, 8505.979282486142, 6349.333320001333, 6556.901646475211, 6667.66661666905, 6674.0, 6678.432333251728, 6925.549839260432, 7020.262872398529, 7022.262662420372, 7022.824429389306, 7025.2272250053475, 6071.939280607137, 6119.969400152971, 6165.3526379731275, 6221.844453888689, 6270.310265870659, 4929.852104436729, 6268.874622507433, 6295.622262664255, 6314.242290925118, 6415.262244841903, 6501.187351581052, 6528.967355163194, 6563.1796025496815, 6563.245226798979, 6575.408213260829, 6067.757289708539, 6112.663803490851, 6112.694365281629, 6117.204763380732, 6123.877522449615, 5695.686737229492, 5712.685802280915, 5758.3090029196765, 5760.049591817471, 5762.135679648086], "unit": "score", "name": "mootools.html", "value": 4187.746280453781}, {"lowerIsBetter": false, "replicates": [309.77850836651794, 315.5093829095756, 318.8230532054709, 324.3140757298315, 324.8830421048424, 5384.784608615656, 5457.263269458622, 5461.15352120421, 5474.78100875965, 5483.150111732678, 5377.623566350357, 5381.408045115034, 5386.596005299609, 5386.73066346683, 5393.406725260228, 4038.97980510097, 4096.5903409659095, 4226.809793559297, 4230.7038507304505, 4238.830446782125, 4191.266528357541, 4234.322508398657, 4238.21593005295, 4241.597048280424, 4244.193603215394, 3984.1633257015915, 4204.726692764976, 4209.074003719177, 4209.957900420987, 4212.3260278355465, 4041.2927737645796, 4124.8143833527565, 4126.42230087788, 4142.150859073898, 4188.141431006637, 3692.1692619160476, 3695.224002959382, 3698.278835627054, 3705.4627079073384, 3711.2206436648066, 5138.640295179339, 5140.614453915934, 5143.459936706667, 5144.5369916707305, 5146.356705411824, 4814.085323788504, 4821.059893320804, 4822.276658501218, 4824.083424149436, 4827.662063655545, 5663.0, 5672.695280085562, 5676.631018983753, 5680.11958146488, 5680.176374425685, 3830.9042273943096, 4047.372657238133, 4049.979750101231, 4050.41269015991, 4055.2497787909333, 5906.291245050578, 5953.136795164677, 5980.641161530322, 5981.611195272293, 5984.281886173643, 4061.1065565575527, 4061.9796901015307, 4068.1863627274665, 4069.2878746219885, 4071.3485842265095, 4121.443605113332, 4124.649404800625, 4125.463689720377, 4128.442660240889, 4129.174165166979, 4736.360591320196, 4737.549932756383, 4739.928901066487, 4739.976300118477, 4742.905141897143, 5668.149777533403, 5672.064109421982, 5677.318721753333, 5679.886402271932, 5701.800436984686, 1395.0, 1431.334429490292, 1456.89801713879, 1460.8247010358825, 1463.5828788795143, 949.126803340928, 959.1751094059103, 959.4579062829479, 963.8843338799248, 969.2536746704998, 4813.975930120327, 4885.65800393969, 4936.308916751657, 4968.130577148984, 4969.229769385751, 5857.414258574108, 5904.232449781587, 5968.432998865101, 6010.549208809357, 6014.1580178775, 5026.572741316956, 5036.143855544567, 5040.067587496325, 5041.143005689041, 5041.8487445376695, 3146.0, 3179.475386561238, 3182.0931034655014, 3183.5861338025907, 3187.8724851006164, 5563.137713654309, 5567.582431317667, 5569.777208911679, 5571.777128914879, 5574.163875418639, 5860.501857342174, 6087.299960504599, 6125.418085281891, 6130.295016073209, 6140.3552626974415, 5565.16522521625, 5584.832455026356, 5587.106063029977, 5593.608447408642, 5603.187537807076, 5948.762049517971, 5949.762009519571, 5952.732127054206, 5959.91060134107, 5965.940340596539, 5806.216160818235, 5806.65160090396, 5850.356460789395, 5866.2373891393845, 5866.50134738535, 5506.1190209566275, 5536.141898005815, 5576.498115169654, 5594.13290939905, 5601.187827765033, 3918.8628398005935, 4058.295515883395, 4093.63157315843, 4101.979490102531, 4104.56902025283, 5839.240898683144, 5856.531477481876, 5865.266841644794, 5865.354810970875, 5888.087346461305, 5632.380438151882, 5639.351474580476, 5647.435256474484, 5648.5481161507805, 5659.858503537444, 5619.438056194348, 5651.378348381757, 5664.801731939362, 5671.0, 5679.403662615366, 5400.081986062457, 5586.078297081099, 5595.720213989202, 5599.356074051373, 5602.607817452739, 5751.1085781703905, 5808.7095645218415, 5836.824895253149, 5837.299524056971, 5846.883062338815, 5613.298337707786, 5617.775288988558, 5620.8032718856275, 5637.0, 5640.54875609942], "unit": "score", "name": "prototype.html", "value": 4275.895290231596}, {"lowerIsBetter": false, "replicates": [667.3026687111967, 775.5734346109638, 789.9328557072648, 790.1466416270429, 793.9717326337174, 12253.632391028272, 12291.631251062483, 12294.26234425934, 12346.876531234684, 12395.0, 11729.589464368748, 11749.588764393247, 11761.764764704702, 11765.941170294136, 11808.645740627795, 637.9968100159492, 788.6056971514242, 798.3692882622736, 811.8863359129726, 812.6058861452191, 812.4597142899964, 815.3314282288526, 818.7298191596759, 818.8730746734266, 819.0171793847377, 849.4563479373206, 861.0356400831078, 861.5562985062697, 862.1249431826701, 862.689431804553, 670.2928410526893, 680.1226417920876, 851.1233429567556, 853.8889944307232, 855.2687452228317, 498.51643905412055, 617.4905702795212, 626.9028300613412, 629.6473974574253, 630.1021045010841, 11555.133364997659, 11559.306441613446, 11569.595064172798, 11614.18700690952, 11669.766604667859, 11680.474378652982, 12429.689257768538, 12470.625881223577, 12699.555515557004, 12807.423665935055, 9752.073553012453, 9854.655087071918, 9909.256805739598, 10295.124914382286, 10402.219833512518, 3434.158631135363, 3443.8450269737673, 3452.067941655764, 3532.717382609385, 3573.0, 41611.58388416137, 42062.36906446406, 42423.36364954528, 42606.0, 42623.786881065396, 10127.544260508295, 10161.54273057714, 10225.642102526375, 10276.640317588848, 10397.63608273722, 18077.7288340675, 18100.54748631295, 18140.18369173364, 18328.0, 18338.174782134836, 6860.245373008965, 7080.575165490087, 7242.601656908815, 7248.492605517668, 7326.523775954546, 3847.711421643388, 3883.689304855605, 3888.941665875014, 3919.392494163409, 4004.0, 2824.7994602293943, 2860.971390286112, 2862.2415060009116, 2867.4551835151256, 2867.5411934090444, 494.3672099712374, 512.9100661095173, 518.3028826228791, 520.8359366799446, 529.0529951387051, 538.9137737961908, 642.1331202876173, 644.9762090830856, 649.3538928765909, 659.6569783712442, 7653.0, 7700.0, 7784.610769461504, 7966.84066318682, 7993.960030199928, 634.9333320001333, 640.6668532363238, 642.1459458919719, 645.2450632759683, 647.5499527828208, 3603.0, 3656.9817150914073, 3746.213295208037, 3758.0980564664283, 3792.469054332396, 48024.7598762004, 49858.50141498539, 50694.0, 50825.23762143571, 50938.0, 40629.9527535436, 40917.18165636671, 41264.0, 41493.79253103715, 41663.166736665095, 38698.226035479136, 38813.223735525135, 38914.6108538911, 39532.0, 39718.0, 7881.527108373516, 8057.838843222986, 8092.069412017458, 8118.5940702963435, 8119.106898241071, 29902.860199678722, 30165.3966920656, 30843.383132336778, 31862.522062169548, 32662.83668581642, 36364.81074796584, 36392.818035910714, 39514.0, 39672.2065558693, 40005.39991900182, 10077.798444031225, 10119.68993475943, 10173.38959662393, 10290.742731431774, 10580.788384232119, 10994.34033957933, 11162.107031437628, 11231.71920701989, 11245.100391968459, 11994.220375675553, 10069.647562335284, 10103.646372377225, 10165.542550585093, 10234.48827558634, 10275.126614237874, 10647.467626618793, 10734.302270352402, 10920.508577114208, 11114.833277501006, 11134.610288639858, 10052.54763535628, 10108.949455252676, 10119.79760404773, 10165.44090075053, 10172.593096276067, 9153.0, 9186.54067296646, 9249.0, 9450.291228157777, 9465.0, 9327.393719408217, 9335.267005721811, 9587.520623968634, 9601.903980960102, 9647.934834211814], "unit": "score", "name": "yui.html", "value": 5875.039359832545}], "name": "dromaeo_css", "value": 6327.6924546494365}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 114.0, 108.0, 111.0, 113.0, 111.0, 105.0, 115.0, 113.0, 116.0], "unit": "score", "name": "ai-astar", "value": 111.7}, {"lowerIsBetter": true, "replicates": [173.0, 135.0, 154.0, 168.0, 141.0, 163.0, 164.0, 131.0, 171.0, 134.0], "unit": "score", "name": "audio-beat-detection", "value": 153.4}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 162.0, 161.0, 160.0, 158.0, 162.0, 161.0, 162.0, 162.0], "unit": "score", "name": "audio-dft", "value": 161.0}, {"lowerIsBetter": true, "replicates": [75.0, 73.0, 105.0, 99.0, 75.0, 76.0, 75.0, 114.0, 98.0, 77.0], "unit": "score", "name": "audio-fft", "value": 86.7}, {"lowerIsBetter": true, "replicates": [93.0, 94.0, 140.0, 94.0, 95.0, 94.0, 131.0, 94.0, 93.0, 140.0], "unit": "score", "name": "audio-oscillator", "value": 106.8}, {"lowerIsBetter": true, "replicates": [117.0, 116.0, 117.0, 116.0, 117.0, 116.0, 116.0, 117.0, 116.0, 118.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.6}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 145.0, 146.0, 146.0, 146.0, 145.0, 146.0, 145.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.7}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.0}, {"lowerIsBetter": true, "replicates": [65.0, 65.0, 65.0, 65.0, 65.0, 65.0, 65.0, 74.0, 65.0, 62.0], "unit": "score", "name": "json-parse-financial", "value": 65.6}, {"lowerIsBetter": true, "replicates": [63.0, 64.0, 63.0, 64.0, 65.0, 64.0, 64.0, 64.0, 70.0, 64.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.5}, {"lowerIsBetter": true, "replicates": [82.0, 82.0, 84.0, 84.0, 90.0, 91.0, 82.0, 82.0, 85.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.5}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 129.0, 115.0, 117.0, 115.0, 134.0, 115.0, 115.0, 116.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 119.0}, {"lowerIsBetter": true, "replicates": [142.0, 131.0, 142.0, 144.0, 146.0, 133.0, 140.0, 140.0, 146.0, 138.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 140.2}, {"lowerIsBetter": true, "replicates": [68.0, 67.0, 68.0, 66.0, 68.0, 68.0, 66.0, 68.0, 75.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.2}], "name": "kraken", "value": 1518.9}]} 22:08:36 INFO - Return code: 0 22:08:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 22:08:36 ERROR - # TBPL SUCCESS # 22:08:36 INFO - Running post-action listener: _resource_record_post_action 22:08:36 INFO - Running post-run listener: _resource_record_post_run 22:08:37 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 4096; Write bytes: 519143424; Read time: 4; Write time: 540496 22:08:37 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 233283584; Read time: 0; Write time: 259736 22:08:37 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 4096; Write bytes: 285859840; Read time: 4; Write time: 280760 22:08:37 INFO - Running post-run listener: _upload_blobber_files 22:08:37 INFO - Blob upload gear active. 22:08:37 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:08:37 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 22:08:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 22:08:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 22:08:37 INFO - (blobuploader) - INFO - Open directory for files ... 22:08:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 22:08:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:08:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:08:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 22:08:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:08:38 INFO - (blobuploader) - INFO - Done attempting. 22:08:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 22:08:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:08:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:08:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 22:08:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:08:39 INFO - (blobuploader) - INFO - Done attempting. 22:08:39 INFO - (blobuploader) - INFO - Iteration through files over. 22:08:39 INFO - Return code: 0 22:08:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:08:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:08:39 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8b06ddbbf29366e074bde5002f1a4f4283587b22bf43c0062ad9a019c0c2438a74d2306bb78fd87ddd8276643ae6ba56536256b07b3e04b1dea7c124b7ed4339", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/101b7024e5d71b8cde48db3932031ca70ab32fa1addeb3af4fa04f20eda986e80dad8235aa245f87c1c60bbea8593ec24d9c24f2800fae220eb897fdd09358e7"} 22:08:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:08:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:08:39 INFO - Contents: 22:08:39 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8b06ddbbf29366e074bde5002f1a4f4283587b22bf43c0062ad9a019c0c2438a74d2306bb78fd87ddd8276643ae6ba56536256b07b3e04b1dea7c124b7ed4339", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/101b7024e5d71b8cde48db3932031ca70ab32fa1addeb3af4fa04f20eda986e80dad8235aa245f87c1c60bbea8593ec24d9c24f2800fae220eb897fdd09358e7"} 22:08:39 INFO - Running post-run listener: copy_logs_to_upload_dir 22:08:39 INFO - Copying logs to upload dir... 22:08:39 INFO - mkdir: /builds/slave/test/build/upload/logs 22:08:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.995490 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2016-04-05 22:08:39.390862) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-05 22:08:39.394626) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1459909530.8227-861680776 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8b06ddbbf29366e074bde5002f1a4f4283587b22bf43c0062ad9a019c0c2438a74d2306bb78fd87ddd8276643ae6ba56536256b07b3e04b1dea7c124b7ed4339", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/101b7024e5d71b8cde48db3932031ca70ab32fa1addeb3af4fa04f20eda986e80dad8235aa245f87c1c60bbea8593ec24d9c24f2800fae220eb897fdd09358e7"} build_url:https://queue.taskcluster.net/v1/task/XBOJ3KexRGKY_ZIkuchWtg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011471 build_url: 'https://queue.taskcluster.net/v1/task/XBOJ3KexRGKY_ZIkuchWtg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8b06ddbbf29366e074bde5002f1a4f4283587b22bf43c0062ad9a019c0c2438a74d2306bb78fd87ddd8276643ae6ba56536256b07b3e04b1dea7c124b7ed4339", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/101b7024e5d71b8cde48db3932031ca70ab32fa1addeb3af4fa04f20eda986e80dad8235aa245f87c1c60bbea8593ec24d9c24f2800fae220eb897fdd09358e7"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-05 22:08:39.419774) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 22:08:39.420130) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1459909530.8227-861680776 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004506 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 22:08:39.508309) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-05 22:08:39.509027) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-05 22:08:39.509736) ========= ========= Total master_lag: 0.53 =========