builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-019 starttime: 1459555964.33 results: success (0) buildid: 20160401154458 builduid: e38653c3b190470b911504cae46362f1 revision: c40c0b2f3b4c778af4307e090b4063b63c806cda ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-01 17:12:44.332063) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-01 17:12:44.332557) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-01 17:12:44.332881) ========= 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-1459555964.100954-45152541 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.004900 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-01 17:12:44.354887) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-01 17:12:44.355251) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-01 17:12:44.369007) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 17:12:44.369439) ========= 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-1459555964.100954-45152541 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004558 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 17:12:44.419276) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-01 17:12:44.419594) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-01 17:12:44.419972) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 17:12:44.420274) ========= 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-1459555964.100954-45152541 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-01 17:12:44-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 51.3M=0s 2016-04-01 17:12:44 (51.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.152758 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 17:12:44.585934) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 17:12:44.586310) ========= 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-1459555964.100954-45152541 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018137 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 17:12:44.636422) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-01 17:12:44.636807) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev c40c0b2f3b4c778af4307e090b4063b63c806cda --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev c40c0b2f3b4c778af4307e090b4063b63c806cda --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-1459555964.100954-45152541 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-01 17:12:45,108 truncating revision to first 12 chars 2016-04-01 17:12:45,108 Setting DEBUG logging. 2016-04-01 17:12:45,108 attempt 1/10 2016-04-01 17:12:45,108 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/c40c0b2f3b4c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-01 17:12:45,830 unpacking tar archive at: mozilla-central-c40c0b2f3b4c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.036594 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-01 17:12:45.687676) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-01 17:12:45.688076) ========= echo c40c0b2f3b4c778af4307e090b4063b63c806cda in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'c40c0b2f3b4c778af4307e090b4063b63c806cda'] 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-1459555964.100954-45152541 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False c40c0b2f3b4c778af4307e090b4063b63c806cda program finished with exit code 0 elapsedTime=0.003128 script_repo_revision: 'c40c0b2f3b4c778af4307e090b4063b63c806cda' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-01 17:12:45.736434) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-01 17:12:45.736758) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-01 17:12:45.747308) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-04-01 17:12:45.747671) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=78329bfc0fd5309db0a6e0ac000001b4-1459555964.100954-45152541 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:12:46 INFO - MultiFileLogger online at 20160401 17:12:46 in /builds/slave/test 17:12:46 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 17:12:46 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:12:46 INFO - {'append_to_log': False, 17:12:46 INFO - 'base_work_dir': '/builds/slave/test', 17:12:46 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 17:12:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:12:46 INFO - 'branch': 'Firefox-Non-PGO', 17:12:46 INFO - 'buildbot_json_path': 'buildprops.json', 17:12:46 INFO - 'config_files': ('talos/linux_config.py',), 17:12:46 INFO - 'default_actions': ('clobber', 17:12:46 INFO - 'read-buildbot-config', 17:12:46 INFO - 'download-and-extract', 17:12:46 INFO - 'populate-webroot', 17:12:46 INFO - 'create-virtualenv', 17:12:46 INFO - 'install', 17:12:46 INFO - 'run-tests'), 17:12:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:12:46 INFO - 'download_minidump_stackwalk': True, 17:12:46 INFO - 'download_symbols': 'ondemand', 17:12:46 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:12:46 INFO - 'tooltool.py': '/tools/tooltool.py', 17:12:46 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:12:46 INFO - '/tools/misc-python/virtualenv.py')}, 17:12:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:12:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:12:46 INFO - 'installer_path': 'installer.exe', 17:12:46 INFO - 'log_level': 'info', 17:12:46 INFO - 'log_name': 'talos', 17:12:46 INFO - 'log_to_console': True, 17:12:46 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:12:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:12:46 INFO - 'opt_config_files': (), 17:12:46 INFO - 'pip_index': False, 17:12:46 INFO - 'sps_profile': False, 17:12:46 INFO - 'sps_profile_interval': 0, 17:12:46 INFO - 'suite': 'dromaeojs', 17:12:46 INFO - 'system_bits': '32', 17:12:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:12:46 INFO - 'title': 'talos-linux64-ix-019', 17:12:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:12:46 INFO - 'use_talos_json': True, 17:12:46 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:12:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:12:46 INFO - 'work_dir': 'build'} 17:12:46 INFO - ##### 17:12:46 INFO - ##### Running clobber step. 17:12:46 INFO - ##### 17:12:46 INFO - Running pre-action listener: _resource_record_pre_action 17:12:46 INFO - Running main action method: clobber 17:12:46 INFO - rmtree: /builds/slave/test/build 17:12:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:12:46 INFO - Running post-action listener: _resource_record_post_action 17:12:46 INFO - ##### 17:12:46 INFO - ##### Running read-buildbot-config step. 17:12:46 INFO - ##### 17:12:46 INFO - Running pre-action listener: _resource_record_pre_action 17:12:46 INFO - Running main action method: read_buildbot_config 17:12:46 INFO - Using buildbot properties: 17:12:46 INFO - { 17:12:46 INFO - "project": "", 17:12:46 INFO - "product": "firefox", 17:12:46 INFO - "script_repo_revision": "production", 17:12:46 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 17:12:46 INFO - "repository": "", 17:12:46 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 17:12:46 INFO - "buildid": "20160401154458", 17:12:46 INFO - "pgo_build": "False", 17:12:46 INFO - "basedir": "/builds/slave/test", 17:12:46 INFO - "buildnumber": 46, 17:12:46 INFO - "slavename": "talos-linux64-ix-019", 17:12:46 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 17:12:46 INFO - "platform": "ubuntu64_hw", 17:12:46 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 17:12:46 INFO - "branch": "mozilla-central", 17:12:46 INFO - "repo_path": "mozilla-central", 17:12:46 INFO - "revision": "c40c0b2f3b4c778af4307e090b4063b63c806cda", 17:12:46 INFO - "stage_platform": "linux64", 17:12:46 INFO - "builduid": "e38653c3b190470b911504cae46362f1", 17:12:46 INFO - "slavebuilddir": "test" 17:12:46 INFO - } 17:12:46 INFO - Found installer url https://queue.taskcluster.net/v1/task/IeIVi6flQe-cncGs2uGDQw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 17:12:46 INFO - Running post-action listener: _resource_record_post_action 17:12:46 INFO - ##### 17:12:46 INFO - ##### Running download-and-extract step. 17:12:46 INFO - ##### 17:12:46 INFO - Running pre-action listener: _resource_record_pre_action 17:12:46 INFO - Running main action method: download_and_extract 17:12:46 INFO - mkdir: /builds/slave/test/build/tests 17:12:46 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')]} 17:12:46 INFO - https://queue.taskcluster.net/v1/task/IeIVi6flQe-cncGs2uGDQw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 17:12:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IeIVi6flQe-cncGs2uGDQw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 17:12:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IeIVi6flQe-cncGs2uGDQw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 17:12:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IeIVi6flQe-cncGs2uGDQw/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 17:12:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IeIVi6flQe-cncGs2uGDQw/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 17:12:47 INFO - Downloaded 1361 bytes. 17:12:47 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 17:12:47 INFO - Using the following test package requirements: 17:12:47 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 17:12:47 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:12:47 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:12:47 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:12:47 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:12:47 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:12:47 INFO - u'jsshell-linux-x86_64.zip'], 17:12:47 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:12:47 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:12:47 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 17:12:47 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:12:47 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:12:47 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:12:47 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:12:47 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:12:47 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:12:47 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:12:47 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:12:47 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:12:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:12:47 INFO - https://queue.taskcluster.net/v1/task/IeIVi6flQe-cncGs2uGDQw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:12:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IeIVi6flQe-cncGs2uGDQw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 17:12:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IeIVi6flQe-cncGs2uGDQw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 17:12:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IeIVi6flQe-cncGs2uGDQw/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 17:12:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IeIVi6flQe-cncGs2uGDQw/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 17:12:48 INFO - Downloaded 22115347 bytes. 17:12:48 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'] 17:12:48 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 17:12:49 INFO - Return code: 0 17:12:49 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 17:12:49 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')]} 17:12:49 INFO - https://queue.taskcluster.net/v1/task/IeIVi6flQe-cncGs2uGDQw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:12:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IeIVi6flQe-cncGs2uGDQw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 17:12:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IeIVi6flQe-cncGs2uGDQw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 17:12:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IeIVi6flQe-cncGs2uGDQw/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 17:12:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IeIVi6flQe-cncGs2uGDQw/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 17:12:51 INFO - Downloaded 22115347 bytes. 17:12:51 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'] 17:12:51 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 17:12:52 INFO - Return code: 0 17:12:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:12:52 INFO - https://queue.taskcluster.net/v1/task/IeIVi6flQe-cncGs2uGDQw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:12:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IeIVi6flQe-cncGs2uGDQw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 17:12:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IeIVi6flQe-cncGs2uGDQw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 17:12:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IeIVi6flQe-cncGs2uGDQw/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 17:12:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IeIVi6flQe-cncGs2uGDQw/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 17:12:53 INFO - Downloaded 10847584 bytes. 17:12:53 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'] 17:12:53 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 17:12:53 INFO - Return code: 0 17:12: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')]} 17:12:53 INFO - https://queue.taskcluster.net/v1/task/IeIVi6flQe-cncGs2uGDQw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:12:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IeIVi6flQe-cncGs2uGDQw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 17:12:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IeIVi6flQe-cncGs2uGDQw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 17:12:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IeIVi6flQe-cncGs2uGDQw/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 17:12:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IeIVi6flQe-cncGs2uGDQw/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 17:12:55 INFO - Downloaded 54243094 bytes. 17:12:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IeIVi6flQe-cncGs2uGDQw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 17:12:55 INFO - mkdir: /builds/slave/test/properties 17:12:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:12:55 INFO - Writing to file /builds/slave/test/properties/build_url 17:12:55 INFO - Contents: 17:12:55 INFO - build_url:https://queue.taskcluster.net/v1/task/IeIVi6flQe-cncGs2uGDQw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 17:12:56 INFO - Running post-action listener: _resource_record_post_action 17:12:56 INFO - Running post-action listener: set_extra_try_arguments 17:12:56 INFO - ##### 17:12:56 INFO - ##### Running populate-webroot step. 17:12:56 INFO - ##### 17:12:56 INFO - Running pre-action listener: _resource_record_pre_action 17:12:56 INFO - Running main action method: populate_webroot 17:12:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:12:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:12:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:12:56 INFO - '--tppagecycles', 17:12:56 INFO - '7'], 17:12:56 INFO - 'tests': ['tsvgm']}}, 17:12:56 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 17:12:56 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 17:12:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:12:56 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 17:12:56 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 17:12:56 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:12:56 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:12:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:12:56 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:12:56 INFO - 'talos_options': ['--e10s'], 17:12:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:12:56 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:12:56 INFO - 'tests': ['damp', 'tps']}, 17:12:56 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:12:56 INFO - 'talos_options': ['--e10s'], 17:12:56 INFO - 'tests': ['damp', 'tps']}, 17:12:56 INFO - 'g3': {'tests': ['dromaeo_dom']}, 17:12:56 INFO - 'g3-e10s': {'talos_options': ['--e10s'], 17:12:56 INFO - 'tests': ['dromaeo_dom']}, 17:12:56 INFO - 'other': {'tests': ['a11yr', 17:12:56 INFO - 'ts_paint', 17:12:56 INFO - 'tpaint', 17:12:56 INFO - 'sessionrestore', 17:12:56 INFO - 'sessionrestore_no_auto_restore', 17:12:56 INFO - 'tabpaint']}, 17:12:56 INFO - 'other-e10s': {'talos_options': ['--e10s'], 17:12:56 INFO - 'tests': ['a11yr', 17:12:56 INFO - 'ts_paint', 17:12:56 INFO - 'tpaint', 17:12:56 INFO - 'sessionrestore', 17:12:56 INFO - 'sessionrestore_no_auto_restore', 17:12:56 INFO - 'tabpaint']}, 17:12:56 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 17:12:56 INFO - 'tests': ['a11yr', 17:12:56 INFO - 'ts_paint', 17:12:56 INFO - 'tpaint', 17:12:56 INFO - 'sessionrestore', 17:12:56 INFO - 'sessionrestore_no_auto_restore', 17:12:56 INFO - 'tabpaint']}, 17:12:56 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 17:12:56 INFO - 'tests': ['a11yr', 17:12:56 INFO - 'ts_paint', 17:12:56 INFO - 'tpaint', 17:12:56 INFO - 'sessionrestore', 17:12:56 INFO - 'sessionrestore_no_auto_restore', 17:12:56 INFO - 'tabpaint']}, 17:12:56 INFO - 'other_l64': {'tests': ['a11yr', 17:12:56 INFO - 'ts_paint', 17:12:56 INFO - 'tpaint', 17:12:56 INFO - 'sessionrestore', 17:12:56 INFO - 'sessionrestore_no_auto_restore', 17:12:56 INFO - 'tabpaint']}, 17:12:56 INFO - 'other_nol64': {'tests': ['a11yr', 17:12:56 INFO - 'ts_paint', 17:12:56 INFO - 'tpaint', 17:12:56 INFO - 'sessionrestore', 17:12:56 INFO - 'sessionrestore_no_auto_restore', 17:12:56 INFO - 'tabpaint']}, 17:12:56 INFO - 'svgr': {'tests': ['tsvgx', 17:12:56 INFO - 'tsvgr_opacity', 17:12:56 INFO - 'tart', 17:12:56 INFO - 'tscrollx', 17:12:56 INFO - 'cart']}, 17:12:56 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 17:12:56 INFO - 'tests': ['tsvgx', 17:12:56 INFO - 'tsvgr_opacity', 17:12:56 INFO - 'tart', 17:12:56 INFO - 'tscrollx', 17:12:56 INFO - 'cart']}, 17:12:56 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:12:56 INFO - 'tests': ['tp5o']}, 17:12:56 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:12:56 INFO - 'talos_options': ['--e10s'], 17:12:56 INFO - 'tests': ['tp5o']}, 17:12:56 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:12:56 INFO - 'talos_options': ['--xperf_path', 17:12:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:12:56 INFO - 'tests': ['tp5n']}, 17:12:56 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:12:56 INFO - 'talos_options': ['--e10s', 17:12:56 INFO - '--xperf_path', 17:12:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:12:56 INFO - 'tests': ['tp5n']}}, 17:12:56 INFO - 'talos.zip': {'path': '', 17:12:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:12:56 INFO - Running post-action listener: _resource_record_post_action 17:12:56 INFO - ##### 17:12:56 INFO - ##### Running create-virtualenv step. 17:12:56 INFO - ##### 17:12:56 INFO - Running pre-action listener: _resource_record_pre_action 17:12:56 INFO - Running main action method: create_virtualenv 17:12:56 INFO - Creating virtualenv /builds/slave/test/build/venv 17:12:56 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 17:12:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:12:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:12:56 INFO - Using real prefix '/usr' 17:12:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:12:57 INFO - Installing distribute.............................................................................................................................................................................................done. 17:12:59 INFO - Installing pip.................done. 17:12:59 INFO - Return code: 0 17:12:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:12:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:12:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:12:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:12:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:12:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:59 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 0x7f4cebc10f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21cd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22997d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2328640>, '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 0x2329540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23299d0>, '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-1459555964.100954-45152541', '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 17:12:59 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 17:12:59 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 17:12:59 INFO - Using env: {'DISPLAY': ':0', 17:12:59 INFO - 'HOME': '/home/cltbld', 17:12:59 INFO - 'LANG': 'en_US.UTF-8', 17:12:59 INFO - 'LANGUAGE': 'en_US:en', 17:12:59 INFO - 'LOGNAME': 'cltbld', 17:12:59 INFO - 'MAIL': '/var/mail/cltbld', 17:12:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:12:59 INFO - 'MOZ_NO_REMOTE': '1', 17:12:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:12:59 INFO - 'NO_EM_RESTART': '1', 17:12:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:12:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:12:59 INFO - 'PWD': '/builds/slave/test', 17:12:59 INFO - 'SHELL': '/bin/bash', 17:12:59 INFO - 'SHLVL': '1', 17:12:59 INFO - 'TERM': 'linux', 17:12:59 INFO - 'TMOUT': '86400', 17:12:59 INFO - 'USER': 'cltbld', 17:12:59 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1459555964.100954-45152541', 17:12:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:12:59 INFO - '_': '/tools/buildbot/bin/python'} 17:12:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:12:59 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 17:12:59 INFO - Cleaning up... 17:12:59 INFO - Return code: 0 17:12:59 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 17:12:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:12:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:12:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:12:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:12:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:59 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 0x7f4cebc10f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21cd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22997d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2328640>, '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 0x2329540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23299d0>, '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-1459555964.100954-45152541', '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 17:12:59 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 17:12:59 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 17:12:59 INFO - Using env: {'DISPLAY': ':0', 17:12:59 INFO - 'HOME': '/home/cltbld', 17:12:59 INFO - 'LANG': 'en_US.UTF-8', 17:12:59 INFO - 'LANGUAGE': 'en_US:en', 17:12:59 INFO - 'LOGNAME': 'cltbld', 17:12:59 INFO - 'MAIL': '/var/mail/cltbld', 17:12:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:12:59 INFO - 'MOZ_NO_REMOTE': '1', 17:12:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:12:59 INFO - 'NO_EM_RESTART': '1', 17:12:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:12:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:12:59 INFO - 'PWD': '/builds/slave/test', 17:12:59 INFO - 'SHELL': '/bin/bash', 17:12:59 INFO - 'SHLVL': '1', 17:12:59 INFO - 'TERM': 'linux', 17:12:59 INFO - 'TMOUT': '86400', 17:12:59 INFO - 'USER': 'cltbld', 17:12:59 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1459555964.100954-45152541', 17:12:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:12:59 INFO - '_': '/tools/buildbot/bin/python'} 17:12:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:12:59 INFO - Downloading/unpacking psutil>=0.7.1 17:12:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:12:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:12:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:12:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:12:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:12:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:13:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:13:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:13:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:13:01 INFO - Installing collected packages: psutil 17:13:01 INFO - Running setup.py install for psutil 17:13:01 INFO - building 'psutil._psutil_linux' extension 17:13:01 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 17:13:01 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 17:13:01 INFO - building 'psutil._psutil_posix' extension 17:13:01 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 17:13:01 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 17:13:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:13:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:13:01 INFO - Successfully installed psutil 17:13:01 INFO - Cleaning up... 17:13:01 INFO - Return code: 0 17:13:01 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 17:13:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:13:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:13:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:13:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:13:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f4cebc10f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21cd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22997d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2328640>, '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 0x2329540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23299d0>, '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-1459555964.100954-45152541', '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 17:13:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 17:13:02 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 17:13:02 INFO - Using env: {'DISPLAY': ':0', 17:13:02 INFO - 'HOME': '/home/cltbld', 17:13:02 INFO - 'LANG': 'en_US.UTF-8', 17:13:02 INFO - 'LANGUAGE': 'en_US:en', 17:13:02 INFO - 'LOGNAME': 'cltbld', 17:13:02 INFO - 'MAIL': '/var/mail/cltbld', 17:13:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:13:02 INFO - 'MOZ_NO_REMOTE': '1', 17:13:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:13:02 INFO - 'NO_EM_RESTART': '1', 17:13:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:13:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:13:02 INFO - 'PWD': '/builds/slave/test', 17:13:02 INFO - 'SHELL': '/bin/bash', 17:13:02 INFO - 'SHLVL': '1', 17:13:02 INFO - 'TERM': 'linux', 17:13:02 INFO - 'TMOUT': '86400', 17:13:02 INFO - 'USER': 'cltbld', 17:13:02 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1459555964.100954-45152541', 17:13:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:13:02 INFO - '_': '/tools/buildbot/bin/python'} 17:13:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:13:02 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:13:02 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 17:13:02 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 17:13:02 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 17:13:02 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 17:13:02 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 17:13:02 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 17:13:04 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:13:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:13:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 17:13:04 INFO - Installing collected packages: mozsystemmonitor 17:13:04 INFO - Running setup.py install for mozsystemmonitor 17:13:04 INFO - Successfully installed mozsystemmonitor 17:13:04 INFO - Cleaning up... 17:13:04 INFO - Return code: 0 17:13:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:13:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:13:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:13:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:13:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:13:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f4cebc10f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21cd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22997d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2328640>, '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 0x2329540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23299d0>, '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-1459555964.100954-45152541', '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 17:13:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:13:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:13:04 INFO - Using env: {'DISPLAY': ':0', 17:13:04 INFO - 'HOME': '/home/cltbld', 17:13:04 INFO - 'LANG': 'en_US.UTF-8', 17:13:04 INFO - 'LANGUAGE': 'en_US:en', 17:13:04 INFO - 'LOGNAME': 'cltbld', 17:13:04 INFO - 'MAIL': '/var/mail/cltbld', 17:13:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:13:04 INFO - 'MOZ_NO_REMOTE': '1', 17:13:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:13:04 INFO - 'NO_EM_RESTART': '1', 17:13:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:13:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:13:04 INFO - 'PWD': '/builds/slave/test', 17:13:04 INFO - 'SHELL': '/bin/bash', 17:13:04 INFO - 'SHLVL': '1', 17:13:04 INFO - 'TERM': 'linux', 17:13:04 INFO - 'TMOUT': '86400', 17:13:04 INFO - 'USER': 'cltbld', 17:13:04 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1459555964.100954-45152541', 17:13:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:13:04 INFO - '_': '/tools/buildbot/bin/python'} 17:13:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:13:04 INFO - Downloading/unpacking blobuploader==1.2.4 17:13:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:13:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:13:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:13:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:13:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:13:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:13:06 INFO - Downloading blobuploader-1.2.4.tar.gz 17:13:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:13:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:13:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:13:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:13:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:13:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:13:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:13:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:13:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:13:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:13:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:13:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:13:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:13:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:13:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:13:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:13:06 INFO - Downloading docopt-0.6.1.tar.gz 17:13:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:13:07 INFO - Installing collected packages: blobuploader, requests, docopt 17:13:07 INFO - Running setup.py install for blobuploader 17:13:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:13:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:13:07 INFO - Running setup.py install for requests 17:13:07 INFO - Running setup.py install for docopt 17:13:07 INFO - Successfully installed blobuploader requests docopt 17:13:07 INFO - Cleaning up... 17:13:07 INFO - Return code: 0 17:13:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:13:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:13:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:13:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:13:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:13:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:07 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 0x7f4cebc10f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21cd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22997d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2328640>, '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 0x2329540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23299d0>, '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-1459555964.100954-45152541', '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 17:13:07 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 17:13:07 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 17:13:07 INFO - Using env: {'DISPLAY': ':0', 17:13:07 INFO - 'HOME': '/home/cltbld', 17:13:07 INFO - 'LANG': 'en_US.UTF-8', 17:13:07 INFO - 'LANGUAGE': 'en_US:en', 17:13:07 INFO - 'LOGNAME': 'cltbld', 17:13:07 INFO - 'MAIL': '/var/mail/cltbld', 17:13:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:13:07 INFO - 'MOZ_NO_REMOTE': '1', 17:13:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:13:07 INFO - 'NO_EM_RESTART': '1', 17:13:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:13:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:13:07 INFO - 'PWD': '/builds/slave/test', 17:13:07 INFO - 'SHELL': '/bin/bash', 17:13:07 INFO - 'SHLVL': '1', 17:13:07 INFO - 'TERM': 'linux', 17:13:07 INFO - 'TMOUT': '86400', 17:13:07 INFO - 'USER': 'cltbld', 17:13:07 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1459555964.100954-45152541', 17:13:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:13:07 INFO - '_': '/tools/buildbot/bin/python'} 17:13:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:13:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:13:07 INFO - Running setup.py (path:/tmp/pip-LsiNdm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:13:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:13:07 INFO - Running setup.py (path:/tmp/pip-ztgYtD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:13:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:13:08 INFO - Running setup.py (path:/tmp/pip-d0GuXZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:13:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:13:08 INFO - Running setup.py (path:/tmp/pip-LtX_hF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:13:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:13:08 INFO - Running setup.py (path:/tmp/pip-qFX5gC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:13:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:13:08 INFO - Running setup.py (path:/tmp/pip-S5siNm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:13:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:13:08 INFO - Running setup.py (path:/tmp/pip-jBS3HE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:13:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:13:08 INFO - Running setup.py (path:/tmp/pip-EN4nJn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:13:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:13:08 INFO - Running setup.py (path:/tmp/pip-nXEume-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:13:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:13:08 INFO - Running setup.py (path:/tmp/pip-fM7LDU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:13:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:13:08 INFO - Running setup.py (path:/tmp/pip-udfatT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:13:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:13:08 INFO - Running setup.py (path:/tmp/pip-vnwR_r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:13:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:13:08 INFO - Running setup.py (path:/tmp/pip-41iX8E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:13:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:13:08 INFO - Running setup.py (path:/tmp/pip-xWbskm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:13:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:13:08 INFO - Running setup.py (path:/tmp/pip-hPspDp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:13:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:13:08 INFO - Running setup.py (path:/tmp/pip-foFCv3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:13:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:13:09 INFO - Running setup.py (path:/tmp/pip-VWowM_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:13:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:13:09 INFO - Running setup.py install for manifestparser 17:13:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:13:09 INFO - Running setup.py install for mozcrash 17:13:09 INFO - Running setup.py install for mozdebug 17:13:09 INFO - Running setup.py install for mozdevice 17:13:09 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:13:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:13:09 INFO - Running setup.py install for mozfile 17:13:09 INFO - Running setup.py install for mozhttpd 17:13:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:13:09 INFO - Running setup.py install for mozinfo 17:13:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:13:09 INFO - Running setup.py install for mozInstall 17:13:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:13:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:13:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:13:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:13:09 INFO - Running setup.py install for mozleak 17:13:10 INFO - Running setup.py install for mozlog 17:13:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:13:10 INFO - Running setup.py install for moznetwork 17:13:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:13:10 INFO - Running setup.py install for mozprocess 17:13:10 INFO - Running setup.py install for mozprofile 17:13:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:13:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:13:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:13:10 INFO - Running setup.py install for mozrunner 17:13:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:13:10 INFO - Running setup.py install for mozscreenshot 17:13:10 INFO - Running setup.py install for moztest 17:13:10 INFO - Running setup.py install for mozversion 17:13:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:13:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:13:10 INFO - Cleaning up... 17:13:10 INFO - Return code: 0 17:13:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:13: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')]} 17:13:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:13:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13: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')]} 17:13:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:13:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:10 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 0x7f4cebc10f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21cd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22997d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2328640>, '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 0x2329540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23299d0>, '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-1459555964.100954-45152541', '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 17:13:10 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 17:13:10 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 17:13:10 INFO - Using env: {'DISPLAY': ':0', 17:13:10 INFO - 'HOME': '/home/cltbld', 17:13:10 INFO - 'LANG': 'en_US.UTF-8', 17:13:10 INFO - 'LANGUAGE': 'en_US:en', 17:13:10 INFO - 'LOGNAME': 'cltbld', 17:13:10 INFO - 'MAIL': '/var/mail/cltbld', 17:13:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:13:10 INFO - 'MOZ_NO_REMOTE': '1', 17:13:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:13:10 INFO - 'NO_EM_RESTART': '1', 17:13:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:13:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:13:10 INFO - 'PWD': '/builds/slave/test', 17:13:10 INFO - 'SHELL': '/bin/bash', 17:13:10 INFO - 'SHLVL': '1', 17:13:10 INFO - 'TERM': 'linux', 17:13:10 INFO - 'TMOUT': '86400', 17:13:10 INFO - 'USER': 'cltbld', 17:13:10 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1459555964.100954-45152541', 17:13:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:13:10 INFO - '_': '/tools/buildbot/bin/python'} 17:13:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:13:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:13:11 INFO - Running setup.py (path:/tmp/pip-foSt5Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:13:11 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)) 17:13:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:13:11 INFO - Running setup.py (path:/tmp/pip-Dk5K8b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:13:11 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)) 17:13:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:13:11 INFO - Running setup.py (path:/tmp/pip-MEG_Zv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:13:11 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)) 17:13:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:13:11 INFO - Running setup.py (path:/tmp/pip-yNzy32-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:13:11 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)) 17:13:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:13:11 INFO - Running setup.py (path:/tmp/pip-6X5maJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:13:11 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)) 17:13:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:13:11 INFO - Running setup.py (path:/tmp/pip-B0bIyK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:13:11 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)) 17:13:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:13:11 INFO - Running setup.py (path:/tmp/pip-tweNhS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:13:11 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)) 17:13:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:13:11 INFO - Running setup.py (path:/tmp/pip-yM6XP4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:13:11 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)) 17:13:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:13:11 INFO - Running setup.py (path:/tmp/pip-HFPeI5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:13:11 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)) 17:13:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:13:11 INFO - Running setup.py (path:/tmp/pip-rWSsEa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:13:11 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)) 17:13:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:13:11 INFO - Running setup.py (path:/tmp/pip-OvoDIQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:13:11 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)) 17:13:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:13:11 INFO - Running setup.py (path:/tmp/pip-XW14No-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:13:11 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)) 17:13:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:13:11 INFO - Running setup.py (path:/tmp/pip-6JpdIb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:13:12 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)) 17:13:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:13:12 INFO - Running setup.py (path:/tmp/pip-Cjf0V_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:13:12 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)) 17:13:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:13:12 INFO - Running setup.py (path:/tmp/pip-5447k6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:13:12 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)) 17:13:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:13:12 INFO - Running setup.py (path:/tmp/pip-hT1RpB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:13:12 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)) 17:13:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:13:12 INFO - Running setup.py (path:/tmp/pip-a3SX0O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:13:12 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)) 17:13:12 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)) 17:13:12 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)) 17:13:12 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)) 17:13:12 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)) 17:13:12 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)) 17:13:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:13:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:13:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:13:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:13:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:13:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:13:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:13:14 INFO - Downloading blessings-1.6.tar.gz 17:13:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:13:14 INFO - Installing collected packages: blessings 17:13:14 INFO - Running setup.py install for blessings 17:13:14 INFO - Successfully installed blessings 17:13:14 INFO - Cleaning up... 17:13:14 INFO - Return code: 0 17:13:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:13:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:13:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:13:14 INFO - Reading from file tmpfile_stdout 17:13:14 INFO - Current package versions: 17:13:14 INFO - argparse == 1.2.1 17:13:14 INFO - blessings == 1.6 17:13:14 INFO - blobuploader == 1.2.4 17:13:14 INFO - docopt == 0.6.1 17:13:14 INFO - manifestparser == 1.1 17:13:14 INFO - mozInstall == 1.12 17:13:14 INFO - mozcrash == 0.17 17:13:14 INFO - mozdebug == 0.1 17:13:14 INFO - mozdevice == 0.48 17:13:14 INFO - mozfile == 1.2 17:13:14 INFO - mozhttpd == 0.7 17:13:14 INFO - mozinfo == 0.9 17:13:14 INFO - mozleak == 0.1 17:13:14 INFO - mozlog == 3.1 17:13:14 INFO - moznetwork == 0.27 17:13:14 INFO - mozprocess == 0.22 17:13:14 INFO - mozprofile == 0.28 17:13:14 INFO - mozrunner == 6.11 17:13:14 INFO - mozscreenshot == 0.1 17:13:14 INFO - mozsystemmonitor == 0.0 17:13:14 INFO - moztest == 0.7 17:13:14 INFO - mozversion == 1.4 17:13:14 INFO - psutil == 3.1.1 17:13:14 INFO - requests == 1.2.3 17:13:14 INFO - wsgiref == 0.1.2 17:13:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:13:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:13:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:13:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:13:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:13:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:14 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 0x7f4cebc10f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21cd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22997d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2328640>, '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 0x2329540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23299d0>, '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-1459555964.100954-45152541', '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 17:13:14 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 17:13:14 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 17:13:14 INFO - Using env: {'DISPLAY': ':0', 17:13:14 INFO - 'HOME': '/home/cltbld', 17:13:14 INFO - 'LANG': 'en_US.UTF-8', 17:13:14 INFO - 'LANGUAGE': 'en_US:en', 17:13:14 INFO - 'LOGNAME': 'cltbld', 17:13:14 INFO - 'MAIL': '/var/mail/cltbld', 17:13:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:13:14 INFO - 'MOZ_NO_REMOTE': '1', 17:13:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:13:14 INFO - 'NO_EM_RESTART': '1', 17:13:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:13:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:13:14 INFO - 'PWD': '/builds/slave/test', 17:13:14 INFO - 'SHELL': '/bin/bash', 17:13:14 INFO - 'SHLVL': '1', 17:13:14 INFO - 'TERM': 'linux', 17:13:14 INFO - 'TMOUT': '86400', 17:13:14 INFO - 'USER': 'cltbld', 17:13:14 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1459555964.100954-45152541', 17:13:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:13:14 INFO - '_': '/tools/buildbot/bin/python'} 17:13:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:13:14 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)) 17:13:14 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)) 17:13:14 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)) 17:13:14 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)) 17:13:14 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)) 17:13:14 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)) 17:13:14 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)) 17:13:14 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)) 17:13:14 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)) 17:13:14 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)) 17:13:14 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)) 17:13:14 INFO - Cleaning up... 17:13:14 INFO - Return code: 0 17:13:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:13:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:13:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:13:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:13:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:13:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4cebc10f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21cd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22997d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2328640>, '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 0x2329540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23299d0>, '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-1459555964.100954-45152541', '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 17:13:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 17:13:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:13:14 INFO - Using env: {'DISPLAY': ':0', 17:13:14 INFO - 'HOME': '/home/cltbld', 17:13:14 INFO - 'LANG': 'en_US.UTF-8', 17:13:14 INFO - 'LANGUAGE': 'en_US:en', 17:13:14 INFO - 'LOGNAME': 'cltbld', 17:13:14 INFO - 'MAIL': '/var/mail/cltbld', 17:13:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:13:14 INFO - 'MOZ_NO_REMOTE': '1', 17:13:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:13:14 INFO - 'NO_EM_RESTART': '1', 17:13:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:13:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:13:14 INFO - 'PWD': '/builds/slave/test', 17:13:14 INFO - 'SHELL': '/bin/bash', 17:13:14 INFO - 'SHLVL': '1', 17:13:14 INFO - 'TERM': 'linux', 17:13:14 INFO - 'TMOUT': '86400', 17:13:14 INFO - 'USER': 'cltbld', 17:13:14 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1459555964.100954-45152541', 17:13:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:13:14 INFO - '_': '/tools/buildbot/bin/python'} 17:13:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:13:15 INFO - Downloading/unpacking jsonschema 17:13:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:13:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:13:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:13:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:13:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:13:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:13:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:13:16 INFO - Downloading/unpacking functools32 (from jsonschema) 17:13:16 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 17:13:16 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 17:13:16 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 17:13:16 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 17:13:16 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 17:13:16 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 17:13:17 INFO - Downloading functools32-3.2.3-2.tar.gz 17:13:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:13:17 INFO - warning: no files found matching '*.txt' 17:13:17 INFO - no previously-included directories found matching 'build' 17:13:17 INFO - no previously-included directories found matching 'dist' 17:13:17 INFO - no previously-included directories found matching '.git*' 17:13:17 INFO - Installing collected packages: jsonschema, functools32 17:13:17 INFO - Running setup.py install for functools32 17:13:17 INFO - warning: no files found matching '*.txt' 17:13:17 INFO - no previously-included directories found matching 'build' 17:13:17 INFO - no previously-included directories found matching 'dist' 17:13:17 INFO - no previously-included directories found matching '.git*' 17:13:17 INFO - Successfully installed jsonschema functools32 17:13:17 INFO - Cleaning up... 17:13:17 INFO - Return code: 0 17:13:17 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:13:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:13:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:13:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:13:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:13:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4cebc10f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21cd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22997d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2328640>, '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 0x2329540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23299d0>, '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-1459555964.100954-45152541', '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 17:13:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 17:13:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 17:13:17 INFO - Using env: {'DISPLAY': ':0', 17:13:17 INFO - 'HOME': '/home/cltbld', 17:13:17 INFO - 'LANG': 'en_US.UTF-8', 17:13:17 INFO - 'LANGUAGE': 'en_US:en', 17:13:17 INFO - 'LOGNAME': 'cltbld', 17:13:17 INFO - 'MAIL': '/var/mail/cltbld', 17:13:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:13:17 INFO - 'MOZ_NO_REMOTE': '1', 17:13:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:13:17 INFO - 'NO_EM_RESTART': '1', 17:13:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:13:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:13:17 INFO - 'PWD': '/builds/slave/test', 17:13:17 INFO - 'SHELL': '/bin/bash', 17:13:17 INFO - 'SHLVL': '1', 17:13:17 INFO - 'TERM': 'linux', 17:13:17 INFO - 'TMOUT': '86400', 17:13:17 INFO - 'USER': 'cltbld', 17:13:17 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1459555964.100954-45152541', 17:13:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:13:17 INFO - '_': '/tools/buildbot/bin/python'} 17:13:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:13:17 INFO - Downloading/unpacking flake8 17:13:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:13:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:13:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:13:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:13:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:13:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:13:19 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:13:19 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:13:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:13:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:13:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:13:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:13:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:13:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:13:19 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:13:19 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:13:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:13:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:13:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:13:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:13:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:13:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:13:19 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:13:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:13:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:13:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:13:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:13:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:13:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:13:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:13:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:13:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:13:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:13:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:13:20 INFO - no previously-included directories found matching 'docs/_build' 17:13:20 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:13:20 INFO - Running setup.py install for pep8 17:13:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:13:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:13:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:13:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:13:20 INFO - no previously-included directories found matching 'docs/_build' 17:13:20 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:13:20 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:13:20 INFO - Cleaning up... 17:13:20 INFO - Return code: 0 17:13:20 INFO - Running post-action listener: _resource_record_post_action 17:13:20 INFO - Running post-action listener: _start_resource_monitoring 17:13:20 INFO - Starting resource monitoring. 17:13:20 INFO - ##### 17:13:20 INFO - ##### Running install step. 17:13:20 INFO - ##### 17:13:20 INFO - Running pre-action listener: _resource_record_pre_action 17:13:20 INFO - Running main action method: install 17:13:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:13:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:13:20 INFO - Reading from file tmpfile_stdout 17:13:20 INFO - Detecting whether we're running mozinstall >=1.0... 17:13:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:13:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:13:20 INFO - Reading from file tmpfile_stdout 17:13:20 INFO - Output received: 17:13:20 INFO - Usage: mozinstall [options] installer 17:13:20 INFO - Options: 17:13:20 INFO - -h, --help show this help message and exit 17:13:20 INFO - -d DEST, --destination=DEST 17:13:20 INFO - Directory to install application into. [default: 17:13:20 INFO - "/builds/slave/test"] 17:13:20 INFO - --app=APP Application being installed. [default: firefox] 17:13:20 INFO - mkdir: /builds/slave/test/build/application 17:13:20 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'] 17:13:20 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 17:13:36 INFO - Reading from file tmpfile_stdout 17:13:36 INFO - Output received: 17:13:36 INFO - /builds/slave/test/build/application/firefox/firefox 17:13:36 INFO - Running post-action listener: _resource_record_post_action 17:13:36 INFO - ##### 17:13:36 INFO - ##### Running run-tests step. 17:13:36 INFO - ##### 17:13:36 INFO - Running pre-action listener: _resource_record_pre_action 17:13:36 INFO - Running main action method: run_tests 17:13:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:13:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:13:36 INFO - Python 2.7.3 17:13:36 INFO - Return code: 0 17:13:36 INFO - grabbing minidump binary from tooltool 17:13:36 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')]} 17:13:36 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 0x2328640>, '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 0x2329540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23299d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:13:36 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 17:13:36 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 17:13:36 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:13:36 INFO - Return code: 0 17:13:36 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:13:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:13:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:13:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:13:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:13:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:13:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:13:37 INFO - Return code: 0 17:13:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IeIVi6flQe-cncGs2uGDQw/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 17:13:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/IeIVi6flQe-cncGs2uGDQw/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 17:13:37 INFO - Using env: {'DISPLAY': ':0', 17:13:37 INFO - 'HOME': '/home/cltbld', 17:13:37 INFO - 'LANG': 'en_US.UTF-8', 17:13:37 INFO - 'LANGUAGE': 'en_US:en', 17:13:37 INFO - 'LOGNAME': 'cltbld', 17:13:37 INFO - 'MAIL': '/var/mail/cltbld', 17:13:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:13:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:13:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:13:37 INFO - 'MOZ_NO_REMOTE': '1', 17:13:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:13:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:13:37 INFO - 'NO_EM_RESTART': '1', 17:13:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:13:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:13:37 INFO - 'PWD': '/builds/slave/test', 17:13:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:13:37 INFO - 'SHELL': '/bin/bash', 17:13:37 INFO - 'SHLVL': '1', 17:13:37 INFO - 'TERM': 'linux', 17:13:37 INFO - 'TMOUT': '86400', 17:13:37 INFO - 'USER': 'cltbld', 17:13:37 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1459555964.100954-45152541', 17:13:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:13:37 INFO - '_': '/tools/buildbot/bin/python'} 17:13:37 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IeIVi6flQe-cncGs2uGDQw/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 17:13:37 INFO - mozversion application_buildid: 20160401154458 17:13:37 INFO - mozversion application_changeset: c40c0b2f3b4c778af4307e090b4063b63c806cda 17:13:37 INFO - mozversion application_display_name: Nightly 17:13:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:13:37 INFO - mozversion application_name: Firefox 17:13:37 INFO - mozversion application_remotingname: firefox 17:13:37 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:13:37 INFO - mozversion application_vendor: Mozilla 17:13:37 INFO - mozversion application_version: 48.0a1 17:13:37 INFO - mozversion platform_buildid: 20160401154458 17:13:37 INFO - mozversion platform_changeset: c40c0b2f3b4c778af4307e090b4063b63c806cda 17:13:37 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:13:37 INFO - mozversion platform_version: 48.0a1 17:13:37 INFO - using testdate: 1459556017 17:13:37 INFO - actual date: 1459556017 17:13:37 INFO - starting webserver on 'localhost:44267' 17:13:37 INFO - SUITE-START | Running 2 tests 17:13:37 INFO - TEST-START | dromaeo_css 17:13:37 INFO - operating with platform_type : linux_ 17:13:37 INFO - Initialising browser for dromaeo_css test... 17:13:37 INFO - TEST-INFO | started process 12014 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGwXh4O/profile http://localhost:44267/getInfo.html) 17:13:42 INFO - PROCESS | 12014 | __metrics Screen width/height:1600/1200 17:13:42 INFO - PROCESS | 12014 | colorDepth:24 17:13:42 INFO - PROCESS | 12014 | Browser inner width/height: 1024/697 17:13:42 INFO - PROCESS | 12014 | __metrics 17:13:43 ERROR - PROCESS | 12014 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 17:13:44 INFO - TEST-INFO | 12014: exit 0 17:13:44 INFO - Browser initialized. 17:13:44 INFO - Running cycle 1/1 for dromaeo_css test... 17:13:44 INFO - TEST-INFO | started process 12095 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGwXh4O/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:13:56 INFO - PROCESS | 12095 | RSS: Main: 154603520 17:13:56 INFO - PROCESS | 12095 | 17:14:47 INFO - PROCESS | 12095 | 1459556087232 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] 17:16:58 INFO - PROCESS | 12095 | Cycle 1(1): loaded http://localhost:44267/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44267/tests/dromaeo/cssquery-ext.html) 17:17:00 INFO - PROCESS | 12095 | RSS: Main: 275955712 17:17:00 INFO - PROCESS | 12095 | 17:20:02 INFO - PROCESS | 12095 | Cycle 1(1): loaded http://localhost:44267/tests/dromaeo/cssquery-ext.html (next: http://localhost:44267/tests/dromaeo/cssquery-jquery.html) 17:20:03 INFO - PROCESS | 12095 | RSS: Main: 240562176 17:20:03 INFO - PROCESS | 12095 | 17:23:04 INFO - PROCESS | 12095 | Cycle 1(1): loaded http://localhost:44267/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44267/tests/dromaeo/cssquery-mootools.html) 17:23:05 INFO - PROCESS | 12095 | RSS: Main: 233562112 17:23:05 INFO - PROCESS | 12095 | 17:26:07 INFO - PROCESS | 12095 | Cycle 1(1): loaded http://localhost:44267/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44267/tests/dromaeo/cssquery-prototype.html) 17:26:08 INFO - PROCESS | 12095 | RSS: Main: 214421504 17:26:08 INFO - PROCESS | 12095 | 17:29:10 INFO - PROCESS | 12095 | Cycle 1(1): loaded http://localhost:44267/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44267/tests/dromaeo/cssquery-yui.html) 17:29:11 INFO - PROCESS | 12095 | RSS: Main: 198803456 17:29:11 INFO - PROCESS | 12095 | 17:32:14 INFO - PROCESS | 12095 | Cycle 1(1): loaded http://localhost:44267/tests/dromaeo/cssquery-yui.html (next: http://localhost:44267/tests/dromaeo/cssquery-dojo.html) 17:32:14 INFO - PROCESS | 12095 | RSS: Main: 268427264 17:32:14 INFO - PROCESS | 12095 | 17:32:14 INFO - PROCESS | 12095 | __start_tp_report 17:32:14 INFO - PROCESS | 12095 | _x_x_mozilla_page_load 17:32:14 INFO - PROCESS | 12095 | _x_x_mozilla_page_load_details 17:32:14 INFO - PROCESS | 12095 | |i|pagename|runs| 17:32:14 INFO - PROCESS | 12095 | |0;dojo.html;2639.1027050802722;2740.520408928437;2745;2753.3804893898873;2781.6662000559936;4629.953700462995;4700.670953033289;4720.622350211984;4722.834700785474;4738.407699037621;4589.128065667521;4593.15026720057;4640.141573808848;4675.555822196894;4704.38842950416;4262.1049579588325;4268.573142685722;4282.7858607069675;4317.395564620955;4460.018795864905;4386.780660966955;4398.318260669601;4410.867673969786;4455.064436468346;4472.284434490482;4179.373094035919;4276.059266961294;4286.849960251377;4353.303471444586;4361.6510679145595;4299.054208074219;4303.763293018883;4336.349547567858;4351.97824010878;4368.213721530124;4272.786360681985;4285.635720963722;4292.399064131024;4310.590493903074;4336.392904993303;4499.955000449986;4546.204414227497;4569.794359253841;4613.838515651936;4622.306654001893;4993.051320249141;4994.450610432849;4999.575036121934;5004.224345226496;5020.598352131858;5031;5035.043341765089;5046.697198168122;5047.520485553867;5094.872628184325;4580.7938642761155;4677.672562920631;4678.368420263289;4746.620270378361;4754.738489383048;5148.6910785353;5161.793528258902;5162.483751624883;5181.948180518147;5182.948170518322;4962.379702537183;4965.726885021359;4966.130927087817;4966.726830024383;5021.6735912165595;4962.454130045692;4970.652054356233;5018.4981501849525;5058.1654027085115;5070.467600901926;4897.681650692693;4919.581835543947;4921.114199444134;4936.062148191832;4967.801287948441;4783.425988881357;4904.411470623548;4906.165951788204;4907.950920490821;4961.280614310905;4164.937525937114;4213.768242746678;4225.133847561243;4226.2392769301205;4238.554951730086;3723.9945214791856;3729.4965179700393;3736.0286325555553;3746.550413950343;3780.2061567070673;4287.121140166259;4362.781860906942;4371.737695738266;4376.496702879146;4420;4908.950910490921;5050.823221187315;5052.621053421009;5106.693598384109;5107.463716309809;4297.119090586422;4298.312270036779;4317.805698743564;4326.65386769064;4335.718178318462;4428.800703968329;4435.933460998088;4469.396631454777;4471.619912307425;4475.4181956345465;4761.095391875532;4762.547557982125;4765.5949244314625;4788.209945359046;4815.855524334345;5051.166557517969;5056.216286475602;5057.115004874206;5058.443571207091;5072.442031376472;4627.398438203012;4674.6260299176665;4751.973336260557;4775.068861572099;4814.085323788469;4931.358923340086;4945.4312754033745;4949.579285760607;4952.306677065286;4978.7510624467905;5007.524285192901;5007.624428167975;5007.69953802773;5014;5045.772940217626;4795.496472870298;4872.244802055687;4917.188663870421;4946.777395017305;4956;4847.515248475124;4855;4866.6350023747655;4871.391076115486;4925.8029678812445;4803.615710743202;4810.518948105161;4810.903781924272;4810.975945120392;4865.878353041061;4730.692504987165;4802.471728109975;4848.80604775805;4929.457759646364;4934.679245849008;4742.976285118552;4770.666053376369;4806.7836947336755;4817.229243321051;4824.565789079 17:32:14 INFO - PROCESS | 12095 | |1;ext.html;526.2211926349004;528.7594144664179;534.5883669574426;546.1371033766649;553.6124712701105;26944.730552694466;34123;34779.65220347793;34837;34872.3025539489;37175;37963.43054854179;38031;38054.80972595133;38111.42832857509;7578.962105189494;7766.262205090507;7768.883466748003;7769.533827970312;7770.650320735552;7686.615669216545;7817.452778305521;7820.569868657221;7821.4133939954445;7987.520748755093;7948.841023179533;8022.959885200566;8029.437939344249;8032.598370081501;8033.397495187855;7893.644785984645;7949.920500795034;7964.084130325029;7965.283124518821;7967.44227904047;7884.408669349822;7929.722459713882;7952.20477952206;8015.118336982927;8015.4389192756535;37467.62532374669;37821.62178378209;37957;38099.80950095259;38106.61893381058;3342.2145795737983;3369.696727294531;3389.322135572895;3477.7565570410084;3690.815459227028;28632.856835715895;28792.42415151685;28862.422751545062;28963.56554651682;29677.851610742026;3334.283129127249;3409.1136304560746;3441.15691655546;3462.221000274918;3498.755087143901;170329;171938;172424.99999999875;172676;173020.13489932596;41152.794236028625;42591.36112958308;42649.78675106604;54874.72562637241;55306;40734;40753.184936301106;40844.18311633751;40868.79565602153;40938.795306023276;14324.068935519366;14574.19841908684;14575.85424145745;14576.271186440636;14582.781258281135;11186.496607652674;11233.213675042669;11239.100871930226;11244.325340479598;11281.830772538418;14599.124052556881;14626.195559244345;14774.704505909822;14798.112113273239;14859.331330090172;5600.887982240414;5725.914111288334;5726.656400615976;5810.941890581124;5895.263092113486;883.3066043156092;894.6779159502574;972.7665360313474;1007.2143727892255;1061.3737894642045;27076.458470830472;27500.58749118765;27730.306742331602;27875.721242787313;27911;989.8366769482955;1061.2040969273046;1065.3820783945293;1068.5084860963889;1093.2729734726317;13739.381727822272;14290.356933937997;14475.92762036183;14562.63593410152;14584.052036617586;283604;287623;288026;289972;291572;47978;48706.75646621744;48721;48729.75635121802;48816.26775598369;1048.8741351037772;1153.5501154549731;1214.574898785418;1241.5530409052733;1258.6853286678331;25005;25056.997720090993;25072.874635626704;25079.373015674755;25094.49811003806;32857;33267;33291.83354083214;34002.31995360128;34058.82970585131;193668;195893;196126;196266;196429;30963;32382.352352952337;32677.18307042343;32904.67095329016;32918.50622240716;39789.40315895322;41175;41182.38226426546;41591.58408415998;41869.69716665613;34814.12964675904;35321.646783532866;35394.8230258847;35482.822585886905;35956.820215898755;34379.82810085933;34712.65287347094;34886.476702849985;35123.47314790229;35233.82383088068;28868.71131288744;29507.262318441353;31850.840745796122;32022.35955280928;34238.315233695685;24670.629940551265;25625.49197397431;29350.853245733633;29492.410151797274;29900.70099298979;23677.526449471257;23986.640200396658;24065.639015414432;24454.51090978206;24475.51048979046 17:32:14 INFO - PROCESS | 12095 | |2;jquery.html;354.40813840885716;355.87722235828636;360.4719086538221;364;369.65252662497267;15310.311036003379;15733.685326293482;17176.914115429438;17600.64798704025;17602.735958960628;16086.5978350541;16594.83405165948;16678;16697.165141742895;16718.916405417956;4960.578350840183;5111.258867464216;5295.8146464873735;5862.149988251722;5862.560307976897;5882.617629854067;5916.083007133901;5934.406559344053;5943.167956486095;5983.700814959257;5839.357670656224;5842.620229685057;5878.647281163123;5908.350081491032;6043.637381757087;5950.285965684124;5978.312494063195;5984.072468767348;5992.580519363646;6009.248843894513;5104.795808167669;5182.300389447414;5230.241614965847;5240.554552863011;5251.737413129328;19174.808251917442;19824.900875495674;19873.20507179711;19884.502887427785;19885.50286242841;2000.1799262302386;2053.7330147080934;2057.1154403606442;2330.697009388786;2486.676732024843;8465.280451161658;8813.559322033872;9015.504147271897;9082.45505269686;12941.417636206394;1690.6618676264795;1743.3985275080076;1755.183839514619;1782.4830799068384;1817.2367605605677;55992.720036399965;58065.838683226524;58291.41708582902;58526.70736646289;59791.402085979455;9406.623735050658;9472.763180920394;9496.382735122195;9570.33007689455;9767.169790567881;13035.15271507349;13115.868841311656;13119.737605247841;13144.737105257842;13187.802182967263;7033.296670332926;7068;7135.5361901476235;7202.495825292284;7306.926930730731;6670.666466676646;6916.619585922823;6988.44092472601;7038.542494737826;7081.398081163159;4074.633283004544;4102.548719640837;4136;4180.7909604519655;4198.6221240088535;1683.8063622683549;1775.6715007723353;1782.6702060118919;1789.0786245083793;1792.1666425112126;805.963731632078;874.6413970272158;881.2685471059006;892.7009451833709;939.9848163982882;16083.437079702155;16197.919010405109;16245.593860153354;16318.428854990256;16537.255823487973;867.2065060469725;872.3326655108847;873.0876234335135;881.4182639457927;908.7546362482093;7655.961720191475;9385.343025988252;9400.435973841591;9426.717198484057;9485.762855928657;365462;369737;371932;375855.1207244001;376487;41717;59005.10637447375;60351.69824150939;69575.65212174007;70660.29339706537;927.8051609162152;937.840567103594;939.9389039712397;959.5921733263475;960.7261930349816;14826.40694372213;14959.476418325741;15186.46847360337;15210.46763363277;15293.847061529243;21610.13559457667;30092.398152037276;30712.84643576768;31256.374872502878;33682.98951031473;39971.60028399679;41890.79054604707;42128.10423530887;42137.57862421337;43602.56397435985;7221.133463984355;7236.565806051653;7245.7826265212125;7441.665125069493;7491.475596708178;9826.606935722491;11344.546218151181;11562.76874462523;11720.88279117198;11755.000824929977;6976.895346569907;10160.847587286344;10165.949170254396;10469.738256543647;10508.581341519102;9188.862167067633;10176.18590512772;10264.230182736474;10341.069303762697;10394.688159355232;8895;9496.19282361007;10026.298159128792;10651.30766500175;10657.786844262917;7380;7432.442566807619;7488.700451981859;7576.6969321228735;7608.80977975555;9206.907930920604;10149.23880708935;10314.27800053989;10344.844827327746;10477.68566942993 17:32:14 INFO - PROCESS | 12095 | |3;mootools.html;1302.042998396178;1402.859714028597;1424.3946322812806;1567.929443175057;1765.9205335759889;6761.594304341743;7281.417486601073;7451.366633836124;7452.292032256927;7452.403807695385;7351.228121047293;7530.983317252169;7540.095188577378;7547.207543207966;7553.395728341719;1902.286642509059;1946.844252459807;1954.2085455390518;2145.0454547726267;2165.7401111866598;2194.659827726697;2257.548490301938;2259.1302348595827;2259.649754288088;2263.7396699379533;2143.807057364837;2193.934181974543;2196.8132708719777;2198.1097655449566;2214.7563767985507;2175.282156888231;2178.771229020954;2181.8472706910525;2188.7701791311842;2190.047329411711;2104.4844013216707;2142.335875878467;2145.967810482844;2150.602138604363;2150.6773983902385;7650.120236172856;7690.307872291521;7704.614769261514;7706.075270967463;7710.807229819244;4515.864524064284;4619.330197121399;4627.467841198271;4635.976820115878;4654.022655242369;3045.345250771095;3069;3173.6032995875516;3185.824779637119;3188.505781603832;918.3112665500875;977.8973207813219;984.1241295247236;995.9004099590055;1030.6032177611598;10764.784704305948;10811.405372704497;10815.837762433648;10827.296225745302;10835.891641083646;4190.20386126635;4285.957140428618;4311.892202694895;4313.094250207429;4316.784160792011;9040.231580315747;9121.81756364869;9128.863067053999;9134.680286189952;9139.954300228455;4592.6555508337005;4617.561331673485;4653.441587009581;4654.115718013567;4654.906901862011;3548.520949671761;3967.682585393162;4098.7950602469755;4191.476065491814;4197.601227883346;3464.2378676691087;3516.929661406809;3536.5932917714276;3557.0751604582993;3564.0733409313766;1140.6121918547733;1142.5772464188303;1147.4148184426003;1154.7979103656826;1167.8773728758529;960.2318145483586;999.2106236073421;1161.4657257661402;1173.1318824070297;1185.6798664360574;6875.449964002868;6905.723771049102;6913.2049814270995;6927.896081558781;6942.1669399671355;1089.7330154112135;1097.9341239525654;1098.0556721219746;1117.6255954255253;1130.2596799096605;5649.519790817744;5688.23208866806;5742.224799652077;5753.309602847685;5764.13537969308;8943.418677785923;9676.177524910461;9687.51562421876;9713.660021899199;9721.70834874955;9407.43555386679;9418.15236628693;9476.194523465445;9495.857562136573;9533;7071.36357727807;7360.521566098294;7382.114146302478;7396.704131834666;7479.214682458263;6908.2400935896;6974.965125174342;6988.685509151998;6996.510244282851;7002.3697867192195;7952.880706789287;7987.760367188761;8119.431639785158;8120.715774947848;8155.306798922158;8251.587420629065;8286.70996515119;8327.541985190872;8408.075111737582;8419.073901870912;5971.0744834550715;6166.568340216142;6167.84580385494;6417.582857114273;6625.801225963229;6710.899336509859;6993.615351155735;7138.750143744944;7168.068151140318;7175.282471752783;6414.807555773335;6590.868182636224;6616.503762217757;6637.767678131242;6675.566088204251;6585.835354116185;6610.041543976;6702.932970670426;6712.630805305755;6749.561278517077;6860.313968603299;6884.586924784529;6902.240753517009;6905.516613836983;6916.965415172892;6320.051992201206;6429.38920802523;6450.774222902176;6459.4832413405875;6466.0947467355545;6367.808965731036;6370.90443643355;6393.264774550986;6399.072134540559;6399.200099987502 17:32:14 INFO - PROCESS | 12095 | |4;prototype.html;315.760022382989;316.1826678037273;318.2759222768203;321.13454240821;323.1275555998803;5254.290670759447;5413.350397952247;5427.755750991205;5449.618526703128;5463.31708536433;5252.737363131847;5399.811006614769;5404.594655400851;5407.675539467635;5409.404965453797;3945.447637330776;4042.090529630839;4126.8761937141935;4127.834886604533;4158.708890377675;4149.190907772985;4153.356229784388;4153.480814898137;4158.147579746144;4159.542450330461;4107.917841643165;4111.876643700693;4112.609302116294;4116.464859568267;4119.691023173259;3906.8632597859223;3994.0613955720382;3998.5801490843332;4008.0581063450068;4118.567550407209;3435.2442462658173;3468.3063387322636;3493.6331685172945;3508.1755787389943;3513.2622149348667;5096.61775366849;5113.642045056848;5115.258287548285;5118.360204974379;5121.692698438105;4657.930131048037;4660.464046634613;4665.976670116627;4666.953330466686;4678.274867395559;5600.775968961237;5602.439756024406;5613.522850557708;5619.241402410663;5621.8594535136535;3847.961520384816;3849.21091176311;3851.306764782338;3851.8074096295354;3858.3826587745825;5771.855703607402;5890.823275301705;5971.970140149315;5989.8203053908455;6003.069524223796;4003.4395184674167;4010.4585880905706;4036.2442337582656;4039.6970227233073;4046.959530404717;4093.9590604094174;4097.282975479339;4098.754074755524;4099.344104943195;4102.692298077656;4708.670393072452;4710.552497512731;4711.057788442326;4711.764411779397;4720.12677654635;5662.37713851476;5671.943280567224;5674.631148975303;5681.318241811009;5681.346645135863;1421.6374824419913;1447.9348429320705;1448.0515262503077;1450.7751298548742;1451.151076620189;940.8071345374182;952.2905435450633;960.7742180587557;967.1778987860403;973.561897146287;4803.879903002383;4900.534449227318;4905.950940490621;4907.312976183337;4958.330625365602;5858.707064646751;5956.940430595725;5969.970150149222;5974.581779275409;5974.731137098841;5044.419891712427;5055;5067.8986420271385;5069.543741063322;5070.01134778722;3144.2768163322107;3165.1454107390878;3177.253345463814;3178.570892929471;3180.777345585787;5526.447355264441;5581.720913954286;5590.161475778585;5591.580631452657;5594.13290939905;5896.528277737771;6084.117802918552;6085.482733967662;6089.969550152309;6096.268447786294;5499.615026948075;5519.31008623922;5581.441855814386;5585.832425027255;5588.413216612278;5916.349201587908;5938.8218353449465;5941.613795103304;5942.940570594239;5955.493783028491;5749.7125143741805;5753.338366087954;5759.65442073477;5767.134929760402;5770.047942089508;5505.467484956965;5549.805756798492;5555.50000499957;5560.054790685513;5565.1374037024325;3978.5026871641044;4124.278251306069;4166.8749937501925;4175.185838761412;4177.665786737114;5829.8251052468495;5846.158460085059;5847.502962248256;5853.09277062056;5854.560907931837;5646.604737668488;5672.092465205547;5675.177099320493;5676.403977582295;5679.545636349165;5663.66018038919;5669.4047125051275;5677.659340439587;5679.091345384883;5679.432056794452;5573.749181286933;5575.358833734173;5577.60956733041;5585.497305242548;5586.38549759518;5494.120940649477;5683.346415162309;5693.914591281051;5693.943060569507;5703.942960570341;5504.889902201853;5545.694986775605;5546.168074788814;5548.916766248429;5640.5769567281795 17:32:14 INFO - PROCESS | 12095 | |5;yui.html;708.6244290526022;787.5314188058107;792.2711105782676;795.9084705258897;800.4196957206025;12566;12879.742405151892;12917.999999999989;12925.612231633042;12929.612111636654;12129.272243665386;12157.696057598565;12238.959688426472;12249;12275.44760485778;642.72041661877;797.7806103321575;804.8752443371287;813.1096449387941;818.9754307370788;807.4105902691039;815.4210510537525;816.2572059425923;819.3404309530825;820.2084987986592;852.7697521669146;854.8546747052985;855.1320409784074;855.6406309350087;856.1695155698962;688.717625773433;840.8822764812932;858.3991206155716;859.2181115185151;860.7934095817021;630.8170630517144;631.0250662726099;631.1511017681212;631.4127861089186;631.6462780842743;12247.448864801105;12297.815532767016;12309.753804923941;12316.81524777129;12317.876821231763;12062.69843253917;12475.563355282522;12499.875001249962;12562.371881405894;12607.495700171981;9715;9870.76802122743;9898.505074746234;10069.345492543034;10108.39349639024;3361.1765117546356;3382.2220889195623;3416.4533674611944;3451.0854623524788;3501.6848483636595;39924.800375998224;39934.60065399338;40376.59623403787;40489.59510404917;40605.187896242205;9676.656151419475;9782.217422606174;9837.852432213522;9871.851922221173;10080.495975201211;17725.7341139883;17759.644807104043;17774.555636109202;17993.550161246072;18010.63978720418;5850.912236316459;5959.970200149059;6015.578909476382;6241.032639940817;6253.37466253371;3549.165946002687;3614.3855544557487;3666.1201311685536;3723.4414837774552;3739.0652336915773;2909.956350654742;2911.5195992660974;2912.956305655417;2924.0789151417234;2927;488.2334734466924;488.6146832181216;495.0840944253103;506.97843844653056;508.43055777529406;479.6306843730308;501.39832201358513;557.6654007595411;576.2048373244895;621.6177051113533;8118.35053195743;8123.431359804875;8299.170082991652;8405;8560.101189375026;528.5665754081693;572.3618165745164;612.8161551534611;619.0806652121596;624.581530374641;3833.9041523962123;3848.5574158972076;3857.1428571428573;3921.215756848642;3921.411788231731;47024.05951880943;51471.48528514667;52834.47165528373;52996.735016325445;53017.469825301254;40967.18065638671;41415.1716965659;41870.790646047186;41949.161016780105;42081.57918420838;38842.22315553729;38935.22129557393;38970.511097678194;38992.80503597464;39261.03694815305;7556.508826926232;7570.05374328209;7584.431167662337;7650.579218143055;8241.340692744447;29042;29804.850975744983;30988.22529436782;31105.222369440038;31312;34525.13687157841;36843.447348289264;37832.43251351287;38196.42705359477;38809;9890.901090989286;10068.093871551595;10131.696049118538;10169.32206185971;10428.634997775041;9350.81298374015;11434.485448154686;11434.599789007345;11970.042396608076;12164.209326393757;10797.13622910181;10921.617743378943;10938.507767150339;10951.83572246433;11277.436128193393;10840.186985975926;10943.835842462211;11057.889421105687;11074.280171788809;11328.716782080513;10956.671299861016;10957.671269861918;11040.392778397265;11071.889281107407;11072.169587281147;9025.548722563977;9089.272858171462;9215.723528294162;9747.9025209747;9863.408195508293;8795.057257414734;9213.856729919542;9219.17027467531;9226.723198304062;9424.764380890258 17:32:14 INFO - PROCESS | 12095 | __end_tp_report 17:32:14 INFO - PROCESS | 12095 | __start_cc_report 17:32:14 INFO - PROCESS | 12095 | _x_x_mozilla_cycle_collect,1144 17:32:14 INFO - PROCESS | 12095 | __end_cc_report 17:32:14 INFO - PROCESS | 12095 | __startTimestamp1459557134368__endTimestamp 17:32:14 INFO - PROCESS | 12095 | 17:32:14 INFO - PROCESS | 12095 | ------- Summary: start ------- 17:32:14 INFO - PROCESS | 12095 | Number of tests: 6 17:32:14 INFO - PROCESS | 12095 | 17:32:14 INFO - PROCESS | 12095 | [#0] dojo.html Cycles:165 Average:4634.48 Median:4765.59 stddev:468.46 (9.8%) stddev-sans-first:442.97 17:32:14 INFO - PROCESS | 12095 | Values: 2639.1 2740.5 2745.0 2753.4 2781.7 4630.0 4700.7 4720.6 4722.8 4738.4 4589.1 4593.2 4640.1 4675.6 4704.4 4262.1 4268.6 4282.8 4317.4 4460.0 4386.8 4398.3 4410.9 4455.1 4472.3 4179.4 4276.1 4286.8 4353.3 4361.7 4299.1 4303.8 4336.3 4352.0 4368.2 4272.8 4285.6 4292.4 4310.6 4336.4 4500.0 4546.2 4569.8 4613.8 4622.3 4993.1 4994.5 4999.6 5004.2 5020.6 5031.0 5035.0 5046.7 5047.5 5094.9 4580.8 4677.7 4678.4 4746.6 4754.7 5148.7 5161.8 5162.5 5181.9 5182.9 4962.4 4965.7 4966.1 4966.7 5021.7 4962.5 4970.7 5018.5 5058.2 5070.5 4897.7 4919.6 4921.1 4936.1 4967.8 4783.4 4904.4 4906.2 4908.0 4961.3 4164.9 4213.8 4225.1 4226.2 4238.6 3724.0 3729.5 3736.0 3746.6 3780.2 4287.1 4362.8 4371.7 4376.5 4420.0 4909.0 5050.8 5052.6 5106.7 5107.5 4297.1 4298.3 4317.8 4326.7 4335.7 4428.8 4435.9 4469.4 4471.6 4475.4 4761.1 4762.5 4765.6 4788.2 4815.9 5051.2 5056.2 5057.1 5058.4 5072.4 4627.4 4674.6 4752.0 4775.1 4814.1 4931.4 4945.4 4949.6 4952.3 4978.8 5007.5 5007.6 5007.7 5014.0 5045.8 4795.5 4872.2 4917.2 4946.8 4956.0 4847.5 4855.0 4866.6 4871.4 4925.8 4803.6 4810.5 4810.9 4811.0 4865.9 4730.7 4802.5 4848.8 4929.5 4934.7 4743.0 4770.7 4806.8 4817.2 4824.6 17:32:14 INFO - PROCESS | 12095 | 17:32:14 INFO - PROCESS | 12095 | [#1] ext.html Cycles:180 Average:37620.74 Median:18766.06 stddev:58451.71 (311.5%) stddev-sans-first:58549.32 17:32:14 INFO - PROCESS | 12095 | Values: 526.2 528.8 534.6 546.1 553.6 26944.7 34123.0 34779.7 34837.0 34872.3 37175.0 37963.4 38031.0 38054.8 38111.4 7579.0 7766.3 7768.9 7769.5 7770.7 7686.6 7817.5 7820.6 7821.4 7987.5 7948.8 8023.0 8029.4 8032.6 8033.4 7893.6 7949.9 7964.1 7965.3 7967.4 7884.4 7929.7 7952.2 8015.1 8015.4 37467.6 37821.6 37957.0 38099.8 38106.6 3342.2 3369.7 3389.3 3477.8 3690.8 28632.9 28792.4 28862.4 28963.6 29677.9 3334.3 3409.1 3441.2 3462.2 3498.8 170329.0 171938.0 172425.0 172676.0 173020.1 41152.8 42591.4 42649.8 54874.7 55306.0 40734.0 40753.2 40844.2 40868.8 40938.8 14324.1 14574.2 14575.9 14576.3 14582.8 11186.5 11233.2 11239.1 11244.3 11281.8 14599.1 14626.2 14774.7 14798.1 14859.3 5600.9 5725.9 5726.7 5810.9 5895.3 883.3 894.7 972.8 1007.2 1061.4 27076.5 27500.6 27730.3 27875.7 27911.0 989.8 1061.2 1065.4 1068.5 1093.3 13739.4 14290.4 14475.9 14562.6 14584.1 283604.0 287623.0 288026.0 289972.0 291572.0 47978.0 48706.8 48721.0 48729.8 48816.3 1048.9 1153.6 1214.6 1241.6 1258.7 25005.0 25057.0 25072.9 25079.4 25094.5 32857.0 33267.0 33291.8 34002.3 34058.8 193668.0 195893.0 196126.0 196266.0 196429.0 30963.0 32382.4 32677.2 32904.7 32918.5 39789.4 41175.0 41182.4 41591.6 41869.7 34814.1 35321.6 35394.8 35482.8 35956.8 34379.8 34712.7 34886.5 35123.5 35233.8 28868.7 29507.3 31850.8 32022.4 34238.3 24670.6 25625.5 29350.9 29492.4 29900.7 23677.5 23986.6 24065.6 24454.5 24475.5 17:32:14 INFO - PROCESS | 12095 | 17:32:14 INFO - PROCESS | 12095 | [#2] jquery.html Cycles:180 Average:22464.55 Median:24281.57 stddev:60888.83 (250.8%) stddev-sans-first:61037.01 17:32:14 INFO - PROCESS | 12095 | Values: 354.4 355.9 360.5 364.0 369.7 15310.3 15733.7 17176.9 17600.6 17602.7 16086.6 16594.8 16678.0 16697.2 16718.9 4960.6 5111.3 5295.8 5862.1 5862.6 5882.6 5916.1 5934.4 5943.2 5983.7 5839.4 5842.6 5878.6 5908.4 6043.6 5950.3 5978.3 5984.1 5992.6 6009.2 5104.8 5182.3 5230.2 5240.6 5251.7 19174.8 19824.9 19873.2 19884.5 19885.5 2000.2 2053.7 2057.1 2330.7 2486.7 8465.3 8813.6 9015.5 9082.5 12941.4 1690.7 1743.4 1755.2 1782.5 1817.2 55992.7 58065.8 58291.4 58526.7 59791.4 9406.6 9472.8 9496.4 9570.3 9767.2 13035.2 13115.9 13119.7 13144.7 13187.8 7033.3 7068.0 7135.5 7202.5 7306.9 6670.7 6916.6 6988.4 7038.5 7081.4 4074.6 4102.5 4136.0 4180.8 4198.6 1683.8 1775.7 1782.7 1789.1 1792.2 806.0 874.6 881.3 892.7 940.0 16083.4 16197.9 16245.6 16318.4 16537.3 867.2 872.3 873.1 881.4 908.8 7656.0 9385.3 9400.4 9426.7 9485.8 365462.0 369737.0 371932.0 375855.1 376487.0 41717.0 59005.1 60351.7 69575.7 70660.3 927.8 937.8 939.9 959.6 960.7 14826.4 14959.5 15186.5 15210.5 15293.8 21610.1 30092.4 30712.8 31256.4 33683.0 39971.6 41890.8 42128.1 42137.6 43602.6 7221.1 7236.6 7245.8 7441.7 7491.5 9826.6 11344.5 11562.8 11720.9 11755.0 6976.9 10160.8 10165.9 10469.7 10508.6 9188.9 10176.2 10264.2 10341.1 10394.7 8895.0 9496.2 10026.3 10651.3 10657.8 7380.0 7432.4 7488.7 7576.7 7608.8 9206.9 10149.2 10314.3 10344.8 10477.7 17:32:14 INFO - PROCESS | 12095 | 17:32:14 INFO - PROCESS | 12095 | [#3] mootools.html Cycles:180 Average:5328.76 Median:6396.17 stddev:2800.99 (43.8%) stddev-sans-first:2792.49 17:32:14 INFO - PROCESS | 12095 | Values: 1302.0 1402.9 1424.4 1567.9 1765.9 6761.6 7281.4 7451.4 7452.3 7452.4 7351.2 7531.0 7540.1 7547.2 7553.4 1902.3 1946.8 1954.2 2145.0 2165.7 2194.7 2257.5 2259.1 2259.6 2263.7 2143.8 2193.9 2196.8 2198.1 2214.8 2175.3 2178.8 2181.8 2188.8 2190.0 2104.5 2142.3 2146.0 2150.6 2150.7 7650.1 7690.3 7704.6 7706.1 7710.8 4515.9 4619.3 4627.5 4636.0 4654.0 3045.3 3069.0 3173.6 3185.8 3188.5 918.3 977.9 984.1 995.9 1030.6 10764.8 10811.4 10815.8 10827.3 10835.9 4190.2 4286.0 4311.9 4313.1 4316.8 9040.2 9121.8 9128.9 9134.7 9140.0 4592.7 4617.6 4653.4 4654.1 4654.9 3548.5 3967.7 4098.8 4191.5 4197.6 3464.2 3516.9 3536.6 3557.1 3564.1 1140.6 1142.6 1147.4 1154.8 1167.9 960.2 999.2 1161.5 1173.1 1185.7 6875.4 6905.7 6913.2 6927.9 6942.2 1089.7 1097.9 1098.1 1117.6 1130.3 5649.5 5688.2 5742.2 5753.3 5764.1 8943.4 9676.2 9687.5 9713.7 9721.7 9407.4 9418.2 9476.2 9495.9 9533.0 7071.4 7360.5 7382.1 7396.7 7479.2 6908.2 6975.0 6988.7 6996.5 7002.4 7952.9 7987.8 8119.4 8120.7 8155.3 8251.6 8286.7 8327.5 8408.1 8419.1 5971.1 6166.6 6167.8 6417.6 6625.8 6710.9 6993.6 7138.8 7168.1 7175.3 6414.8 6590.9 6616.5 6637.8 6675.6 6585.8 6610.0 6702.9 6712.6 6749.6 6860.3 6884.6 6902.2 6905.5 6917.0 6320.1 6429.4 6450.8 6459.5 6466.1 6367.8 6370.9 6393.3 6399.1 6399.2 17:32:14 INFO - PROCESS | 12095 | 17:32:14 INFO - PROCESS | 12095 | [#4] prototype.html Cycles:180 Average:4683.97 Median:5411.38 stddev:1393.15 (25.7%) stddev-sans-first:1357.93 17:32:14 INFO - PROCESS | 12095 | Values: 315.8 316.2 318.3 321.1 323.1 5254.3 5413.4 5427.8 5449.6 5463.3 5252.7 5399.8 5404.6 5407.7 5409.4 3945.4 4042.1 4126.9 4127.8 4158.7 4149.2 4153.4 4153.5 4158.1 4159.5 4107.9 4111.9 4112.6 4116.5 4119.7 3906.9 3994.1 3998.6 4008.1 4118.6 3435.2 3468.3 3493.6 3508.2 3513.3 5096.6 5113.6 5115.3 5118.4 5121.7 4657.9 4660.5 4666.0 4667.0 4678.3 5600.8 5602.4 5613.5 5619.2 5621.9 3848.0 3849.2 3851.3 3851.8 3858.4 5771.9 5890.8 5972.0 5989.8 6003.1 4003.4 4010.5 4036.2 4039.7 4047.0 4094.0 4097.3 4098.8 4099.3 4102.7 4708.7 4710.6 4711.1 4711.8 4720.1 5662.4 5671.9 5674.6 5681.3 5681.3 1421.6 1447.9 1448.1 1450.8 1451.2 940.8 952.3 960.8 967.2 973.6 4803.9 4900.5 4906.0 4907.3 4958.3 5858.7 5956.9 5970.0 5974.6 5974.7 5044.4 5055.0 5067.9 5069.5 5070.0 3144.3 3165.1 3177.3 3178.6 3180.8 5526.4 5581.7 5590.2 5591.6 5594.1 5896.5 6084.1 6085.5 6090.0 6096.3 5499.6 5519.3 5581.4 5585.8 5588.4 5916.3 5938.8 5941.6 5942.9 5955.5 5749.7 5753.3 5759.7 5767.1 5770.0 5505.5 5549.8 5555.5 5560.1 5565.1 3978.5 4124.3 4166.9 4175.2 4177.7 5829.8 5846.2 5847.5 5853.1 5854.6 5646.6 5672.1 5675.2 5676.4 5679.5 5663.7 5669.4 5677.7 5679.1 5679.4 5573.7 5575.4 5577.6 5585.5 5586.4 5494.1 5683.3 5693.9 5693.9 5703.9 5504.9 5545.7 5546.2 5548.9 5640.6 17:32:14 INFO - PROCESS | 12095 | 17:32:14 INFO - PROCESS | 12095 | [#5] yui.html Cycles:180 Average:12300.11 Median:40786.18 stddev:13498.96 (33.1%) stddev-sans-first:13508.76 17:32:14 INFO - PROCESS | 12095 | Values: 708.6 787.5 792.3 795.9 800.4 12566.0 12879.7 12918.0 12925.6 12929.6 12129.3 12157.7 12239.0 12249.0 12275.4 642.7 797.8 804.9 813.1 819.0 807.4 815.4 816.3 819.3 820.2 852.8 854.9 855.1 855.6 856.2 688.7 840.9 858.4 859.2 860.8 630.8 631.0 631.2 631.4 631.6 12247.4 12297.8 12309.8 12316.8 12317.9 12062.7 12475.6 12499.9 12562.4 12607.5 9715.0 9870.8 9898.5 10069.3 10108.4 3361.2 3382.2 3416.5 3451.1 3501.7 39924.8 39934.6 40376.6 40489.6 40605.2 9676.7 9782.2 9837.9 9871.9 10080.5 17725.7 17759.6 17774.6 17993.6 18010.6 5850.9 5960.0 6015.6 6241.0 6253.4 3549.2 3614.4 3666.1 3723.4 3739.1 2910.0 2911.5 2913.0 2924.1 2927.0 488.2 488.6 495.1 507.0 508.4 479.6 501.4 557.7 576.2 621.6 8118.4 8123.4 8299.2 8405.0 8560.1 528.6 572.4 612.8 619.1 624.6 3833.9 3848.6 3857.1 3921.2 3921.4 47024.1 51471.5 52834.5 52996.7 53017.5 40967.2 41415.2 41870.8 41949.2 42081.6 38842.2 38935.2 38970.5 38992.8 39261.0 7556.5 7570.1 7584.4 7650.6 8241.3 29042.0 29804.9 30988.2 31105.2 31312.0 34525.1 36843.4 37832.4 38196.4 38809.0 9890.9 10068.1 10131.7 10169.3 10428.6 9350.8 11434.5 11434.6 11970.0 12164.2 10797.1 10921.6 10938.5 10951.8 11277.4 10840.2 10943.8 11057.9 11074.3 11328.7 10956.7 10957.7 11040.4 11071.9 11072.2 9025.5 9089.3 9215.7 9747.9 9863.4 8795.1 9213.9 9219.2 9226.7 9424.8 17:32:14 INFO - PROCESS | 12095 | -------- Summary: end -------- 17:32:14 INFO - PROCESS | 12095 | 17:32:15 INFO - TEST-INFO | 12095: exit 0 17:32:15 INFO - TEST-OK | dromaeo_css | took 1117401ms 17:32:15 INFO - TEST-START | kraken 17:32:15 INFO - operating with platform_type : linux_ 17:32:15 INFO - Initialising browser for kraken test... 17:32:15 INFO - TEST-INFO | started process 12273 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzDeOtL/profile http://localhost:44267/getInfo.html) 17:32:19 INFO - PROCESS | 12273 | __metrics Screen width/height:1600/1200 17:32:19 INFO - PROCESS | 12273 | colorDepth:24 17:32:19 INFO - PROCESS | 12273 | Browser inner width/height: 1024/697 17:32:19 INFO - PROCESS | 12273 | __metrics 17:32:20 ERROR - PROCESS | 12273 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 17:32:21 INFO - TEST-INFO | 12273: exit 0 17:32:21 INFO - Browser initialized. 17:32:21 INFO - Running cycle 1/1 for kraken test... 17:32:21 INFO - TEST-INFO | started process 12354 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzDeOtL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:32:33 INFO - PROCESS | 12354 | RSS: Main: 155070464 17:32:33 INFO - PROCESS | 12354 | 17:32:36 INFO - PROCESS | 12354 | Cycle 1(1): loaded http://localhost:44267/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44267/tests/kraken/driver.html?testName=audio-beat-detection) 17:32:37 INFO - PROCESS | 12354 | RSS: Main: 195485696 17:32:37 INFO - PROCESS | 12354 | 17:32:39 INFO - PROCESS | 12354 | Cycle 1(1): loaded http://localhost:44267/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44267/tests/kraken/driver.html?testName=audio-dft) 17:32:40 INFO - PROCESS | 12354 | RSS: Main: 185384960 17:32:40 INFO - PROCESS | 12354 | 17:32:43 INFO - PROCESS | 12354 | Cycle 1(1): loaded http://localhost:44267/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44267/tests/kraken/driver.html?testName=audio-fft) 17:32:44 INFO - PROCESS | 12354 | RSS: Main: 171405312 17:32:44 INFO - PROCESS | 12354 | 17:32:46 INFO - PROCESS | 12354 | Cycle 1(1): loaded http://localhost:44267/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44267/tests/kraken/driver.html?testName=audio-oscillator) 17:32:46 INFO - PROCESS | 12354 | RSS: Main: 172093440 17:32:46 INFO - PROCESS | 12354 | 17:32:49 INFO - PROCESS | 12354 | Cycle 1(1): loaded http://localhost:44267/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44267/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:32:49 INFO - PROCESS | 12354 | RSS: Main: 173596672 17:32:49 INFO - PROCESS | 12354 | 17:32:52 INFO - PROCESS | 12354 | Cycle 1(1): loaded http://localhost:44267/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44267/tests/kraken/driver.html?testName=imaging-darkroom) 17:32:53 INFO - PROCESS | 12354 | RSS: Main: 173936640 17:32:53 INFO - PROCESS | 12354 | 17:32:56 INFO - PROCESS | 12354 | Cycle 1(1): loaded http://localhost:44267/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44267/tests/kraken/driver.html?testName=imaging-desaturate) 17:32:57 INFO - PROCESS | 12354 | RSS: Main: 174518272 17:32:57 INFO - PROCESS | 12354 | 17:33:00 INFO - PROCESS | 12354 | Cycle 1(1): loaded http://localhost:44267/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44267/tests/kraken/driver.html?testName=json-parse-financial) 17:33:00 INFO - PROCESS | 12354 | RSS: Main: 173797376 17:33:00 INFO - PROCESS | 12354 | 17:33:02 INFO - PROCESS | 12354 | Cycle 1(1): loaded http://localhost:44267/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44267/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:33:03 INFO - PROCESS | 12354 | RSS: Main: 184872960 17:33:03 INFO - PROCESS | 12354 | 17:33:04 INFO - PROCESS | 12354 | Cycle 1(1): loaded http://localhost:44267/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44267/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:33:05 INFO - PROCESS | 12354 | RSS: Main: 183955456 17:33:05 INFO - PROCESS | 12354 | 17:33:07 INFO - PROCESS | 12354 | Cycle 1(1): loaded http://localhost:44267/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44267/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:33:08 INFO - PROCESS | 12354 | RSS: Main: 196050944 17:33:08 INFO - PROCESS | 12354 | 17:33:10 INFO - PROCESS | 12354 | Cycle 1(1): loaded http://localhost:44267/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:33:11 INFO - PROCESS | 12354 | RSS: Main: 199426048 17:33:11 INFO - PROCESS | 12354 | 17:33:13 INFO - PROCESS | 12354 | Cycle 1(1): loaded http://localhost:44267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:33:14 INFO - PROCESS | 12354 | RSS: Main: 199831552 17:33:14 INFO - PROCESS | 12354 | 17:33:16 INFO - PROCESS | 12354 | Cycle 1(1): loaded http://localhost:44267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44267/tests/kraken/driver.html?testName=ai-astar) 17:33:16 INFO - PROCESS | 12354 | RSS: Main: 261062656 17:33:16 INFO - PROCESS | 12354 | 17:33:16 INFO - PROCESS | 12354 | __start_tp_report 17:33:16 INFO - PROCESS | 12354 | _x_x_mozilla_page_load 17:33:16 INFO - PROCESS | 12354 | _x_x_mozilla_page_load_details 17:33:16 INFO - PROCESS | 12354 | |i|pagename|runs| 17:33:16 INFO - PROCESS | 12354 | |0;ai-astar;113;115;110;113;114;114;102;114;114;115 17:33:16 INFO - PROCESS | 12354 | |1;audio-beat-detection;164;135;158;174;133;161;155;133;184;137 17:33:16 INFO - PROCESS | 12354 | |2;audio-dft;161;161;160;160;160;161;165;164;161;161 17:33:16 INFO - PROCESS | 12354 | |3;audio-fft;74;75;128;95;74;73;76;116;100;74 17:33:16 INFO - PROCESS | 12354 | |4;audio-oscillator;95;95;141;93;93;95;137;94;94;140 17:33:16 INFO - PROCESS | 12354 | |5;imaging-gaussian-blur;117;117;117;117;118;118;118;117;118;117 17:33:16 INFO - PROCESS | 12354 | |6;imaging-darkroom;146;146;146;146;145;145;146;146;147;145 17:33:16 INFO - PROCESS | 12354 | |7;imaging-desaturate;95;95;96;95;95;95;96;96;96;95 17:33:16 INFO - PROCESS | 12354 | |8;json-parse-financial;66;66;68;65;64;66;66;74;63;64 17:33:16 INFO - PROCESS | 12354 | |9;json-stringify-tinderbox;63;63;74;63;64;65;65;64;63;64 17:33:16 INFO - PROCESS | 12354 | |10;stanford-crypto-aes;82;83;84;84;85;84;84;84;85;84 17:33:16 INFO - PROCESS | 12354 | |11;stanford-crypto-ccm;130;125;119;124;128;123;120;122;119;120 17:33:16 INFO - PROCESS | 12354 | |12;stanford-crypto-pbkdf2;146;135;147;146;146;134;145;146;147;145 17:33:16 INFO - PROCESS | 12354 | |13;stanford-crypto-sha256-iterative;70;69;72;69;71;69;70;71;69;68 17:33:16 INFO - PROCESS | 12354 | __end_tp_report 17:33:16 INFO - PROCESS | 12354 | __start_cc_report 17:33:16 INFO - PROCESS | 12354 | _x_x_mozilla_cycle_collect,1192 17:33:16 INFO - PROCESS | 12354 | __end_cc_report 17:33:16 INFO - PROCESS | 12354 | __startTimestamp1459557196562__endTimestamp 17:33:16 INFO - PROCESS | 12354 | 17:33:16 INFO - PROCESS | 12354 | ------- Summary: start ------- 17:33:16 INFO - PROCESS | 12354 | Number of tests: 14 17:33:16 INFO - PROCESS | 12354 | 17:33:16 INFO - PROCESS | 12354 | [#0] ai-astar Cycles:10 Average:112.40 Median:114.00 stddev:3.92 (3.4%) stddev-sans-first:4.15 17:33:16 INFO - PROCESS | 12354 | Values: 113.0 115.0 110.0 113.0 114.0 114.0 102.0 114.0 114.0 115.0 17:33:16 INFO - PROCESS | 12354 | 17:33:16 INFO - PROCESS | 12354 | [#1] audio-beat-detection Cycles:10 Average:153.40 Median:159.50 stddev:18.24 (11.4%) stddev-sans-first:18.94 17:33:16 INFO - PROCESS | 12354 | Values: 164.0 135.0 158.0 174.0 133.0 161.0 155.0 133.0 184.0 137.0 17:33:16 INFO - PROCESS | 12354 | 17:33:16 INFO - PROCESS | 12354 | [#2] audio-dft Cycles:10 Average:161.40 Median:161.00 stddev:1.71 (1.1%) stddev-sans-first:1.81 17:33:16 INFO - PROCESS | 12354 | Values: 161.0 161.0 160.0 160.0 160.0 161.0 165.0 164.0 161.0 161.0 17:33:16 INFO - PROCESS | 12354 | 17:33:16 INFO - PROCESS | 12354 | [#3] audio-fft Cycles:10 Average:88.50 Median:74.00 stddev:20.28 (27.4%) stddev-sans-first:20.82 17:33:16 INFO - PROCESS | 12354 | Values: 74.0 75.0 128.0 95.0 74.0 73.0 76.0 116.0 100.0 74.0 17:33:16 INFO - PROCESS | 12354 | 17:33:16 INFO - PROCESS | 12354 | [#4] audio-oscillator Cycles:10 Average:107.70 Median:94.00 stddev:21.86 (23.3%) stddev-sans-first:22.70 17:33:16 INFO - PROCESS | 12354 | Values: 95.0 95.0 141.0 93.0 93.0 95.0 137.0 94.0 94.0 140.0 17:33:16 INFO - PROCESS | 12354 | 17:33:16 INFO - PROCESS | 12354 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 17:33:16 INFO - PROCESS | 12354 | Values: 117.0 117.0 117.0 117.0 118.0 118.0 118.0 117.0 118.0 117.0 17:33:16 INFO - PROCESS | 12354 | 17:33:16 INFO - PROCESS | 12354 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 17:33:16 INFO - PROCESS | 12354 | Values: 146.0 146.0 146.0 146.0 145.0 145.0 146.0 146.0 147.0 145.0 17:33:16 INFO - PROCESS | 12354 | 17:33:16 INFO - PROCESS | 12354 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 17:33:16 INFO - PROCESS | 12354 | Values: 95.0 95.0 96.0 95.0 95.0 95.0 96.0 96.0 96.0 95.0 17:33:16 INFO - PROCESS | 12354 | 17:33:16 INFO - PROCESS | 12354 | [#8] json-parse-financial Cycles:10 Average:66.20 Median:66.00 stddev:3.08 (4.7%) stddev-sans-first:3.27 17:33:16 INFO - PROCESS | 12354 | Values: 66.0 66.0 68.0 65.0 64.0 66.0 66.0 74.0 63.0 64.0 17:33:16 INFO - PROCESS | 12354 | 17:33:16 INFO - PROCESS | 12354 | [#9] json-stringify-tinderbox Cycles:10 Average:64.80 Median:64.00 stddev:3.33 (5.2%) stddev-sans-first:3.46 17:33:16 INFO - PROCESS | 12354 | Values: 63.0 63.0 74.0 63.0 64.0 65.0 65.0 64.0 63.0 64.0 17:33:16 INFO - PROCESS | 12354 | 17:33:16 INFO - PROCESS | 12354 | [#10] stanford-crypto-aes Cycles:10 Average:83.90 Median:84.00 stddev:0.88 (1.0%) stddev-sans-first:0.60 17:33:16 INFO - PROCESS | 12354 | Values: 82.0 83.0 84.0 84.0 85.0 84.0 84.0 84.0 85.0 84.0 17:33:16 INFO - PROCESS | 12354 | 17:33:16 INFO - PROCESS | 12354 | [#11] stanford-crypto-ccm Cycles:10 Average:123.00 Median:123.50 stddev:3.80 (3.1%) stddev-sans-first:3.07 17:33:16 INFO - PROCESS | 12354 | Values: 130.0 125.0 119.0 124.0 128.0 123.0 120.0 122.0 119.0 120.0 17:33:16 INFO - PROCESS | 12354 | 17:33:16 INFO - PROCESS | 12354 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.70 Median:146.00 stddev:4.90 (3.4%) stddev-sans-first:5.13 17:33:16 INFO - PROCESS | 12354 | Values: 146.0 135.0 147.0 146.0 146.0 134.0 145.0 146.0 147.0 145.0 17:33:16 INFO - PROCESS | 12354 | 17:33:16 INFO - PROCESS | 12354 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.80 Median:70.00 stddev:1.23 (1.8%) stddev-sans-first:1.30 17:33:16 INFO - PROCESS | 12354 | Values: 70.0 69.0 72.0 69.0 71.0 69.0 70.0 71.0 69.0 68.0 17:33:16 INFO - PROCESS | 12354 | -------- Summary: end -------- 17:33:16 INFO - PROCESS | 12354 | 17:33:17 INFO - TEST-INFO | 12354: exit 0 17:33:17 INFO - TEST-OK | kraken | took 62482ms 17:33:17 INFO - SUITE-END | took 1179s 17:33:17 INFO - Completed test suite (00:19:39) 17:33:17 INFO - javascript benchmark 17:33:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2639.1027050802722, 2740.520408928437, 2745.0, 2753.3804893898873, 2781.6662000559936, 4629.953700462995, 4700.670953033289, 4720.622350211984, 4722.834700785474, 4738.407699037621, 4589.128065667521, 4593.15026720057, 4640.141573808848, 4675.555822196894, 4704.38842950416, 4262.1049579588325, 4268.573142685722, 4282.7858607069675, 4317.395564620955, 4460.018795864905, 4386.780660966955, 4398.318260669601, 4410.867673969786, 4455.064436468346, 4472.284434490482, 4179.373094035919, 4276.059266961294, 4286.849960251377, 4353.303471444586, 4361.6510679145595, 4299.054208074219, 4303.763293018883, 4336.349547567858, 4351.97824010878, 4368.213721530124, 4272.786360681985, 4285.635720963722, 4292.399064131024, 4310.590493903074, 4336.392904993303, 4499.955000449986, 4546.204414227497, 4569.794359253841, 4613.838515651936, 4622.306654001893, 4993.051320249141, 4994.450610432849, 4999.575036121934, 5004.224345226496, 5020.598352131858, 5031.0, 5035.043341765089, 5046.697198168122, 5047.520485553867, 5094.872628184325, 4580.7938642761155, 4677.672562920631, 4678.368420263289, 4746.620270378361, 4754.738489383048, 5148.6910785353, 5161.793528258902, 5162.483751624883, 5181.948180518147, 5182.948170518322, 4962.379702537183, 4965.726885021359, 4966.130927087817, 4966.726830024383, 5021.6735912165595, 4962.454130045692, 4970.652054356233, 5018.4981501849525, 5058.1654027085115, 5070.467600901926, 4897.681650692693, 4919.581835543947, 4921.114199444134, 4936.062148191832, 4967.801287948441, 4783.425988881357, 4904.411470623548, 4906.165951788204, 4907.950920490821, 4961.280614310905, 4164.937525937114, 4213.768242746678, 4225.133847561243, 4226.2392769301205, 4238.554951730086, 3723.9945214791856, 3729.4965179700393, 3736.0286325555553, 3746.550413950343, 3780.2061567070673, 4287.121140166259, 4362.781860906942, 4371.737695738266, 4376.496702879146, 4420.0, 4908.950910490921, 5050.823221187315, 5052.621053421009, 5106.693598384109, 5107.463716309809, 4297.119090586422, 4298.312270036779, 4317.805698743564, 4326.65386769064, 4335.718178318462, 4428.800703968329, 4435.933460998088, 4469.396631454777, 4471.619912307425, 4475.4181956345465, 4761.095391875532, 4762.547557982125, 4765.5949244314625, 4788.209945359046, 4815.855524334345, 5051.166557517969, 5056.216286475602, 5057.115004874206, 5058.443571207091, 5072.442031376472, 4627.398438203012, 4674.6260299176665, 4751.973336260557, 4775.068861572099, 4814.085323788469, 4931.358923340086, 4945.4312754033745, 4949.579285760607, 4952.306677065286, 4978.7510624467905, 5007.524285192901, 5007.624428167975, 5007.69953802773, 5014.0, 5045.772940217626, 4795.496472870298, 4872.244802055687, 4917.188663870421, 4946.777395017305, 4956.0, 4847.515248475124, 4855.0, 4866.6350023747655, 4871.391076115486, 4925.8029678812445, 4803.615710743202, 4810.518948105161, 4810.903781924272, 4810.975945120392, 4865.878353041061, 4730.692504987165, 4802.471728109975, 4848.80604775805, 4929.457759646364, 4934.679245849008, 4742.976285118552, 4770.666053376369, 4806.7836947336755, 4817.229243321051, 4824.565789079], "unit": "score", "name": "dojo.html", "value": 4606.2721032741465}, {"lowerIsBetter": false, "replicates": [526.2211926349004, 528.7594144664179, 534.5883669574426, 546.1371033766649, 553.6124712701105, 26944.730552694466, 34123.0, 34779.65220347793, 34837.0, 34872.3025539489, 37175.0, 37963.43054854179, 38031.0, 38054.80972595133, 38111.42832857509, 7578.962105189494, 7766.262205090507, 7768.883466748003, 7769.533827970312, 7770.650320735552, 7686.615669216545, 7817.452778305521, 7820.569868657221, 7821.4133939954445, 7987.520748755093, 7948.841023179533, 8022.959885200566, 8029.437939344249, 8032.598370081501, 8033.397495187855, 7893.644785984645, 7949.920500795034, 7964.084130325029, 7965.283124518821, 7967.44227904047, 7884.408669349822, 7929.722459713882, 7952.20477952206, 8015.118336982927, 8015.4389192756535, 37467.62532374669, 37821.62178378209, 37957.0, 38099.80950095259, 38106.61893381058, 3342.2145795737983, 3369.696727294531, 3389.322135572895, 3477.7565570410084, 3690.815459227028, 28632.856835715895, 28792.42415151685, 28862.422751545062, 28963.56554651682, 29677.851610742026, 3334.283129127249, 3409.1136304560746, 3441.15691655546, 3462.221000274918, 3498.755087143901, 170329.0, 171938.0, 172424.99999999875, 172676.0, 173020.13489932596, 41152.794236028625, 42591.36112958308, 42649.78675106604, 54874.72562637241, 55306.0, 40734.0, 40753.184936301106, 40844.18311633751, 40868.79565602153, 40938.795306023276, 14324.068935519366, 14574.19841908684, 14575.85424145745, 14576.271186440636, 14582.781258281135, 11186.496607652674, 11233.213675042669, 11239.100871930226, 11244.325340479598, 11281.830772538418, 14599.124052556881, 14626.195559244345, 14774.704505909822, 14798.112113273239, 14859.331330090172, 5600.887982240414, 5725.914111288334, 5726.656400615976, 5810.941890581124, 5895.263092113486, 883.3066043156092, 894.6779159502574, 972.7665360313474, 1007.2143727892255, 1061.3737894642045, 27076.458470830472, 27500.58749118765, 27730.306742331602, 27875.721242787313, 27911.0, 989.8366769482955, 1061.2040969273046, 1065.3820783945293, 1068.5084860963889, 1093.2729734726317, 13739.381727822272, 14290.356933937997, 14475.92762036183, 14562.63593410152, 14584.052036617586, 283604.0, 287623.0, 288026.0, 289972.0, 291572.0, 47978.0, 48706.75646621744, 48721.0, 48729.75635121802, 48816.26775598369, 1048.8741351037772, 1153.5501154549731, 1214.574898785418, 1241.5530409052733, 1258.6853286678331, 25005.0, 25056.997720090993, 25072.874635626704, 25079.373015674755, 25094.49811003806, 32857.0, 33267.0, 33291.83354083214, 34002.31995360128, 34058.82970585131, 193668.0, 195893.0, 196126.0, 196266.0, 196429.0, 30963.0, 32382.352352952337, 32677.18307042343, 32904.67095329016, 32918.50622240716, 39789.40315895322, 41175.0, 41182.38226426546, 41591.58408415998, 41869.69716665613, 34814.12964675904, 35321.646783532866, 35394.8230258847, 35482.822585886905, 35956.820215898755, 34379.82810085933, 34712.65287347094, 34886.476702849985, 35123.47314790229, 35233.82383088068, 28868.71131288744, 29507.262318441353, 31850.840745796122, 32022.35955280928, 34238.315233695685, 24670.629940551265, 25625.49197397431, 29350.853245733633, 29492.410151797274, 29900.70099298979, 23677.526449471257, 23986.640200396658, 24065.639015414432, 24454.51090978206, 24475.51048979046], "unit": "score", "name": "ext.html", "value": 16334.878949658101}, {"lowerIsBetter": false, "replicates": [354.40813840885716, 355.87722235828636, 360.4719086538221, 364.0, 369.65252662497267, 15310.311036003379, 15733.685326293482, 17176.914115429438, 17600.64798704025, 17602.735958960628, 16086.5978350541, 16594.83405165948, 16678.0, 16697.165141742895, 16718.916405417956, 4960.578350840183, 5111.258867464216, 5295.8146464873735, 5862.149988251722, 5862.560307976897, 5882.617629854067, 5916.083007133901, 5934.406559344053, 5943.167956486095, 5983.700814959257, 5839.357670656224, 5842.620229685057, 5878.647281163123, 5908.350081491032, 6043.637381757087, 5950.285965684124, 5978.312494063195, 5984.072468767348, 5992.580519363646, 6009.248843894513, 5104.795808167669, 5182.300389447414, 5230.241614965847, 5240.554552863011, 5251.737413129328, 19174.808251917442, 19824.900875495674, 19873.20507179711, 19884.502887427785, 19885.50286242841, 2000.1799262302386, 2053.7330147080934, 2057.1154403606442, 2330.697009388786, 2486.676732024843, 8465.280451161658, 8813.559322033872, 9015.504147271897, 9082.45505269686, 12941.417636206394, 1690.6618676264795, 1743.3985275080076, 1755.183839514619, 1782.4830799068384, 1817.2367605605677, 55992.720036399965, 58065.838683226524, 58291.41708582902, 58526.70736646289, 59791.402085979455, 9406.623735050658, 9472.763180920394, 9496.382735122195, 9570.33007689455, 9767.169790567881, 13035.15271507349, 13115.868841311656, 13119.737605247841, 13144.737105257842, 13187.802182967263, 7033.296670332926, 7068.0, 7135.5361901476235, 7202.495825292284, 7306.926930730731, 6670.666466676646, 6916.619585922823, 6988.44092472601, 7038.542494737826, 7081.398081163159, 4074.633283004544, 4102.548719640837, 4136.0, 4180.7909604519655, 4198.6221240088535, 1683.8063622683549, 1775.6715007723353, 1782.6702060118919, 1789.0786245083793, 1792.1666425112126, 805.963731632078, 874.6413970272158, 881.2685471059006, 892.7009451833709, 939.9848163982882, 16083.437079702155, 16197.919010405109, 16245.593860153354, 16318.428854990256, 16537.255823487973, 867.2065060469725, 872.3326655108847, 873.0876234335135, 881.4182639457927, 908.7546362482093, 7655.961720191475, 9385.343025988252, 9400.435973841591, 9426.717198484057, 9485.762855928657, 365462.0, 369737.0, 371932.0, 375855.1207244001, 376487.0, 41717.0, 59005.10637447375, 60351.69824150939, 69575.65212174007, 70660.29339706537, 927.8051609162152, 937.840567103594, 939.9389039712397, 959.5921733263475, 960.7261930349816, 14826.40694372213, 14959.476418325741, 15186.46847360337, 15210.46763363277, 15293.847061529243, 21610.13559457667, 30092.398152037276, 30712.84643576768, 31256.374872502878, 33682.98951031473, 39971.60028399679, 41890.79054604707, 42128.10423530887, 42137.57862421337, 43602.56397435985, 7221.133463984355, 7236.565806051653, 7245.7826265212125, 7441.665125069493, 7491.475596708178, 9826.606935722491, 11344.546218151181, 11562.76874462523, 11720.88279117198, 11755.000824929977, 6976.895346569907, 10160.847587286344, 10165.949170254396, 10469.738256543647, 10508.581341519102, 9188.862167067633, 10176.18590512772, 10264.230182736474, 10341.069303762697, 10394.688159355232, 8895.0, 9496.19282361007, 10026.298159128792, 10651.30766500175, 10657.786844262917, 7380.0, 7432.442566807619, 7488.700451981859, 7576.6969321228735, 7608.80977975555, 9206.907930920604, 10149.23880708935, 10314.27800053989, 10344.844827327746, 10477.68566942993], "unit": "score", "name": "jquery.html", "value": 7991.063956098049}, {"lowerIsBetter": false, "replicates": [1302.042998396178, 1402.859714028597, 1424.3946322812806, 1567.929443175057, 1765.9205335759889, 6761.594304341743, 7281.417486601073, 7451.366633836124, 7452.292032256927, 7452.403807695385, 7351.228121047293, 7530.983317252169, 7540.095188577378, 7547.207543207966, 7553.395728341719, 1902.286642509059, 1946.844252459807, 1954.2085455390518, 2145.0454547726267, 2165.7401111866598, 2194.659827726697, 2257.548490301938, 2259.1302348595827, 2259.649754288088, 2263.7396699379533, 2143.807057364837, 2193.934181974543, 2196.8132708719777, 2198.1097655449566, 2214.7563767985507, 2175.282156888231, 2178.771229020954, 2181.8472706910525, 2188.7701791311842, 2190.047329411711, 2104.4844013216707, 2142.335875878467, 2145.967810482844, 2150.602138604363, 2150.6773983902385, 7650.120236172856, 7690.307872291521, 7704.614769261514, 7706.075270967463, 7710.807229819244, 4515.864524064284, 4619.330197121399, 4627.467841198271, 4635.976820115878, 4654.022655242369, 3045.345250771095, 3069.0, 3173.6032995875516, 3185.824779637119, 3188.505781603832, 918.3112665500875, 977.8973207813219, 984.1241295247236, 995.9004099590055, 1030.6032177611598, 10764.784704305948, 10811.405372704497, 10815.837762433648, 10827.296225745302, 10835.891641083646, 4190.20386126635, 4285.957140428618, 4311.892202694895, 4313.094250207429, 4316.784160792011, 9040.231580315747, 9121.81756364869, 9128.863067053999, 9134.680286189952, 9139.954300228455, 4592.6555508337005, 4617.561331673485, 4653.441587009581, 4654.115718013567, 4654.906901862011, 3548.520949671761, 3967.682585393162, 4098.7950602469755, 4191.476065491814, 4197.601227883346, 3464.2378676691087, 3516.929661406809, 3536.5932917714276, 3557.0751604582993, 3564.0733409313766, 1140.6121918547733, 1142.5772464188303, 1147.4148184426003, 1154.7979103656826, 1167.8773728758529, 960.2318145483586, 999.2106236073421, 1161.4657257661402, 1173.1318824070297, 1185.6798664360574, 6875.449964002868, 6905.723771049102, 6913.2049814270995, 6927.896081558781, 6942.1669399671355, 1089.7330154112135, 1097.9341239525654, 1098.0556721219746, 1117.6255954255253, 1130.2596799096605, 5649.519790817744, 5688.23208866806, 5742.224799652077, 5753.309602847685, 5764.13537969308, 8943.418677785923, 9676.177524910461, 9687.51562421876, 9713.660021899199, 9721.70834874955, 9407.43555386679, 9418.15236628693, 9476.194523465445, 9495.857562136573, 9533.0, 7071.36357727807, 7360.521566098294, 7382.114146302478, 7396.704131834666, 7479.214682458263, 6908.2400935896, 6974.965125174342, 6988.685509151998, 6996.510244282851, 7002.3697867192195, 7952.880706789287, 7987.760367188761, 8119.431639785158, 8120.715774947848, 8155.306798922158, 8251.587420629065, 8286.70996515119, 8327.541985190872, 8408.075111737582, 8419.073901870912, 5971.0744834550715, 6166.568340216142, 6167.84580385494, 6417.582857114273, 6625.801225963229, 6710.899336509859, 6993.615351155735, 7138.750143744944, 7168.068151140318, 7175.282471752783, 6414.807555773335, 6590.868182636224, 6616.503762217757, 6637.767678131242, 6675.566088204251, 6585.835354116185, 6610.041543976, 6702.932970670426, 6712.630805305755, 6749.561278517077, 6860.313968603299, 6884.586924784529, 6902.240753517009, 6905.516613836983, 6916.965415172892, 6320.051992201206, 6429.38920802523, 6450.774222902176, 6459.4832413405875, 6466.0947467355545, 6367.808965731036, 6370.90443643355, 6393.264774550986, 6399.072134540559, 6399.200099987502], "unit": "score", "name": "mootools.html", "value": 4362.976569951829}, {"lowerIsBetter": false, "replicates": [315.760022382989, 316.1826678037273, 318.2759222768203, 321.13454240821, 323.1275555998803, 5254.290670759447, 5413.350397952247, 5427.755750991205, 5449.618526703128, 5463.31708536433, 5252.737363131847, 5399.811006614769, 5404.594655400851, 5407.675539467635, 5409.404965453797, 3945.447637330776, 4042.090529630839, 4126.8761937141935, 4127.834886604533, 4158.708890377675, 4149.190907772985, 4153.356229784388, 4153.480814898137, 4158.147579746144, 4159.542450330461, 4107.917841643165, 4111.876643700693, 4112.609302116294, 4116.464859568267, 4119.691023173259, 3906.8632597859223, 3994.0613955720382, 3998.5801490843332, 4008.0581063450068, 4118.567550407209, 3435.2442462658173, 3468.3063387322636, 3493.6331685172945, 3508.1755787389943, 3513.2622149348667, 5096.61775366849, 5113.642045056848, 5115.258287548285, 5118.360204974379, 5121.692698438105, 4657.930131048037, 4660.464046634613, 4665.976670116627, 4666.953330466686, 4678.274867395559, 5600.775968961237, 5602.439756024406, 5613.522850557708, 5619.241402410663, 5621.8594535136535, 3847.961520384816, 3849.21091176311, 3851.306764782338, 3851.8074096295354, 3858.3826587745825, 5771.855703607402, 5890.823275301705, 5971.970140149315, 5989.8203053908455, 6003.069524223796, 4003.4395184674167, 4010.4585880905706, 4036.2442337582656, 4039.6970227233073, 4046.959530404717, 4093.9590604094174, 4097.282975479339, 4098.754074755524, 4099.344104943195, 4102.692298077656, 4708.670393072452, 4710.552497512731, 4711.057788442326, 4711.764411779397, 4720.12677654635, 5662.37713851476, 5671.943280567224, 5674.631148975303, 5681.318241811009, 5681.346645135863, 1421.6374824419913, 1447.9348429320705, 1448.0515262503077, 1450.7751298548742, 1451.151076620189, 940.8071345374182, 952.2905435450633, 960.7742180587557, 967.1778987860403, 973.561897146287, 4803.879903002383, 4900.534449227318, 4905.950940490621, 4907.312976183337, 4958.330625365602, 5858.707064646751, 5956.940430595725, 5969.970150149222, 5974.581779275409, 5974.731137098841, 5044.419891712427, 5055.0, 5067.8986420271385, 5069.543741063322, 5070.01134778722, 3144.2768163322107, 3165.1454107390878, 3177.253345463814, 3178.570892929471, 3180.777345585787, 5526.447355264441, 5581.720913954286, 5590.161475778585, 5591.580631452657, 5594.13290939905, 5896.528277737771, 6084.117802918552, 6085.482733967662, 6089.969550152309, 6096.268447786294, 5499.615026948075, 5519.31008623922, 5581.441855814386, 5585.832425027255, 5588.413216612278, 5916.349201587908, 5938.8218353449465, 5941.613795103304, 5942.940570594239, 5955.493783028491, 5749.7125143741805, 5753.338366087954, 5759.65442073477, 5767.134929760402, 5770.047942089508, 5505.467484956965, 5549.805756798492, 5555.50000499957, 5560.054790685513, 5565.1374037024325, 3978.5026871641044, 4124.278251306069, 4166.8749937501925, 4175.185838761412, 4177.665786737114, 5829.8251052468495, 5846.158460085059, 5847.502962248256, 5853.09277062056, 5854.560907931837, 5646.604737668488, 5672.092465205547, 5675.177099320493, 5676.403977582295, 5679.545636349165, 5663.66018038919, 5669.4047125051275, 5677.659340439587, 5679.091345384883, 5679.432056794452, 5573.749181286933, 5575.358833734173, 5577.60956733041, 5585.497305242548, 5586.38549759518, 5494.120940649477, 5683.346415162309, 5693.914591281051, 5693.943060569507, 5703.942960570341, 5504.889902201853, 5545.694986775605, 5546.168074788814, 5548.916766248429, 5640.5769567281795], "unit": "score", "name": "prototype.html", "value": 4238.900587565743}, {"lowerIsBetter": false, "replicates": [708.6244290526022, 787.5314188058107, 792.2711105782676, 795.9084705258897, 800.4196957206025, 12566.0, 12879.742405151892, 12917.999999999989, 12925.612231633042, 12929.612111636654, 12129.272243665386, 12157.696057598565, 12238.959688426472, 12249.0, 12275.44760485778, 642.72041661877, 797.7806103321575, 804.8752443371287, 813.1096449387941, 818.9754307370788, 807.4105902691039, 815.4210510537525, 816.2572059425923, 819.3404309530825, 820.2084987986592, 852.7697521669146, 854.8546747052985, 855.1320409784074, 855.6406309350087, 856.1695155698962, 688.717625773433, 840.8822764812932, 858.3991206155716, 859.2181115185151, 860.7934095817021, 630.8170630517144, 631.0250662726099, 631.1511017681212, 631.4127861089186, 631.6462780842743, 12247.448864801105, 12297.815532767016, 12309.753804923941, 12316.81524777129, 12317.876821231763, 12062.69843253917, 12475.563355282522, 12499.875001249962, 12562.371881405894, 12607.495700171981, 9715.0, 9870.76802122743, 9898.505074746234, 10069.345492543034, 10108.39349639024, 3361.1765117546356, 3382.2220889195623, 3416.4533674611944, 3451.0854623524788, 3501.6848483636595, 39924.800375998224, 39934.60065399338, 40376.59623403787, 40489.59510404917, 40605.187896242205, 9676.656151419475, 9782.217422606174, 9837.852432213522, 9871.851922221173, 10080.495975201211, 17725.7341139883, 17759.644807104043, 17774.555636109202, 17993.550161246072, 18010.63978720418, 5850.912236316459, 5959.970200149059, 6015.578909476382, 6241.032639940817, 6253.37466253371, 3549.165946002687, 3614.3855544557487, 3666.1201311685536, 3723.4414837774552, 3739.0652336915773, 2909.956350654742, 2911.5195992660974, 2912.956305655417, 2924.0789151417234, 2927.0, 488.2334734466924, 488.6146832181216, 495.0840944253103, 506.97843844653056, 508.43055777529406, 479.6306843730308, 501.39832201358513, 557.6654007595411, 576.2048373244895, 621.6177051113533, 8118.35053195743, 8123.431359804875, 8299.170082991652, 8405.0, 8560.101189375026, 528.5665754081693, 572.3618165745164, 612.8161551534611, 619.0806652121596, 624.581530374641, 3833.9041523962123, 3848.5574158972076, 3857.1428571428573, 3921.215756848642, 3921.411788231731, 47024.05951880943, 51471.48528514667, 52834.47165528373, 52996.735016325445, 53017.469825301254, 40967.18065638671, 41415.1716965659, 41870.790646047186, 41949.161016780105, 42081.57918420838, 38842.22315553729, 38935.22129557393, 38970.511097678194, 38992.80503597464, 39261.03694815305, 7556.508826926232, 7570.05374328209, 7584.431167662337, 7650.579218143055, 8241.340692744447, 29042.0, 29804.850975744983, 30988.22529436782, 31105.222369440038, 31312.0, 34525.13687157841, 36843.447348289264, 37832.43251351287, 38196.42705359477, 38809.0, 9890.901090989286, 10068.093871551595, 10131.696049118538, 10169.32206185971, 10428.634997775041, 9350.81298374015, 11434.485448154686, 11434.599789007345, 11970.042396608076, 12164.209326393757, 10797.13622910181, 10921.617743378943, 10938.507767150339, 10951.83572246433, 11277.436128193393, 10840.186985975926, 10943.835842462211, 11057.889421105687, 11074.280171788809, 11328.716782080513, 10956.671299861016, 10957.671269861918, 11040.392778397265, 11071.889281107407, 11072.169587281147, 9025.548722563977, 9089.272858171462, 9215.723528294162, 9747.9025209747, 9863.408195508293, 8795.057257414734, 9213.856729919542, 9219.17027467531, 9226.723198304062, 9424.764380890258], "unit": "score", "name": "yui.html", "value": 5848.458266998088}], "name": "dromaeo_css", "value": 6341.588100197996}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 115.0, 110.0, 113.0, 114.0, 114.0, 102.0, 114.0, 114.0, 115.0], "unit": "score", "name": "ai-astar", "value": 112.4}, {"lowerIsBetter": true, "replicates": [164.0, 135.0, 158.0, 174.0, 133.0, 161.0, 155.0, 133.0, 184.0, 137.0], "unit": "score", "name": "audio-beat-detection", "value": 153.4}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 160.0, 160.0, 160.0, 161.0, 165.0, 164.0, 161.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.4}, {"lowerIsBetter": true, "replicates": [74.0, 75.0, 128.0, 95.0, 74.0, 73.0, 76.0, 116.0, 100.0, 74.0], "unit": "score", "name": "audio-fft", "value": 88.5}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 141.0, 93.0, 93.0, 95.0, 137.0, 94.0, 94.0, 140.0], "unit": "score", "name": "audio-oscillator", "value": 107.7}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 117.0, 117.0, 118.0, 118.0, 118.0, 117.0, 118.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.4}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 146.0, 146.0, 145.0, 145.0, 146.0, 146.0, 147.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.8}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 96.0, 96.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.4}, {"lowerIsBetter": true, "replicates": [66.0, 66.0, 68.0, 65.0, 64.0, 66.0, 66.0, 74.0, 63.0, 64.0], "unit": "score", "name": "json-parse-financial", "value": 66.2}, {"lowerIsBetter": true, "replicates": [63.0, 63.0, 74.0, 63.0, 64.0, 65.0, 65.0, 64.0, 63.0, 64.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.8}, {"lowerIsBetter": true, "replicates": [82.0, 83.0, 84.0, 84.0, 85.0, 84.0, 84.0, 84.0, 85.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.9}, {"lowerIsBetter": true, "replicates": [130.0, 125.0, 119.0, 124.0, 128.0, 123.0, 120.0, 122.0, 119.0, 120.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 123.0}, {"lowerIsBetter": true, "replicates": [146.0, 135.0, 147.0, 146.0, 146.0, 134.0, 145.0, 146.0, 147.0, 145.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 143.7}, {"lowerIsBetter": true, "replicates": [70.0, 69.0, 72.0, 69.0, 71.0, 69.0, 70.0, 71.0, 69.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.8}], "name": "kraken", "value": 1533.4}]} 17:33:17 INFO - Return code: 0 17:33:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 17:33:17 ERROR - # TBPL SUCCESS # 17:33:17 INFO - Running post-action listener: _resource_record_post_action 17:33:17 INFO - Running post-run listener: _resource_record_post_run 17:33:18 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 0; Write bytes: 518909952; Read time: 0; Write time: 490416 17:33:18 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 233480192; Read time: 0; Write time: 265460 17:33:18 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 0; Write bytes: 285429760; Read time: 0; Write time: 224956 17:33:18 INFO - Running post-run listener: _upload_blobber_files 17:33:18 INFO - Blob upload gear active. 17:33:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:33:18 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 17:33:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:33:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:33:19 INFO - (blobuploader) - INFO - Open directory for files ... 17:33:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:33:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:33:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:33:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:33:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:33:20 INFO - (blobuploader) - INFO - Done attempting. 17:33:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:33:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:33:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:33:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:33:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:33:21 INFO - (blobuploader) - INFO - Done attempting. 17:33:21 INFO - (blobuploader) - INFO - Iteration through files over. 17:33:21 INFO - Return code: 0 17:33:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:33:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:33:21 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/937173c93e748be710ef12e560659b488a0ed9d65c90f9d6199232f08f2cf72b5fc370b7af0457937b17c0bafac0b25eccff8b18e532089a597227397ef6e8e7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/103174300b4b45fff07f71a0e3b6c5dff97aa5c56cb96332640afdb93df9e952d9ce35cf28e00d194a2a64e7fa575ca3db6b500194e515b1f91fb1a935fd8ea0"} 17:33:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:33:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:33:21 INFO - Contents: 17:33:21 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/937173c93e748be710ef12e560659b488a0ed9d65c90f9d6199232f08f2cf72b5fc370b7af0457937b17c0bafac0b25eccff8b18e532089a597227397ef6e8e7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/103174300b4b45fff07f71a0e3b6c5dff97aa5c56cb96332640afdb93df9e952d9ce35cf28e00d194a2a64e7fa575ca3db6b500194e515b1f91fb1a935fd8ea0"} 17:33:21 INFO - Running post-run listener: copy_logs_to_upload_dir 17:33:21 INFO - Copying logs to upload dir... 17:33:21 INFO - mkdir: /builds/slave/test/build/upload/logs 17:33:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.227396 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-04-01 17:33:21.001146) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-01 17:33:21.004687) ========= 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-1459555964.100954-45152541 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/937173c93e748be710ef12e560659b488a0ed9d65c90f9d6199232f08f2cf72b5fc370b7af0457937b17c0bafac0b25eccff8b18e532089a597227397ef6e8e7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/103174300b4b45fff07f71a0e3b6c5dff97aa5c56cb96332640afdb93df9e952d9ce35cf28e00d194a2a64e7fa575ca3db6b500194e515b1f91fb1a935fd8ea0"} build_url:https://queue.taskcluster.net/v1/task/IeIVi6flQe-cncGs2uGDQw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011342 build_url: 'https://queue.taskcluster.net/v1/task/IeIVi6flQe-cncGs2uGDQw/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/Firefox-Non-PGO/sha512/937173c93e748be710ef12e560659b488a0ed9d65c90f9d6199232f08f2cf72b5fc370b7af0457937b17c0bafac0b25eccff8b18e532089a597227397ef6e8e7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/103174300b4b45fff07f71a0e3b6c5dff97aa5c56cb96332640afdb93df9e952d9ce35cf28e00d194a2a64e7fa575ca3db6b500194e515b1f91fb1a935fd8ea0"}' ========= master_lag: 0.05 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-01 17:33:21.064856) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 17:33:21.065250) ========= 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-1459555964.100954-45152541 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004418 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 17:33:21.146690) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-01 17:33:21.147042) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-01 17:33:21.147360) ========= ========= Total master_lag: 0.32 =========