builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-039 starttime: 1459559446.12 results: success (0) buildid: 20160401173744 builduid: 3bcc6682f9624926aab4e4a37e0d52ee revision: 7e4c0bee56f35104a4809121e8672f1e659258f5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-01 18:10:46.124729) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-01 18:10:46.125216) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-01 18:10:46.125526) ========= 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=5bd038846534b2fdfa68eeae000001e2-1459559316.70669-633906442 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006409 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-01 18:10:46.152749) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-01 18:10:46.153035) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-01 18:10:46.169512) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 18:10:46.169781) ========= 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=5bd038846534b2fdfa68eeae000001e2-1459559316.70669-633906442 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004593 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 18:10:46.220533) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-01 18:10:46.220815) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-01 18:10:46.221147) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 18:10:46.221791) ========= 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=5bd038846534b2fdfa68eeae000001e2-1459559316.70669-633906442 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-01 18:10:46-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 47.0M=0s 2016-04-01 18:10:46 (47.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.165624 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 18:10:46.407797) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 18:10:46.408071) ========= 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=5bd038846534b2fdfa68eeae000001e2-1459559316.70669-633906442 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016947 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 18:10:46.462111) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 18:10:46.462430) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 7e4c0bee56f35104a4809121e8672f1e659258f5 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 7e4c0bee56f35104a4809121e8672f1e659258f5 --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=5bd038846534b2fdfa68eeae000001e2-1459559316.70669-633906442 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-01 18:10:46,952 truncating revision to first 12 chars 2016-04-01 18:10:46,952 Setting DEBUG logging. 2016-04-01 18:10:46,952 attempt 1/10 2016-04-01 18:10:46,952 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/7e4c0bee56f3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-01 18:10:47,245 unpacking tar archive at: fx-team-7e4c0bee56f3/testing/mozharness/ program finished with exit code 0 elapsedTime=0.577278 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 18:10:47.052709) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-01 18:10:47.053098) ========= echo 7e4c0bee56f35104a4809121e8672f1e659258f5 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'7e4c0bee56f35104a4809121e8672f1e659258f5'] 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=5bd038846534b2fdfa68eeae000001e2-1459559316.70669-633906442 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 7e4c0bee56f35104a4809121e8672f1e659258f5 program finished with exit code 0 elapsedTime=0.004019 script_repo_revision: '7e4c0bee56f35104a4809121e8672f1e659258f5' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-01 18:10:47.101696) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-01 18:10:47.101969) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-01 18:10:47.116078) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-04-01 18:10:47.116446) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5bd038846534b2fdfa68eeae000001e2-1459559316.70669-633906442 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:10:47 INFO - MultiFileLogger online at 20160401 18:10:47 in /builds/slave/test 18:10:47 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 18:10:47 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:10:47 INFO - {'append_to_log': False, 18:10:47 INFO - 'base_work_dir': '/builds/slave/test', 18:10:47 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 18:10:47 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:10:47 INFO - 'branch': 'Fx-Team-Non-PGO', 18:10:47 INFO - 'buildbot_json_path': 'buildprops.json', 18:10:47 INFO - 'config_files': ('talos/linux_config.py',), 18:10:47 INFO - 'default_actions': ('clobber', 18:10:47 INFO - 'read-buildbot-config', 18:10:47 INFO - 'download-and-extract', 18:10:47 INFO - 'populate-webroot', 18:10:47 INFO - 'create-virtualenv', 18:10:47 INFO - 'install', 18:10:47 INFO - 'run-tests'), 18:10:47 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:10:47 INFO - 'download_minidump_stackwalk': True, 18:10:47 INFO - 'download_symbols': 'ondemand', 18:10:47 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:10:47 INFO - 'tooltool.py': '/tools/tooltool.py', 18:10:47 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:10:47 INFO - '/tools/misc-python/virtualenv.py')}, 18:10:47 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:10:47 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:10:47 INFO - 'installer_path': 'installer.exe', 18:10:47 INFO - 'log_level': 'info', 18:10:47 INFO - 'log_name': 'talos', 18:10:47 INFO - 'log_to_console': True, 18:10:47 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:10:47 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:10:47 INFO - 'opt_config_files': (), 18:10:47 INFO - 'pip_index': False, 18:10:47 INFO - 'sps_profile': False, 18:10:47 INFO - 'sps_profile_interval': 0, 18:10:47 INFO - 'suite': 'dromaeojs', 18:10:47 INFO - 'system_bits': '32', 18:10:47 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:10:47 INFO - 'title': 'talos-linux64-ix-039', 18:10:47 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:10:47 INFO - 'use_talos_json': True, 18:10:47 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:10:47 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:10:47 INFO - 'work_dir': 'build'} 18:10:47 INFO - ##### 18:10:47 INFO - ##### Running clobber step. 18:10:47 INFO - ##### 18:10:47 INFO - Running pre-action listener: _resource_record_pre_action 18:10:47 INFO - Running main action method: clobber 18:10:47 INFO - rmtree: /builds/slave/test/build 18:10:47 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:10:48 INFO - Running post-action listener: _resource_record_post_action 18:10:48 INFO - ##### 18:10:48 INFO - ##### Running read-buildbot-config step. 18:10:48 INFO - ##### 18:10:48 INFO - Running pre-action listener: _resource_record_pre_action 18:10:48 INFO - Running main action method: read_buildbot_config 18:10:48 INFO - Using buildbot properties: 18:10:48 INFO - { 18:10:48 INFO - "project": "", 18:10:48 INFO - "product": "firefox", 18:10:48 INFO - "script_repo_revision": "production", 18:10:48 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 18:10:48 INFO - "repository": "", 18:10:48 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 18:10:48 INFO - "buildid": "20160401173744", 18:10:48 INFO - "pgo_build": "False", 18:10:48 INFO - "basedir": "/builds/slave/test", 18:10:48 INFO - "buildnumber": 1529, 18:10:48 INFO - "slavename": "talos-linux64-ix-039", 18:10:48 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 18:10:48 INFO - "platform": "ubuntu64_hw", 18:10:48 INFO - "scheduler": "tests-fx-team-linux64-talos", 18:10:48 INFO - "branch": "fx-team", 18:10:48 INFO - "repo_path": "integration/fx-team", 18:10:48 INFO - "revision": "7e4c0bee56f35104a4809121e8672f1e659258f5", 18:10:48 INFO - "stage_platform": "linux64", 18:10:48 INFO - "builduid": "3bcc6682f9624926aab4e4a37e0d52ee", 18:10:48 INFO - "slavebuilddir": "test" 18:10:48 INFO - } 18:10:48 INFO - Found installer url https://queue.taskcluster.net/v1/task/ccpaxqcLQbOMDNmQGQ49FQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 18:10:48 INFO - Running post-action listener: _resource_record_post_action 18:10:48 INFO - ##### 18:10:48 INFO - ##### Running download-and-extract step. 18:10:48 INFO - ##### 18:10:48 INFO - Running pre-action listener: _resource_record_pre_action 18:10:48 INFO - Running main action method: download_and_extract 18:10:48 INFO - mkdir: /builds/slave/test/build/tests 18:10:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:10:48 INFO - https://queue.taskcluster.net/v1/task/ccpaxqcLQbOMDNmQGQ49FQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 18:10:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ccpaxqcLQbOMDNmQGQ49FQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 18:10:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ccpaxqcLQbOMDNmQGQ49FQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 18:10:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ccpaxqcLQbOMDNmQGQ49FQ/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 18:10:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ccpaxqcLQbOMDNmQGQ49FQ/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 18:10:48 INFO - Downloaded 1361 bytes. 18:10:48 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 18:10:48 INFO - Using the following test package requirements: 18:10:48 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 18:10:48 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:10:48 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:10:48 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:10:48 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 18:10:48 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:10:48 INFO - u'jsshell-linux-x86_64.zip'], 18:10:48 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:10:48 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:10:48 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 18:10:48 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:10:48 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:10:48 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:10:48 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:10:48 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:10:48 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:10:48 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:10:48 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:10:48 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:10:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:10:48 INFO - https://queue.taskcluster.net/v1/task/ccpaxqcLQbOMDNmQGQ49FQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:10:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ccpaxqcLQbOMDNmQGQ49FQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 18:10:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ccpaxqcLQbOMDNmQGQ49FQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 18:10:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ccpaxqcLQbOMDNmQGQ49FQ/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 18:10:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ccpaxqcLQbOMDNmQGQ49FQ/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 18:10:49 INFO - Downloaded 22115802 bytes. 18:10:49 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'] 18:10:49 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 18:10:51 INFO - Return code: 0 18:10:51 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 18:10:51 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')]} 18:10:51 INFO - https://queue.taskcluster.net/v1/task/ccpaxqcLQbOMDNmQGQ49FQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:10:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ccpaxqcLQbOMDNmQGQ49FQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 18:10:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ccpaxqcLQbOMDNmQGQ49FQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 18:10:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ccpaxqcLQbOMDNmQGQ49FQ/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 18:10:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ccpaxqcLQbOMDNmQGQ49FQ/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 18:10:54 INFO - Downloaded 22115802 bytes. 18:10:54 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'] 18:10:54 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 18:10:55 INFO - Return code: 0 18:10:55 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')]} 18:10:55 INFO - https://queue.taskcluster.net/v1/task/ccpaxqcLQbOMDNmQGQ49FQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 18:10:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ccpaxqcLQbOMDNmQGQ49FQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 18:10:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ccpaxqcLQbOMDNmQGQ49FQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 18:10:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ccpaxqcLQbOMDNmQGQ49FQ/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 18:10:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ccpaxqcLQbOMDNmQGQ49FQ/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 18:10:57 INFO - Downloaded 10847584 bytes. 18:10:57 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'] 18:10:57 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 18:10:57 INFO - Return code: 0 18:10:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:10:57 INFO - https://queue.taskcluster.net/v1/task/ccpaxqcLQbOMDNmQGQ49FQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 18:10:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ccpaxqcLQbOMDNmQGQ49FQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 18:10:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ccpaxqcLQbOMDNmQGQ49FQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 18:10:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ccpaxqcLQbOMDNmQGQ49FQ/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 18:10:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ccpaxqcLQbOMDNmQGQ49FQ/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 18:10:58 INFO - Downloaded 54238023 bytes. 18:10:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ccpaxqcLQbOMDNmQGQ49FQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 18:10:58 INFO - mkdir: /builds/slave/test/properties 18:10:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:10:58 INFO - Writing to file /builds/slave/test/properties/build_url 18:10:58 INFO - Contents: 18:10:58 INFO - build_url:https://queue.taskcluster.net/v1/task/ccpaxqcLQbOMDNmQGQ49FQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 18:10:59 INFO - Running post-action listener: _resource_record_post_action 18:10:59 INFO - Running post-action listener: set_extra_try_arguments 18:10:59 INFO - ##### 18:10:59 INFO - ##### Running populate-webroot step. 18:10:59 INFO - ##### 18:10:59 INFO - Running pre-action listener: _resource_record_pre_action 18:10:59 INFO - Running main action method: populate_webroot 18:10:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:10:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:10:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:10:59 INFO - '--tppagecycles', 18:10:59 INFO - '7'], 18:10:59 INFO - 'tests': ['tsvgm']}}, 18:10:59 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 18:10:59 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 18:10:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:10:59 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 18:10:59 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 18:10:59 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:10:59 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:10:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:10:59 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:10:59 INFO - 'talos_options': ['--e10s'], 18:10:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:10:59 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:10:59 INFO - 'tests': ['damp', 'tps']}, 18:10:59 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:10:59 INFO - 'talos_options': ['--e10s'], 18:10:59 INFO - 'tests': ['damp', 'tps']}, 18:10:59 INFO - 'g3': {'tests': ['dromaeo_dom']}, 18:10:59 INFO - 'g3-e10s': {'talos_options': ['--e10s'], 18:10:59 INFO - 'tests': ['dromaeo_dom']}, 18:10:59 INFO - 'other': {'tests': ['a11yr', 18:10:59 INFO - 'ts_paint', 18:10:59 INFO - 'tpaint', 18:10:59 INFO - 'sessionrestore', 18:10:59 INFO - 'sessionrestore_no_auto_restore', 18:10:59 INFO - 'tabpaint']}, 18:10:59 INFO - 'other-e10s': {'talos_options': ['--e10s'], 18:10:59 INFO - 'tests': ['a11yr', 18:10:59 INFO - 'ts_paint', 18:10:59 INFO - 'tpaint', 18:10:59 INFO - 'sessionrestore', 18:10:59 INFO - 'sessionrestore_no_auto_restore', 18:10:59 INFO - 'tabpaint']}, 18:10:59 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 18:10:59 INFO - 'tests': ['a11yr', 18:10:59 INFO - 'ts_paint', 18:10:59 INFO - 'tpaint', 18:10:59 INFO - 'sessionrestore', 18:10:59 INFO - 'sessionrestore_no_auto_restore', 18:10:59 INFO - 'tabpaint']}, 18:10:59 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 18:10:59 INFO - 'tests': ['a11yr', 18:10:59 INFO - 'ts_paint', 18:10:59 INFO - 'tpaint', 18:10:59 INFO - 'sessionrestore', 18:10:59 INFO - 'sessionrestore_no_auto_restore', 18:10:59 INFO - 'tabpaint']}, 18:10:59 INFO - 'other_l64': {'tests': ['a11yr', 18:10:59 INFO - 'ts_paint', 18:10:59 INFO - 'tpaint', 18:10:59 INFO - 'sessionrestore', 18:10:59 INFO - 'sessionrestore_no_auto_restore', 18:10:59 INFO - 'tabpaint']}, 18:10:59 INFO - 'other_nol64': {'tests': ['a11yr', 18:10:59 INFO - 'ts_paint', 18:10:59 INFO - 'tpaint', 18:10:59 INFO - 'sessionrestore', 18:10:59 INFO - 'sessionrestore_no_auto_restore', 18:10:59 INFO - 'tabpaint']}, 18:10:59 INFO - 'svgr': {'tests': ['tsvgx', 18:10:59 INFO - 'tsvgr_opacity', 18:10:59 INFO - 'tart', 18:10:59 INFO - 'tscrollx', 18:10:59 INFO - 'cart']}, 18:10:59 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 18:10:59 INFO - 'tests': ['tsvgx', 18:10:59 INFO - 'tsvgr_opacity', 18:10:59 INFO - 'tart', 18:10:59 INFO - 'tscrollx', 18:10:59 INFO - 'cart']}, 18:10:59 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:10:59 INFO - 'tests': ['tp5o']}, 18:10:59 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:10:59 INFO - 'talos_options': ['--e10s'], 18:10:59 INFO - 'tests': ['tp5o']}, 18:10:59 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:10:59 INFO - 'talos_options': ['--xperf_path', 18:10:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:10:59 INFO - 'tests': ['tp5n']}, 18:10:59 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:10:59 INFO - 'talos_options': ['--e10s', 18:10:59 INFO - '--xperf_path', 18:10:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:10:59 INFO - 'tests': ['tp5n']}}, 18:10:59 INFO - 'talos.zip': {'path': '', 18:10:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:10:59 INFO - Running post-action listener: _resource_record_post_action 18:10:59 INFO - ##### 18:10:59 INFO - ##### Running create-virtualenv step. 18:10:59 INFO - ##### 18:10:59 INFO - Running pre-action listener: _resource_record_pre_action 18:10:59 INFO - Running main action method: create_virtualenv 18:10:59 INFO - Creating virtualenv /builds/slave/test/build/venv 18:10:59 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 18:10:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:10:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:10:59 INFO - Using real prefix '/usr' 18:10:59 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:11:00 INFO - Installing distribute.............................................................................................................................................................................................done. 18:11:02 INFO - Installing pip.................done. 18:11:02 INFO - Return code: 0 18:11:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:11:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:11:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:11:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:11:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:11:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:11:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:11:02 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 0x7f1f76e5af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x274b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28177d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a6640>, '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 0x28a7540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28a79d0>, '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': '5bd038846534b2fdfa68eeae000001e2-1459559316.70669-633906442', '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 18:11:02 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 18:11: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 pip>=1.5 18:11:02 INFO - Using env: {'DISPLAY': ':0', 18:11:02 INFO - 'HOME': '/home/cltbld', 18:11:02 INFO - 'LANG': 'en_US.UTF-8', 18:11:02 INFO - 'LANGUAGE': 'en_US:en', 18:11:02 INFO - 'LOGNAME': 'cltbld', 18:11:02 INFO - 'MAIL': '/var/mail/cltbld', 18:11:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:11:02 INFO - 'MOZ_NO_REMOTE': '1', 18:11:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:11:02 INFO - 'NO_EM_RESTART': '1', 18:11:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:11:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:11:02 INFO - 'PWD': '/builds/slave/test', 18:11:02 INFO - 'SHELL': '/bin/bash', 18:11:02 INFO - 'SHLVL': '1', 18:11:02 INFO - 'TERM': 'linux', 18:11:02 INFO - 'TMOUT': '86400', 18:11:02 INFO - 'USER': 'cltbld', 18:11:02 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1459559316.70669-633906442', 18:11:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:11:02 INFO - '_': '/tools/buildbot/bin/python'} 18:11:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:11:02 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 18:11:02 INFO - Cleaning up... 18:11:02 INFO - Return code: 0 18:11:02 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 18:11:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:11:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:11:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:11:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:11:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:11:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:11:02 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 0x7f1f76e5af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x274b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28177d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a6640>, '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 0x28a7540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28a79d0>, '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': '5bd038846534b2fdfa68eeae000001e2-1459559316.70669-633906442', '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 18:11:02 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 18:11: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 psutil>=0.7.1 18:11:02 INFO - Using env: {'DISPLAY': ':0', 18:11:02 INFO - 'HOME': '/home/cltbld', 18:11:02 INFO - 'LANG': 'en_US.UTF-8', 18:11:02 INFO - 'LANGUAGE': 'en_US:en', 18:11:02 INFO - 'LOGNAME': 'cltbld', 18:11:02 INFO - 'MAIL': '/var/mail/cltbld', 18:11:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:11:02 INFO - 'MOZ_NO_REMOTE': '1', 18:11:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:11:02 INFO - 'NO_EM_RESTART': '1', 18:11:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:11:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:11:02 INFO - 'PWD': '/builds/slave/test', 18:11:02 INFO - 'SHELL': '/bin/bash', 18:11:02 INFO - 'SHLVL': '1', 18:11:02 INFO - 'TERM': 'linux', 18:11:02 INFO - 'TMOUT': '86400', 18:11:02 INFO - 'USER': 'cltbld', 18:11:02 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1459559316.70669-633906442', 18:11:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:11:02 INFO - '_': '/tools/buildbot/bin/python'} 18:11:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:11:02 INFO - Downloading/unpacking psutil>=0.7.1 18:11: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 18:11: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 18:11: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 18:11: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 18:11: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 18:11: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 18:11:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:11:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:11:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:11:04 INFO - Installing collected packages: psutil 18:11:04 INFO - Running setup.py install for psutil 18:11:04 INFO - building 'psutil._psutil_linux' extension 18:11:04 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 18:11:04 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 18:11:04 INFO - building 'psutil._psutil_posix' extension 18:11:04 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 18:11:05 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 18:11:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:11:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:11:05 INFO - Successfully installed psutil 18:11:05 INFO - Cleaning up... 18:11:05 INFO - Return code: 0 18:11:05 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 18:11:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:11:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:11:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:11:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:11:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:11:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:11:05 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 0x7f1f76e5af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x274b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28177d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a6640>, '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 0x28a7540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28a79d0>, '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': '5bd038846534b2fdfa68eeae000001e2-1459559316.70669-633906442', '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 18:11:05 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 18:11:05 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 18:11:05 INFO - Using env: {'DISPLAY': ':0', 18:11:05 INFO - 'HOME': '/home/cltbld', 18:11:05 INFO - 'LANG': 'en_US.UTF-8', 18:11:05 INFO - 'LANGUAGE': 'en_US:en', 18:11:05 INFO - 'LOGNAME': 'cltbld', 18:11:05 INFO - 'MAIL': '/var/mail/cltbld', 18:11:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:11:05 INFO - 'MOZ_NO_REMOTE': '1', 18:11:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:11:05 INFO - 'NO_EM_RESTART': '1', 18:11:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:11:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:11:05 INFO - 'PWD': '/builds/slave/test', 18:11:05 INFO - 'SHELL': '/bin/bash', 18:11:05 INFO - 'SHLVL': '1', 18:11:05 INFO - 'TERM': 'linux', 18:11:05 INFO - 'TMOUT': '86400', 18:11:05 INFO - 'USER': 'cltbld', 18:11:05 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1459559316.70669-633906442', 18:11:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:11:05 INFO - '_': '/tools/buildbot/bin/python'} 18:11:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:11:05 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:11:05 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 18:11:05 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 18:11:05 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 18:11:05 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 18:11:05 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 18:11:05 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 18:11:07 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:11:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:11:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 18:11:07 INFO - Installing collected packages: mozsystemmonitor 18:11:07 INFO - Running setup.py install for mozsystemmonitor 18:11:07 INFO - Successfully installed mozsystemmonitor 18:11:07 INFO - Cleaning up... 18:11:07 INFO - Return code: 0 18:11:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:11: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')]} 18:11:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:11:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:11: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')]} 18:11:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:11:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:11:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f1f76e5af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x274b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28177d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a6640>, '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 0x28a7540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28a79d0>, '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': '5bd038846534b2fdfa68eeae000001e2-1459559316.70669-633906442', '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 18:11:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:11:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 18:11:07 INFO - Using env: {'DISPLAY': ':0', 18:11:07 INFO - 'HOME': '/home/cltbld', 18:11:07 INFO - 'LANG': 'en_US.UTF-8', 18:11:07 INFO - 'LANGUAGE': 'en_US:en', 18:11:07 INFO - 'LOGNAME': 'cltbld', 18:11:07 INFO - 'MAIL': '/var/mail/cltbld', 18:11:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:11:07 INFO - 'MOZ_NO_REMOTE': '1', 18:11:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:11:07 INFO - 'NO_EM_RESTART': '1', 18:11:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:11:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:11:07 INFO - 'PWD': '/builds/slave/test', 18:11:07 INFO - 'SHELL': '/bin/bash', 18:11:07 INFO - 'SHLVL': '1', 18:11:07 INFO - 'TERM': 'linux', 18:11:07 INFO - 'TMOUT': '86400', 18:11:07 INFO - 'USER': 'cltbld', 18:11:07 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1459559316.70669-633906442', 18:11:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:11:07 INFO - '_': '/tools/buildbot/bin/python'} 18:11:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:11:07 INFO - Downloading/unpacking blobuploader==1.2.4 18:11:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:11:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:11:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:11:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:11:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:11:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:11:09 INFO - Downloading blobuploader-1.2.4.tar.gz 18:11:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:11:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:11:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:11:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:11:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:11:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:11:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:11:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:11:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:11:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:11:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:11:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:11:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:11:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:11:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:11:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:11:10 INFO - Downloading docopt-0.6.1.tar.gz 18:11:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:11:10 INFO - Installing collected packages: blobuploader, requests, docopt 18:11:10 INFO - Running setup.py install for blobuploader 18:11:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:11:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:11:10 INFO - Running setup.py install for requests 18:11:10 INFO - Running setup.py install for docopt 18:11:10 INFO - Successfully installed blobuploader requests docopt 18:11:10 INFO - Cleaning up... 18:11:10 INFO - Return code: 0 18:11:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:11: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')]} 18:11:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:11:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:11: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')]} 18:11:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:11:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:11:10 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 0x7f1f76e5af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x274b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28177d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a6640>, '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 0x28a7540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28a79d0>, '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': '5bd038846534b2fdfa68eeae000001e2-1459559316.70669-633906442', '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 18:11:10 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 18:11:10 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 18:11:10 INFO - Using env: {'DISPLAY': ':0', 18:11:10 INFO - 'HOME': '/home/cltbld', 18:11:10 INFO - 'LANG': 'en_US.UTF-8', 18:11:10 INFO - 'LANGUAGE': 'en_US:en', 18:11:10 INFO - 'LOGNAME': 'cltbld', 18:11:10 INFO - 'MAIL': '/var/mail/cltbld', 18:11:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:11:10 INFO - 'MOZ_NO_REMOTE': '1', 18:11:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:11:10 INFO - 'NO_EM_RESTART': '1', 18:11:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:11:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:11:10 INFO - 'PWD': '/builds/slave/test', 18:11:10 INFO - 'SHELL': '/bin/bash', 18:11:10 INFO - 'SHLVL': '1', 18:11:10 INFO - 'TERM': 'linux', 18:11:10 INFO - 'TMOUT': '86400', 18:11:10 INFO - 'USER': 'cltbld', 18:11:10 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1459559316.70669-633906442', 18:11:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:11:10 INFO - '_': '/tools/buildbot/bin/python'} 18:11:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:11:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:11:11 INFO - Running setup.py (path:/tmp/pip-pgxg2X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:11:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:11:11 INFO - Running setup.py (path:/tmp/pip-hcNDJW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:11:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:11:11 INFO - Running setup.py (path:/tmp/pip-Cfpqw1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:11:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:11:11 INFO - Running setup.py (path:/tmp/pip-Hde_2K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:11:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:11:11 INFO - Running setup.py (path:/tmp/pip-0ouVSk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:11:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:11:11 INFO - Running setup.py (path:/tmp/pip-9v7avr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:11:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:11:11 INFO - Running setup.py (path:/tmp/pip-FSBvcs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:11:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:11:11 INFO - Running setup.py (path:/tmp/pip-lXGGDT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:11:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:11:11 INFO - Running setup.py (path:/tmp/pip-JrtIYd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:11:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:11:11 INFO - Running setup.py (path:/tmp/pip-vXSXrZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:11:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:11:11 INFO - Running setup.py (path:/tmp/pip-UwifU0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:11:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:11:11 INFO - Running setup.py (path:/tmp/pip-Uw00TC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:11:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:11:11 INFO - Running setup.py (path:/tmp/pip-qWVODy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:11:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:11:12 INFO - Running setup.py (path:/tmp/pip-XuJkOl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:11:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:11:12 INFO - Running setup.py (path:/tmp/pip-urniP7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:11:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:11:12 INFO - Running setup.py (path:/tmp/pip-Xpg1go-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:11:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:11:12 INFO - Running setup.py (path:/tmp/pip-UDw17l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:11:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:11:12 INFO - Running setup.py install for manifestparser 18:11:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:11:12 INFO - Running setup.py install for mozcrash 18:11:12 INFO - Running setup.py install for mozdebug 18:11:12 INFO - Running setup.py install for mozdevice 18:11:12 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:11:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:11:12 INFO - Running setup.py install for mozfile 18:11:12 INFO - Running setup.py install for mozhttpd 18:11:12 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:11:12 INFO - Running setup.py install for mozinfo 18:11:12 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:11:13 INFO - Running setup.py install for mozInstall 18:11:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:11:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:11:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:11:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:11:13 INFO - Running setup.py install for mozleak 18:11:13 INFO - Running setup.py install for mozlog 18:11:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:11:13 INFO - Running setup.py install for moznetwork 18:11:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:11:13 INFO - Running setup.py install for mozprocess 18:11:13 INFO - Running setup.py install for mozprofile 18:11:13 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:11:13 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:11:13 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:11:13 INFO - Running setup.py install for mozrunner 18:11:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:11:13 INFO - Running setup.py install for mozscreenshot 18:11:13 INFO - Running setup.py install for moztest 18:11:13 INFO - Running setup.py install for mozversion 18:11:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:11:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:11:14 INFO - Cleaning up... 18:11:14 INFO - Return code: 0 18:11:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:11: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')]} 18:11:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:11:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:11: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')]} 18:11:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:11:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:11:14 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 0x7f1f76e5af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x274b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28177d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a6640>, '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 0x28a7540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28a79d0>, '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': '5bd038846534b2fdfa68eeae000001e2-1459559316.70669-633906442', '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 18:11:14 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 18:11:14 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 18:11:14 INFO - Using env: {'DISPLAY': ':0', 18:11:14 INFO - 'HOME': '/home/cltbld', 18:11:14 INFO - 'LANG': 'en_US.UTF-8', 18:11:14 INFO - 'LANGUAGE': 'en_US:en', 18:11:14 INFO - 'LOGNAME': 'cltbld', 18:11:14 INFO - 'MAIL': '/var/mail/cltbld', 18:11:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:11:14 INFO - 'MOZ_NO_REMOTE': '1', 18:11:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:11:14 INFO - 'NO_EM_RESTART': '1', 18:11:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:11:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:11:14 INFO - 'PWD': '/builds/slave/test', 18:11:14 INFO - 'SHELL': '/bin/bash', 18:11:14 INFO - 'SHLVL': '1', 18:11:14 INFO - 'TERM': 'linux', 18:11:14 INFO - 'TMOUT': '86400', 18:11:14 INFO - 'USER': 'cltbld', 18:11:14 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1459559316.70669-633906442', 18:11:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:11:14 INFO - '_': '/tools/buildbot/bin/python'} 18:11:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:11:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:11:14 INFO - Running setup.py (path:/tmp/pip-kvF84k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:11:14 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)) 18:11:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:11:14 INFO - Running setup.py (path:/tmp/pip-9gUr1a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:11:14 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)) 18:11:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:11:14 INFO - Running setup.py (path:/tmp/pip-dhmgNw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:11:14 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)) 18:11:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:11:14 INFO - Running setup.py (path:/tmp/pip-sAwobK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:11:14 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)) 18:11:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:11:14 INFO - Running setup.py (path:/tmp/pip-DACt5T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:11:14 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)) 18:11:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:11:14 INFO - Running setup.py (path:/tmp/pip-87Lvxm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:11:14 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)) 18:11:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:11:14 INFO - Running setup.py (path:/tmp/pip-mTwzJJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:11:14 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)) 18:11:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:11:14 INFO - Running setup.py (path:/tmp/pip-m3muY9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:11:14 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)) 18:11:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:11:14 INFO - Running setup.py (path:/tmp/pip-SbOGmP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:11:14 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)) 18:11:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:11:14 INFO - Running setup.py (path:/tmp/pip-2AhH1T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:11:15 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)) 18:11:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:11:15 INFO - Running setup.py (path:/tmp/pip-6JEkpy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:11:15 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)) 18:11:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:11:15 INFO - Running setup.py (path:/tmp/pip-QQYniN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:11:15 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)) 18:11:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:11:15 INFO - Running setup.py (path:/tmp/pip-mIokUJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:11:15 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)) 18:11:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:11:15 INFO - Running setup.py (path:/tmp/pip-rTlrcX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:11:15 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)) 18:11:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:11:15 INFO - Running setup.py (path:/tmp/pip-2KumvK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:11:15 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)) 18:11:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:11:15 INFO - Running setup.py (path:/tmp/pip-Unlk4W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:11:15 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)) 18:11:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:11:15 INFO - Running setup.py (path:/tmp/pip-9mcO_g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:11:15 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)) 18:11:15 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)) 18:11:15 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)) 18:11:15 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)) 18:11:15 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)) 18:11:15 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)) 18:11:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:11: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 18:11: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 18:11: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 18:11: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 18:11: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 18:11: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 18:11:17 INFO - Downloading blessings-1.6.tar.gz 18:11:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:11:17 INFO - Installing collected packages: blessings 18:11:17 INFO - Running setup.py install for blessings 18:11:17 INFO - Successfully installed blessings 18:11:17 INFO - Cleaning up... 18:11:17 INFO - Return code: 0 18:11:17 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:11:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:11:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:11:17 INFO - Reading from file tmpfile_stdout 18:11:17 INFO - Current package versions: 18:11:17 INFO - argparse == 1.2.1 18:11:17 INFO - blessings == 1.6 18:11:17 INFO - blobuploader == 1.2.4 18:11:17 INFO - docopt == 0.6.1 18:11:17 INFO - manifestparser == 1.1 18:11:17 INFO - mozInstall == 1.12 18:11:17 INFO - mozcrash == 0.17 18:11:17 INFO - mozdebug == 0.1 18:11:17 INFO - mozdevice == 0.48 18:11:17 INFO - mozfile == 1.2 18:11:17 INFO - mozhttpd == 0.7 18:11:17 INFO - mozinfo == 0.9 18:11:17 INFO - mozleak == 0.1 18:11:17 INFO - mozlog == 3.1 18:11:17 INFO - moznetwork == 0.27 18:11:17 INFO - mozprocess == 0.22 18:11:17 INFO - mozprofile == 0.28 18:11:17 INFO - mozrunner == 6.11 18:11:17 INFO - mozscreenshot == 0.1 18:11:17 INFO - mozsystemmonitor == 0.0 18:11:17 INFO - moztest == 0.7 18:11:17 INFO - mozversion == 1.4 18:11:17 INFO - psutil == 3.1.1 18:11:17 INFO - requests == 1.2.3 18:11:17 INFO - wsgiref == 0.1.2 18:11:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:11:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:11:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:11:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:11:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:11:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:11:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:11:17 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 0x7f1f76e5af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x274b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28177d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a6640>, '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 0x28a7540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28a79d0>, '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': '5bd038846534b2fdfa68eeae000001e2-1459559316.70669-633906442', '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 18:11:17 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 18:11:17 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 18:11:17 INFO - Using env: {'DISPLAY': ':0', 18:11:17 INFO - 'HOME': '/home/cltbld', 18:11:17 INFO - 'LANG': 'en_US.UTF-8', 18:11:17 INFO - 'LANGUAGE': 'en_US:en', 18:11:17 INFO - 'LOGNAME': 'cltbld', 18:11:17 INFO - 'MAIL': '/var/mail/cltbld', 18:11:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:11:17 INFO - 'MOZ_NO_REMOTE': '1', 18:11:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:11:17 INFO - 'NO_EM_RESTART': '1', 18:11:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:11:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:11:17 INFO - 'PWD': '/builds/slave/test', 18:11:17 INFO - 'SHELL': '/bin/bash', 18:11:17 INFO - 'SHLVL': '1', 18:11:17 INFO - 'TERM': 'linux', 18:11:17 INFO - 'TMOUT': '86400', 18:11:17 INFO - 'USER': 'cltbld', 18:11:17 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1459559316.70669-633906442', 18:11:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:11:17 INFO - '_': '/tools/buildbot/bin/python'} 18:11:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:11:18 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)) 18:11:18 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)) 18:11:18 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)) 18:11:18 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)) 18:11:18 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)) 18:11:18 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)) 18:11:18 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)) 18:11:18 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)) 18:11:18 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)) 18:11:18 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)) 18:11:18 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)) 18:11:18 INFO - Cleaning up... 18:11:18 INFO - Return code: 0 18:11:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:11:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:11:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:11:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:11:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:11:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:11:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:11:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1f76e5af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x274b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28177d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a6640>, '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 0x28a7540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28a79d0>, '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': '5bd038846534b2fdfa68eeae000001e2-1459559316.70669-633906442', '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 18:11:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 18:11:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 18:11:18 INFO - Using env: {'DISPLAY': ':0', 18:11:18 INFO - 'HOME': '/home/cltbld', 18:11:18 INFO - 'LANG': 'en_US.UTF-8', 18:11:18 INFO - 'LANGUAGE': 'en_US:en', 18:11:18 INFO - 'LOGNAME': 'cltbld', 18:11:18 INFO - 'MAIL': '/var/mail/cltbld', 18:11:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:11:18 INFO - 'MOZ_NO_REMOTE': '1', 18:11:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:11:18 INFO - 'NO_EM_RESTART': '1', 18:11:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:11:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:11:18 INFO - 'PWD': '/builds/slave/test', 18:11:18 INFO - 'SHELL': '/bin/bash', 18:11:18 INFO - 'SHLVL': '1', 18:11:18 INFO - 'TERM': 'linux', 18:11:18 INFO - 'TMOUT': '86400', 18:11:18 INFO - 'USER': 'cltbld', 18:11:18 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1459559316.70669-633906442', 18:11:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:11:18 INFO - '_': '/tools/buildbot/bin/python'} 18:11:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:11:18 INFO - Downloading/unpacking jsonschema 18:11:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:11:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:11:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:11:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:11:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:11:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:11:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:11:20 INFO - Downloading/unpacking functools32 (from jsonschema) 18:11:20 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 18:11:20 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 18:11:20 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 18:11:20 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 18:11:20 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 18:11:20 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 18:11:20 INFO - Downloading functools32-3.2.3-2.tar.gz 18:11:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:11:20 INFO - warning: no files found matching '*.txt' 18:11:20 INFO - no previously-included directories found matching 'build' 18:11:20 INFO - no previously-included directories found matching 'dist' 18:11:20 INFO - no previously-included directories found matching '.git*' 18:11:20 INFO - Installing collected packages: jsonschema, functools32 18:11:20 INFO - Running setup.py install for functools32 18:11:20 INFO - warning: no files found matching '*.txt' 18:11:20 INFO - no previously-included directories found matching 'build' 18:11:20 INFO - no previously-included directories found matching 'dist' 18:11:20 INFO - no previously-included directories found matching '.git*' 18:11:20 INFO - Successfully installed jsonschema functools32 18:11:20 INFO - Cleaning up... 18:11:20 INFO - Return code: 0 18:11:20 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 18:11:20 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')]} 18:11:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:11:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:11:20 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')]} 18:11:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:11:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:11:20 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 0x7f1f76e5af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x274b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28177d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a6640>, '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 0x28a7540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28a79d0>, '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': '5bd038846534b2fdfa68eeae000001e2-1459559316.70669-633906442', '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 18:11:20 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 18:11:20 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 18:11:20 INFO - Using env: {'DISPLAY': ':0', 18:11:20 INFO - 'HOME': '/home/cltbld', 18:11:20 INFO - 'LANG': 'en_US.UTF-8', 18:11:20 INFO - 'LANGUAGE': 'en_US:en', 18:11:20 INFO - 'LOGNAME': 'cltbld', 18:11:20 INFO - 'MAIL': '/var/mail/cltbld', 18:11:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:11:20 INFO - 'MOZ_NO_REMOTE': '1', 18:11:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:11:20 INFO - 'NO_EM_RESTART': '1', 18:11:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:11:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:11:20 INFO - 'PWD': '/builds/slave/test', 18:11:20 INFO - 'SHELL': '/bin/bash', 18:11:20 INFO - 'SHLVL': '1', 18:11:20 INFO - 'TERM': 'linux', 18:11:20 INFO - 'TMOUT': '86400', 18:11:20 INFO - 'USER': 'cltbld', 18:11:20 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1459559316.70669-633906442', 18:11:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:11:20 INFO - '_': '/tools/buildbot/bin/python'} 18:11:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:11:20 INFO - Downloading/unpacking flake8 18:11:20 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 18:11:20 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 18:11:20 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 18:11:20 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 18:11:20 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 18:11:20 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 18:11:22 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 18:11:22 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 18:11:22 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 18:11:22 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 18:11:22 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 18:11:22 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 18:11:22 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 18:11:22 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 18:11:22 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 18:11:22 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 18:11:22 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 18:11:22 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 18:11:22 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 18:11:22 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 18:11:22 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 18:11:22 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 18:11:23 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 18:11:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:11:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:11:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:11:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:11:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:11:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:11:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 18:11:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:11:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:11:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:11:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:11:23 INFO - no previously-included directories found matching 'docs/_build' 18:11:23 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 18:11:23 INFO - Running setup.py install for pep8 18:11:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:11:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:11:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:11:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:11:23 INFO - no previously-included directories found matching 'docs/_build' 18:11:23 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 18:11:23 INFO - Successfully installed flake8 mccabe pyflakes pep8 18:11:23 INFO - Cleaning up... 18:11:23 INFO - Return code: 0 18:11:23 INFO - Running post-action listener: _resource_record_post_action 18:11:23 INFO - Running post-action listener: _start_resource_monitoring 18:11:23 INFO - Starting resource monitoring. 18:11:23 INFO - ##### 18:11:23 INFO - ##### Running install step. 18:11:23 INFO - ##### 18:11:23 INFO - Running pre-action listener: _resource_record_pre_action 18:11:23 INFO - Running main action method: install 18:11:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:11:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:11:23 INFO - Reading from file tmpfile_stdout 18:11:23 INFO - Detecting whether we're running mozinstall >=1.0... 18:11:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:11:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:11:24 INFO - Reading from file tmpfile_stdout 18:11:24 INFO - Output received: 18:11:24 INFO - Usage: mozinstall [options] installer 18:11:24 INFO - Options: 18:11:24 INFO - -h, --help show this help message and exit 18:11:24 INFO - -d DEST, --destination=DEST 18:11:24 INFO - Directory to install application into. [default: 18:11:24 INFO - "/builds/slave/test"] 18:11:24 INFO - --app=APP Application being installed. [default: firefox] 18:11:24 INFO - mkdir: /builds/slave/test/build/application 18:11:24 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'] 18:11:24 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 18:11:39 INFO - Reading from file tmpfile_stdout 18:11:39 INFO - Output received: 18:11:39 INFO - /builds/slave/test/build/application/firefox/firefox 18:11:39 INFO - Running post-action listener: _resource_record_post_action 18:11:39 INFO - ##### 18:11:39 INFO - ##### Running run-tests step. 18:11:39 INFO - ##### 18:11:39 INFO - Running pre-action listener: _resource_record_pre_action 18:11:39 INFO - Running main action method: run_tests 18:11:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:11:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:11:39 INFO - Python 2.7.3 18:11:39 INFO - Return code: 0 18:11:39 INFO - grabbing minidump binary from tooltool 18:11:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:11:39 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 0x28a6640>, '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 0x28a7540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28a79d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:11:39 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 18:11:39 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 18:11:39 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:11:39 INFO - Return code: 0 18:11:39 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:11:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:11:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:11:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:11:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:11:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 18:11:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 18:11:40 INFO - Return code: 0 18:11:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ccpaxqcLQbOMDNmQGQ49FQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--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 18:11:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ccpaxqcLQbOMDNmQGQ49FQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-039 --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 18:11:40 INFO - Using env: {'DISPLAY': ':0', 18:11:40 INFO - 'HOME': '/home/cltbld', 18:11:40 INFO - 'LANG': 'en_US.UTF-8', 18:11:40 INFO - 'LANGUAGE': 'en_US:en', 18:11:40 INFO - 'LOGNAME': 'cltbld', 18:11:40 INFO - 'MAIL': '/var/mail/cltbld', 18:11:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:11:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:11:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:11:40 INFO - 'MOZ_NO_REMOTE': '1', 18:11:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:11:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:11:40 INFO - 'NO_EM_RESTART': '1', 18:11:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:11:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:11:40 INFO - 'PWD': '/builds/slave/test', 18:11:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:11:40 INFO - 'SHELL': '/bin/bash', 18:11:40 INFO - 'SHLVL': '1', 18:11:40 INFO - 'TERM': 'linux', 18:11:40 INFO - 'TMOUT': '86400', 18:11:40 INFO - 'USER': 'cltbld', 18:11:40 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1459559316.70669-633906442', 18:11:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:11:40 INFO - '_': '/tools/buildbot/bin/python'} 18:11:40 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ccpaxqcLQbOMDNmQGQ49FQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--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 18:11:40 INFO - mozversion application_buildid: 20160401173744 18:11:40 INFO - mozversion application_changeset: 7e4c0bee56f35104a4809121e8672f1e659258f5 18:11:40 INFO - mozversion application_display_name: Nightly 18:11:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:11:40 INFO - mozversion application_name: Firefox 18:11:40 INFO - mozversion application_remotingname: firefox 18:11:40 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 18:11:40 INFO - mozversion application_vendor: Mozilla 18:11:40 INFO - mozversion application_version: 48.0a1 18:11:40 INFO - mozversion platform_buildid: 20160401173744 18:11:40 INFO - mozversion platform_changeset: 7e4c0bee56f35104a4809121e8672f1e659258f5 18:11:40 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 18:11:40 INFO - mozversion platform_version: 48.0a1 18:11:40 INFO - using testdate: 1459559500 18:11:40 INFO - actual date: 1459559500 18:11:40 INFO - starting webserver on 'localhost:40130' 18:11:40 INFO - SUITE-START | Running 2 tests 18:11:40 INFO - TEST-START | dromaeo_css 18:11:40 INFO - operating with platform_type : linux_ 18:11:40 INFO - Initialising browser for dromaeo_css test... 18:11:40 INFO - TEST-INFO | started process 12370 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIEhQAj/profile http://localhost:40130/getInfo.html) 18:11:45 INFO - PROCESS | 12370 | __metrics Screen width/height:1600/1200 18:11:45 INFO - PROCESS | 12370 | colorDepth:24 18:11:45 INFO - PROCESS | 12370 | Browser inner width/height: 1024/697 18:11:45 INFO - PROCESS | 12370 | __metrics 18:11:46 ERROR - PROCESS | 12370 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 18:11:47 INFO - TEST-INFO | 12370: exit 0 18:11:47 INFO - Browser initialized. 18:11:47 INFO - Running cycle 1/1 for dromaeo_css test... 18:11:47 INFO - TEST-INFO | started process 12452 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIEhQAj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:11:59 INFO - PROCESS | 12452 | RSS: Main: 154677248 18:11:59 INFO - PROCESS | 12452 | 18:12:50 INFO - PROCESS | 12452 | 1459559570106 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] 18:15:01 INFO - PROCESS | 12452 | Cycle 1(1): loaded http://localhost:40130/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40130/tests/dromaeo/cssquery-ext.html) 18:15:02 INFO - PROCESS | 12452 | RSS: Main: 265424896 18:15:02 INFO - PROCESS | 12452 | 18:18:04 INFO - PROCESS | 12452 | Cycle 1(1): loaded http://localhost:40130/tests/dromaeo/cssquery-ext.html (next: http://localhost:40130/tests/dromaeo/cssquery-jquery.html) 18:18:05 INFO - PROCESS | 12452 | RSS: Main: 239874048 18:18:05 INFO - PROCESS | 12452 | 18:21:07 INFO - PROCESS | 12452 | Cycle 1(1): loaded http://localhost:40130/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40130/tests/dromaeo/cssquery-mootools.html) 18:21:07 INFO - PROCESS | 12452 | RSS: Main: 243355648 18:21:07 INFO - PROCESS | 12452 | 18:24:09 INFO - PROCESS | 12452 | Cycle 1(1): loaded http://localhost:40130/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40130/tests/dromaeo/cssquery-prototype.html) 18:24:10 INFO - PROCESS | 12452 | RSS: Main: 210100224 18:24:10 INFO - PROCESS | 12452 | 18:27:13 INFO - PROCESS | 12452 | Cycle 1(1): loaded http://localhost:40130/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40130/tests/dromaeo/cssquery-yui.html) 18:27:13 INFO - PROCESS | 12452 | RSS: Main: 202469376 18:27:13 INFO - PROCESS | 12452 | 18:30:16 INFO - PROCESS | 12452 | Cycle 1(1): loaded http://localhost:40130/tests/dromaeo/cssquery-yui.html (next: http://localhost:40130/tests/dromaeo/cssquery-dojo.html) 18:30:16 INFO - PROCESS | 12452 | RSS: Main: 242704384 18:30:16 INFO - PROCESS | 12452 | 18:30:16 INFO - PROCESS | 12452 | __start_tp_report 18:30:16 INFO - PROCESS | 12452 | _x_x_mozilla_page_load 18:30:16 INFO - PROCESS | 12452 | _x_x_mozilla_page_load_details 18:30:16 INFO - PROCESS | 12452 | |i|pagename|runs| 18:30:16 INFO - PROCESS | 12452 | |0;dojo.html;2636.828606140601;2716.130838131797;2722.006467639312;2730.7132751061126;2766.11484325016;4517.796699148538;4607.401037865081;4622.884427889305;4656.976715116424;4668.486466488688;4607.516210797869;4612.469565999911;4664.813407463697;4693.037927224919;4734.076855013273;4224.514180869209;4227.471566054243;4275.25183092959;4299.8065087071;4406.735595864242;4329.870103896888;4353.912921741579;4365.497967733703;4387.62705170061;4407.250767369539;4138.006878349204;4209.3054645983375;4234.428352172448;4242.257604919127;4304;4246.299360605496;4247.426597409341;4262.893427664302;4287.957120428819;4308.159908817782;4225.514065882432;4226.323788193874;4229.238737027334;4270.957290427087;4273.957260427387;4436.889077773049;4493.213687604656;4510.819567217307;4533.591976722111;4585.105904348653;4973.32860063894;4974.651774375795;4977.228529577885;5003.17447621142;5022.59819214462;4989.101961646902;4992.151334273146;5000.324956130912;5004.8999020019755;5036.043151801183;4627.953720462752;4628.0281140960105;4629.0279041401345;4634.328022436728;4707.223308154116;5023.14606516893;5034.0686972910125;5053.292539044537;5056.115179843513;5108;4830.516948305141;4841.2496063110275;4847.903041939141;4848.03039392123;4892.339534162842;4848.369711937426;4917.434495033117;4939.209726443752;5018.673786203885;5045.899082018339;4875.658703890694;4888.340074089952;4896.95103048972;4896.975515122402;4946.505349465025;4875.853724388274;4879.634027447955;4884.5603895649565;4889.584385327216;4929.112759703288;4124.13393187428;4159.417681524589;4185.434966279574;4240.978795106004;4267.4025636410925;3666.9816650916573;3671.6879065279218;3681.963180368162;3718.6095459976855;3723.590405055442;4294.484661840599;4302.913941721148;4304.913901721948;4309.181255561433;4344.869653910388;4838.879028024257;4928.507149285115;4934.963657631937;4995.400551933719;5000.649954503223;4245.214635292481;4248.214080395137;4254.936175957363;4258.957410425856;4272.636825869774;4374.21264172452;4440.62254708347;4442.400275962768;4483.910321793546;4484.282514797616;4596.954030459719;4650.953490465052;4688.413948256468;4691.225947718588;4694.201985662377;4872.342233798534;4876.487968763229;4891.046245981999;4897.46127925935;4941.407031156285;4588;4635.281531362644;4643.117807616542;4662.976685116552;4674.252119660838;4859.586935110555;4894.216925291937;4919.311296418576;4936.210206367107;4968.453470118357;4879.73161476108;4922.852314430573;4927.9507204927495;4932.556069953722;4943.802247910044;4757.619390448686;4781.641376896677;4808.711477311373;4811.711297322032;4865.537773911473;4815.783289751899;4821.807127714852;4845.1520983828395;4849.878753031202;4893.241547560134;4762.809487620457;4762.904741905073;4764.547368000034;4793.784279707491;4793.904121917472;4807.351007614067;4859.4654587996;4882.194437917704;4925.16272233714;4927.211646136601;4743.146233677833;4759.595434387978;4762.738049407316;4792.137415265286;4806.47128815837 18:30:16 INFO - PROCESS | 12452 | |1;ext.html;533.6424595521;535.2559941681064;537.9004884096443;548.7311217503424;557.0585710149849;26377.076802311898;33930.66069339306;34666.8266658667;34700.182979872254;34790;37596.436053459154;38047.61952380475;38111.42832857509;38136.80931595345;38262.234755304875;7427.517211381243;7611.3910887128895;7616.581088040156;7617.314441700246;7617.3525250353505;7555.320021198091;7679.155292917774;7679.308862202401;7683.923160768405;7868.488548244374;7843.33331666809;7905.130435652074;7925.603719814015;7927.28654421102;7928.127905930343;7787.61061946906;7801.687932482722;7846.725364612211;7873.921260787433;7875.173106823787;7733.7679869604;7858.803529911798;7876.606169691549;7882.172371900925;7883.487573307774;38201;38277.80861095677;38296.234075318614;38513;38673.22653546942;3319.4356959316974;3708.8331025103935;3764.1154328732728;3844.9807750961068;3959.3467077932105;28528.857355713295;28970.565441518393;29251;29441.411171776446;30084.24789380261;3429.240299773331;3442.845071971767;3494.947575786365;3578.982105089484;3614.6746792788776;232489;232514.8374258135;232517;232654;233193;41290.587094129274;42021.78989105035;52484.21273680898;52752.736236318575;52781.2082818758;40895.591044089175;40928.38607420891;41054.79472602618;41105.383419248734;41130.79434602808;13672.93163534176;13874.098183618235;13900.37448314808;13906.721865562835;13938.512152074629;9931.65239216624;9951.900480995097;9956.452395118338;9956.751081223027;10071.59713611462;14528.782068268985;14581.125132492085;14613.086345981603;14637.341319640642;14713.264336783119;5599.468050535193;5712.65724056558;5748.7125643717645;5901.76392944286;5905.173275741399;900.8603666431713;901.9458832470073;909.2226146644524;964.609333220033;1058.6506452870535;26476;26527.07155249557;27080;27118.86440567824;27156.456870862472;790.707438247852;923.2567782934668;958.1424624960621;962.9903700963041;981.6269817469316;12583.433745481476;12641;12830.743385132431;12878.871211287955;12979.610611681665;288118;291148;292633;294370;294973;41177;41367.379489307685;41707.165856682695;42332.153356932686;42472.36291455631;1068.1294744782977;1244.5146392906593;1252.1110011891476;1258.7104965857905;1263.3746295583744;24069.51860962806;25488.617670734584;26798.464030719668;26987.865060674572;27113.322166945196;35474;35780.4632930501;35803.641963580034;35844.462333065545;36419.63580364163;163689;167065;176194;178371;179324;31740.523892142097;31782;32281.838590806896;32390.19024524406;32672.34655306833;39921.2015759689;40117.19765604613;40273.77809775269;40774;41096;34545.30909381748;34602.13494662553;34773.304533908675;34788.65211347854;34791.4781278276;33424.33151337008;33780.324393512485;34337.484937726455;34398.82800585981;34492.82753586216;34222.14444638805;34485.13787155341;34751;34871.65128348684;34879;29484.410311793214;30584.08247752571;30774.384512310076;30809;30847.84576077105;24123.75876241215;24410.633840492763;24466.63300050465;24936.750632494168;24971.875140624907 18:30:16 INFO - PROCESS | 12452 | |2;jquery.html;348.34684965689326;352.59275536755047;353.71172494417067;359.98020108894;362.0748986339902;15416.69166616667;15991.360345586178;16109.677806443879;16806.243719032642;16808.831911680878;10241.28311018229;10521.053105220528;12773.872261277384;15626.453074142379;15656.921715391407;4381.759003254828;4616.053708989666;4617.330487079372;4619.145458090247;4636.814527418899;3376.206591451007;3561.465780132975;3605.4231322988326;5183.999999999981;5226.764795584208;5172.586193104543;5175.637705360627;5185.170372740362;5211.583073354142;5218.712970786605;4949.82675606352;5169.922451163236;5179.19722443022;5278;5289.233061206103;5082.161443361841;5102.770375333119;5107.61692873036;5159.509846564571;5159.819406320761;12049.879501204963;12175.756484870253;17223.655526889394;17981.190846411944;17983.64032719338;1832.239620557467;1919.4721451600922;1949.3274820187012;2209.3482422685347;2211.977880221193;8717.389782715212;9515.714528564155;12321.815172772416;12616;12887.806682899763;1732.9913350433167;1765.6910040742946;1789.9552511187194;1795.1203910083964;1829.039754129093;57591;59950;60400.69799651018;61675.69162154206;63201.36798632001;9451.196648284973;9455.621775128919;9513.714588562354;9587.568559414844;9634.566444510014;12882.871171288354;12955.676108097374;12986.870131298567;13002.609921702364;13015.154014988995;7021.648917554102;7056.470764692669;7269.563826170447;7329.617874190909;7343.48595598303;6963.651817409109;6968.547044442095;6978.337057979484;7032.05067315916;7043;4084.36692312692;4107.609777071173;4141;4189.2040512302565;4237.300845360543;1702.5318037539776;1737.5916659584987;1756.8418842304254;1757.165346460421;1791.578978939948;824.6000689665508;837.1795640272445;923.2060428031887;957.1529196661005;974.2790335152079;15624.687506250038;15904.840951590568;16008;16134.75797863033;16271.430499932445;887.8046829697586;897.9191872731485;916.9449833010041;920.9769755756159;964.1081999150757;9132.726018219464;9186.173244408035;9242.445453272825;9357.39176953496;9368.216611447493;373045;400393;401280;406104;408791;49434.752826235635;58971.11543326853;59238.70380648069;68334.65832670804;72998.63500682569;864.1747131489412;873.7946582553095;885.0662551008747;889.9332550058772;896.4397251717677;11435.714107147054;14055.578332650037;14166.433342666178;14198.787018194942;14317.85682143207;28657.713422865505;28677.569836452054;29063.418731624824;30077;32209;41522.169556608096;41786;41801.79099104485;42026.159476810906;42185.789071055675;7489.962550187214;7561.432892532972;7676.923230767844;7684.6157692116285;7736.535807851547;8594.398392112742;11328.660140195807;11674.70813229676;12020.819687704867;12338.50645974151;10097.5456104474;10411.843822342822;10452.372857628567;10488.737781555217;10645.8935410648;9970;10016.449095299828;10106.090451859369;10114.494275286059;10118.6458473956;10563.894361056598;10643.414612196404;10802.67591972242;10875.945620271848;11032.117430605693;7574.431917606312;7602.885956710543;7690.500117492345;7710.961445192738;7883.921160788548;9329.300302477477;10363.844542332023;10429.895701042893;10441.791164176826;10502.947485262524 18:30:16 INFO - PROCESS | 12452 | |3;mootools.html;1288.3107537467456;1372.1492674541782;1388.7361401333749;1501.4219525482692;1737.0185844997584;6568.540202185843;7155.105611798525;7275.818104547389;7294.088238970129;7299.8540029199385;7098.538594991322;7263.455240856931;7267;7267.27327267273;7270.563766174033;1915.9233630654758;2184.137265780016;2240.955180896385;2251.167068184766;2271.46620544172;2277.4534111813127;2285.7828506291876;2288.324944141474;2288.3592594073684;2289.347535952254;2151.376100930736;2219.056900817154;2219.9889000554977;2220.0675716199235;2221.1670623516184;2239.675247089163;2254.0645632062674;2261.6268315727884;2278.40761402035;2283.303592404316;2180.5420861619077;2190.9780902190932;2200.5158865049825;2200.878951657658;2269.5687819314276;7667.961660191719;7748.573828439434;7752.457327987043;7758.650860711282;7759.30166285037;4338.934915976263;4451.666125040635;4462.419885414908;4464.129494748526;4465.799039043251;2962.3630919352445;3047.6495203051713;3065.9846700766575;3094.90715278542;3107.5494053362363;962.1244667352745;967.4727273635885;973.8198433289864;999.4602914426201;1035.8653375061194;9866.950665246699;9867.259955503367;9868.703938881774;9891;9902.801943961153;3985.282649123186;4064.7967601620394;4110.671146308288;4134.545200027995;4137.089840235143;8437.029741579674;8457.281131103926;8464.492130472192;8486.23623873842;8500.064992850781;3879.165979314461;4362.498312694081;4377.715448495837;4387.298032314814;4395.934060989088;3509.175343794206;3551.662592053751;3552.0587044433246;3970.7617542947514;4136.110736191673;3562.6437356264164;3624.7643903146213;3646.9635303647156;3674.595794462607;3691.90770230741;1139.7948369293606;1151.067635215478;1159.09590519395;1170.2919733561073;1171.2211379432752;1037.180627304436;1038.6053299746047;1183.9931316418588;1230.028277660638;1241.9130660853834;7069.82325441868;7275.67259473325;7307.744228951961;7327.926720732831;7347.55914645123;1048.1771809129796;1049.7742985258205;1065.2198754925003;1068.3089924311485;1079.4656644960637;5644.689542075143;5727;5783.71081445926;5785.913211301834;5791.044477661138;9053.728388148365;9282.489463079595;9393.060693930553;9506.096920792514;9522.85725712919;9188.586513606904;9308.208802251884;9391.201747851372;9410.341276110743;9427.010163932826;7175.425965922714;7232.927670723226;7296.452766042462;7324.816879578053;7418.36943859778;6988.650567471708;7022.262662420372;7026.1217347831525;7030.753923612649;7076.256993015865;8209.58952052383;8284.420090593601;8482.448640838325;8489.278411335106;8537.701180458655;8070.152633973348;8133.918660813553;8141.837163256583;8278.296344810758;8280.089190189196;6216.595921265103;6364.268109167319;6368;6411.935880641134;6425.06836508713;6912.239653638197;6912.619805910723;6940.13248343957;6944.548604340702;6944.965275173592;6205.689715514297;6308.495320374451;6333.081703153109;6403.775867844603;6442.291347951816;6298.527610429144;6322.652254126067;6348.079528468438;6370.108184854032;6576.44100251484;6714.83212919681;6741.561798483083;6753;6759.763408280686;6769.086173366532;6082.057281121433;6282.465990390685;6282.905756413749;6291.056341548804;6304.842378940563;6334.353068202208;6358.650274234961;6381.29805721361;6388.233411990405;6412.134361861089 18:30:16 INFO - PROCESS | 12452 | |4;prototype.html;321.57061860032167;321.6333379946861;321.7217107202268;327.97048265656093;330.18444442227707;5349.8127565535215;5362.249285100089;5390.568754499641;5396.730163491829;5417.756200970956;5313.814016509423;5335.226392173133;5343.839684809453;5353;5354;3968.583298753633;4075.857344992926;4163.479565054368;4197.958020419803;4205.957940420602;4176.916461670765;4188.958110418903;4211.810468528908;4217.873463796076;4218.303979843322;4169.770662613555;4172.645325147366;4173.6661067114555;4181;4182.121754431558;3961.841526338943;4058.228936502055;4146.564610715892;4151.356539736345;4164.83340666373;3688.3360995020885;3692.8892133236045;3696.5194524711883;3700.2599480104086;3705.7591256568235;5093.032323858455;5098.566621837148;5100.719460429675;5104.081265372231;5104.846854594368;4812.013537224861;4822.541858523435;4825.252085926687;4825.782839772219;4829.251466022772;5608;5625.156226566007;5628.831135065954;5629.774809007635;5631.2397826293745;4052.615001574846;4061.1877624475223;4064.2074795414906;4065.125997910434;4068.0643452005907;5674.602777805555;5914.349421563625;5921.111833225008;5921.141434491975;5948.702564871783;3935.9803200984384;4026.979865100656;4028.3957406389277;4029.315016447211;4036.919261614751;4084.305668036441;4088.7342322748927;4088.7751173685137;4089.5501494835544;4090.3046482098116;4683.695559788603;4688.742119183477;4690.835820746258;4692.1084993851055;4699.765011749399;5574.721263936868;5599;5604.60767746262;5621.381648018714;5623.746931388097;1483.391809358158;1499.520153550875;1501.129344979909;1504.0749938787785;1509.622594351412;945.1871390604075;988.471167925171;1011.4184344002228;1025.8102251083574;1037.865077539915;4833.951660483421;4834.468208497063;4841.733704646208;4864.927026094611;4881.096997055556;5765.538756899438;5769.942300577024;5769.971150144306;5774.797882074107;5782.59521833476;4857.635677324215;4867.7322747249245;4871.585915197177;4878.341423907798;4884.12085824555;3047.8933237336587;3099;3103.069079276208;3104.674009229044;3105.4254962831496;5423.050966080999;5436.048691478975;5448.318960129984;5448.509634132947;5450.209719590637;5730.255066841284;5890.3815099414805;5898.3216930053595;5898.380670029671;5916.2013128228;5382.41218840443;5396.595255355864;5410.945890541123;5417.918731219113;5422.918656220081;5749.655020698771;5753.338366087954;5755.568332375173;5764.250647415809;5765.106408506688;5609.046462101534;5616.4383561645145;5616.5787565931905;5619.353774316006;5621.128725047624;5390.460953904735;5408.405075441619;5413.918791218056;5414.485623865727;5421.3765416975975;3873.1091848874353;4018.5378681452007;4043.474348334698;4049.4735684360844;4182.393552934868;5724.542036637143;5758.309002919509;5758.3090029196765;5763;5770.3652598215;5563.638363506359;5573.052581061311;5582.581306401955;5583.888322233452;5586.13414920688;5557.44425557441;5589.496945274945;5591.356993945748;5594.049011667945;5597.972010139923;5482.095454250004;5482.643628164156;5497.257870187474;5498.532624726943;5498.642588231752;5447.536959358499;5621.55027597783;5666.433356664301;5682.204491371294;5685.77256909719;5468.425815289337;5515.09001014828;5528.806491772769;5534.1975413564005;5551.417101204315 18:30:16 INFO - PROCESS | 12452 | |5;yui.html;679.3444326225192;682.8463595690969;738.8596166728324;741.8034220931453;800.6797281087564;12634.052446066537;12794.744105117892;12811.935940320309;12844.422001009954;12863.099583029192;11965.22226055308;12034.09744269179;12056.879431205685;12067.879321206785;12068.939655301732;655.3381085104055;795.32397462157;813.3127507256359;831.6590198018813;834.1616675241374;809.0897740042452;822.5722624235394;825.5789547330844;828.200786241277;828.2918105020211;870.0255713600744;875.9912400875974;876.1676407412951;876.5836227791812;876.7808047988003;689.2074114768006;842.6460886427715;851.1573542193246;853.5134973065356;853.9871901921476;621.7233331167632;623.8939380305359;625.4808508937571;626.7023163997111;627.0061951806392;12627.93686031564;12667.746645067047;12697.238165710087;12715.427805748763;12719.618411447578;12220.877791222063;12632.11575189728;12824.422900969386;12996.090273680846;13019.283939383331;10086.495675216283;10143.391396516232;10175;10252.94873525635;10532.104771094466;3406.131436483681;3437.295354452331;3462.3594634992605;3469.809160496172;3548.6451354864566;41662.37506437406;41824.58175418237;41851.58148418507;41992;42661.99999999969;9719.757006074904;9799.510024498746;9847.901520984842;10042.146417554444;10068.144207742424;18148.63702725938;18149.909250453664;18153;18179.63640727178;18239.63520729578;6771.52599318043;6827.112475378169;6894.758683446055;7117.3238542338395;7276.490645654753;3451.447768357051;3463.341965026637;3482.3557641835837;3491.633378495272;3503.2993401319836;2717.55160398532;2753.8347699138117;2753.8898444062015;2753.8898444062415;2761.8619069046867;448.2827476038378;453.2951260789504;461.2044223714066;463.87707257576767;464.4844222912564;550.7163810637525;624.1168746224042;629.8519847835755;630.5523078614143;633.8827316946288;8064.274215320649;8156.265936065783;8264.256216940505;8290.91409366958;8309.335253179732;534.286727219159;575.4878158438993;616.8827922694763;626.1421852062704;636.2365161805759;3647.379945409287;3773.1510410158044;3921.745086569364;3928.273269445162;4008.198360327946;48734.75632621814;50101;50200.49799502031;51099.74450127726;51111.23333150006;45575;45959.77020114878;46136;46207.76896115565;46387.76806115948;41601.37597936033;41777;41920.37119443211;41950.37074443886;42227;7524.623768811647;7563.394928405604;7643.503172293783;7656.081270247606;7744.728934487266;30615.54076688807;31239;31387;31579;31727.52408713825;36440.81779591085;39986.400203997546;40531;40894.38658420066;40930.59069409268;10077.949610251902;10078.79842403133;10139.645112421325;10177.389356638625;10470.371777693363;10476.214283928888;10604.840927385942;10640.733981650521;10684.198685098803;11945.940270298594;11079.169062320198;11215.831762523405;11225.4387280634;11249.66251012471;11480.655580332603;10754.193435492525;10903;11064.612738554111;11078.937552759195;11488.253263537843;10908.563657453931;11012.834807478055;11014.39420831862;11326.32042077478;11597.76804463923;9590.856137157809;9598;9626.47054412014;9987.450690212108;10244.692659220234;9506.667266645634;9659.661911833053;9698.440519527088;9712.125908668253;9881.110700037032 18:30:16 INFO - PROCESS | 12452 | __end_tp_report 18:30:16 INFO - PROCESS | 12452 | __start_cc_report 18:30:16 INFO - PROCESS | 12452 | _x_x_mozilla_cycle_collect,1075 18:30:16 INFO - PROCESS | 12452 | __end_cc_report 18:30:16 INFO - PROCESS | 12452 | __startTimestamp1459560616636__endTimestamp 18:30:16 INFO - PROCESS | 12452 | 18:30:16 INFO - PROCESS | 12452 | ------- Summary: start ------- 18:30:16 INFO - PROCESS | 12452 | Number of tests: 6 18:30:16 INFO - PROCESS | 12452 | 18:30:16 INFO - PROCESS | 12452 | [#0] dojo.html Cycles:165 Average:4580.32 Median:4694.20 stddev:458.04 (9.8%) stddev-sans-first:433.33 18:30:16 INFO - PROCESS | 12452 | Values: 2636.8 2716.1 2722.0 2730.7 2766.1 4517.8 4607.4 4622.9 4657.0 4668.5 4607.5 4612.5 4664.8 4693.0 4734.1 4224.5 4227.5 4275.3 4299.8 4406.7 4329.9 4353.9 4365.5 4387.6 4407.3 4138.0 4209.3 4234.4 4242.3 4304.0 4246.3 4247.4 4262.9 4288.0 4308.2 4225.5 4226.3 4229.2 4271.0 4274.0 4436.9 4493.2 4510.8 4533.6 4585.1 4973.3 4974.7 4977.2 5003.2 5022.6 4989.1 4992.2 5000.3 5004.9 5036.0 4628.0 4628.0 4629.0 4634.3 4707.2 5023.1 5034.1 5053.3 5056.1 5108.0 4830.5 4841.2 4847.9 4848.0 4892.3 4848.4 4917.4 4939.2 5018.7 5045.9 4875.7 4888.3 4897.0 4897.0 4946.5 4875.9 4879.6 4884.6 4889.6 4929.1 4124.1 4159.4 4185.4 4241.0 4267.4 3667.0 3671.7 3682.0 3718.6 3723.6 4294.5 4302.9 4304.9 4309.2 4344.9 4838.9 4928.5 4935.0 4995.4 5000.6 4245.2 4248.2 4254.9 4259.0 4272.6 4374.2 4440.6 4442.4 4483.9 4484.3 4597.0 4651.0 4688.4 4691.2 4694.2 4872.3 4876.5 4891.0 4897.5 4941.4 4588.0 4635.3 4643.1 4663.0 4674.3 4859.6 4894.2 4919.3 4936.2 4968.5 4879.7 4922.9 4928.0 4932.6 4943.8 4757.6 4781.6 4808.7 4811.7 4865.5 4815.8 4821.8 4845.2 4849.9 4893.2 4762.8 4762.9 4764.5 4793.8 4793.9 4807.4 4859.5 4882.2 4925.2 4927.2 4743.1 4759.6 4762.7 4792.1 4806.5 18:30:16 INFO - PROCESS | 12452 | 18:30:16 INFO - PROCESS | 12452 | [#1] ext.html Cycles:180 Average:38727.68 Median:19484.47 stddev:62009.71 (318.3%) stddev-sans-first:62117.35 18:30:16 INFO - PROCESS | 12452 | Values: 533.6 535.3 537.9 548.7 557.1 26377.1 33930.7 34666.8 34700.2 34790.0 37596.4 38047.6 38111.4 38136.8 38262.2 7427.5 7611.4 7616.6 7617.3 7617.4 7555.3 7679.2 7679.3 7683.9 7868.5 7843.3 7905.1 7925.6 7927.3 7928.1 7787.6 7801.7 7846.7 7873.9 7875.2 7733.8 7858.8 7876.6 7882.2 7883.5 38201.0 38277.8 38296.2 38513.0 38673.2 3319.4 3708.8 3764.1 3845.0 3959.3 28528.9 28970.6 29251.0 29441.4 30084.2 3429.2 3442.8 3494.9 3579.0 3614.7 232489.0 232514.8 232517.0 232654.0 233193.0 41290.6 42021.8 52484.2 52752.7 52781.2 40895.6 40928.4 41054.8 41105.4 41130.8 13672.9 13874.1 13900.4 13906.7 13938.5 9931.7 9951.9 9956.5 9956.8 10071.6 14528.8 14581.1 14613.1 14637.3 14713.3 5599.5 5712.7 5748.7 5901.8 5905.2 900.9 901.9 909.2 964.6 1058.7 26476.0 26527.1 27080.0 27118.9 27156.5 790.7 923.3 958.1 963.0 981.6 12583.4 12641.0 12830.7 12878.9 12979.6 288118.0 291148.0 292633.0 294370.0 294973.0 41177.0 41367.4 41707.2 42332.2 42472.4 1068.1 1244.5 1252.1 1258.7 1263.4 24069.5 25488.6 26798.5 26987.9 27113.3 35474.0 35780.5 35803.6 35844.5 36419.6 163689.0 167065.0 176194.0 178371.0 179324.0 31740.5 31782.0 32281.8 32390.2 32672.3 39921.2 40117.2 40273.8 40774.0 41096.0 34545.3 34602.1 34773.3 34788.7 34791.5 33424.3 33780.3 34337.5 34398.8 34492.8 34222.1 34485.1 34751.0 34871.7 34879.0 29484.4 30584.1 30774.4 30809.0 30847.8 24123.8 24410.6 24466.6 24936.8 24971.9 18:30:16 INFO - PROCESS | 12452 | 18:30:16 INFO - PROCESS | 12452 | [#2] jquery.html Cycles:180 Average:23010.07 Median:22831.58 stddev:65195.92 (285.6%) stddev-sans-first:65356.61 18:30:16 INFO - PROCESS | 12452 | Values: 348.3 352.6 353.7 360.0 362.1 15416.7 15991.4 16109.7 16806.2 16808.8 10241.3 10521.1 12773.9 15626.5 15656.9 4381.8 4616.1 4617.3 4619.1 4636.8 3376.2 3561.5 3605.4 5184.0 5226.8 5172.6 5175.6 5185.2 5211.6 5218.7 4949.8 5169.9 5179.2 5278.0 5289.2 5082.2 5102.8 5107.6 5159.5 5159.8 12049.9 12175.8 17223.7 17981.2 17983.6 1832.2 1919.5 1949.3 2209.3 2212.0 8717.4 9515.7 12321.8 12616.0 12887.8 1733.0 1765.7 1790.0 1795.1 1829.0 57591.0 59950.0 60400.7 61675.7 63201.4 9451.2 9455.6 9513.7 9587.6 9634.6 12882.9 12955.7 12986.9 13002.6 13015.2 7021.6 7056.5 7269.6 7329.6 7343.5 6963.7 6968.5 6978.3 7032.1 7043.0 4084.4 4107.6 4141.0 4189.2 4237.3 1702.5 1737.6 1756.8 1757.2 1791.6 824.6 837.2 923.2 957.2 974.3 15624.7 15904.8 16008.0 16134.8 16271.4 887.8 897.9 916.9 921.0 964.1 9132.7 9186.2 9242.4 9357.4 9368.2 373045.0 400393.0 401280.0 406104.0 408791.0 49434.8 58971.1 59238.7 68334.7 72998.6 864.2 873.8 885.1 889.9 896.4 11435.7 14055.6 14166.4 14198.8 14317.9 28657.7 28677.6 29063.4 30077.0 32209.0 41522.2 41786.0 41801.8 42026.2 42185.8 7490.0 7561.4 7676.9 7684.6 7736.5 8594.4 11328.7 11674.7 12020.8 12338.5 10097.5 10411.8 10452.4 10488.7 10645.9 9970.0 10016.4 10106.1 10114.5 10118.6 10563.9 10643.4 10802.7 10875.9 11032.1 7574.4 7602.9 7690.5 7711.0 7883.9 9329.3 10363.8 10429.9 10441.8 10502.9 18:30:16 INFO - PROCESS | 12452 | 18:30:16 INFO - PROCESS | 12452 | [#3] mootools.html Cycles:180 Average:5239.45 Median:6327.87 stddev:2707.99 (42.8%) stddev-sans-first:2699.30 18:30:16 INFO - PROCESS | 12452 | Values: 1288.3 1372.1 1388.7 1501.4 1737.0 6568.5 7155.1 7275.8 7294.1 7299.9 7098.5 7263.5 7267.0 7267.3 7270.6 1915.9 2184.1 2241.0 2251.2 2271.5 2277.5 2285.8 2288.3 2288.4 2289.3 2151.4 2219.1 2220.0 2220.1 2221.2 2239.7 2254.1 2261.6 2278.4 2283.3 2180.5 2191.0 2200.5 2200.9 2269.6 7668.0 7748.6 7752.5 7758.7 7759.3 4338.9 4451.7 4462.4 4464.1 4465.8 2962.4 3047.6 3066.0 3094.9 3107.5 962.1 967.5 973.8 999.5 1035.9 9867.0 9867.3 9868.7 9891.0 9902.8 3985.3 4064.8 4110.7 4134.5 4137.1 8437.0 8457.3 8464.5 8486.2 8500.1 3879.2 4362.5 4377.7 4387.3 4395.9 3509.2 3551.7 3552.1 3970.8 4136.1 3562.6 3624.8 3647.0 3674.6 3691.9 1139.8 1151.1 1159.1 1170.3 1171.2 1037.2 1038.6 1184.0 1230.0 1241.9 7069.8 7275.7 7307.7 7327.9 7347.6 1048.2 1049.8 1065.2 1068.3 1079.5 5644.7 5727.0 5783.7 5785.9 5791.0 9053.7 9282.5 9393.1 9506.1 9522.9 9188.6 9308.2 9391.2 9410.3 9427.0 7175.4 7232.9 7296.5 7324.8 7418.4 6988.7 7022.3 7026.1 7030.8 7076.3 8209.6 8284.4 8482.4 8489.3 8537.7 8070.2 8133.9 8141.8 8278.3 8280.1 6216.6 6364.3 6368.0 6411.9 6425.1 6912.2 6912.6 6940.1 6944.5 6945.0 6205.7 6308.5 6333.1 6403.8 6442.3 6298.5 6322.7 6348.1 6370.1 6576.4 6714.8 6741.6 6753.0 6759.8 6769.1 6082.1 6282.5 6282.9 6291.1 6304.8 6334.4 6358.7 6381.3 6388.2 6412.1 18:30:16 INFO - PROCESS | 12452 | 18:30:16 INFO - PROCESS | 12452 | [#4] prototype.html Cycles:180 Average:4649.87 Median:5346.83 stddev:1342.64 (25.1%) stddev-sans-first:1306.51 18:30:16 INFO - PROCESS | 12452 | Values: 321.6 321.6 321.7 328.0 330.2 5349.8 5362.2 5390.6 5396.7 5417.8 5313.8 5335.2 5343.8 5353.0 5354.0 3968.6 4075.9 4163.5 4198.0 4206.0 4176.9 4189.0 4211.8 4217.9 4218.3 4169.8 4172.6 4173.7 4181.0 4182.1 3961.8 4058.2 4146.6 4151.4 4164.8 3688.3 3692.9 3696.5 3700.3 3705.8 5093.0 5098.6 5100.7 5104.1 5104.8 4812.0 4822.5 4825.3 4825.8 4829.3 5608.0 5625.2 5628.8 5629.8 5631.2 4052.6 4061.2 4064.2 4065.1 4068.1 5674.6 5914.3 5921.1 5921.1 5948.7 3936.0 4027.0 4028.4 4029.3 4036.9 4084.3 4088.7 4088.8 4089.6 4090.3 4683.7 4688.7 4690.8 4692.1 4699.8 5574.7 5599.0 5604.6 5621.4 5623.7 1483.4 1499.5 1501.1 1504.1 1509.6 945.2 988.5 1011.4 1025.8 1037.9 4834.0 4834.5 4841.7 4864.9 4881.1 5765.5 5769.9 5770.0 5774.8 5782.6 4857.6 4867.7 4871.6 4878.3 4884.1 3047.9 3099.0 3103.1 3104.7 3105.4 5423.1 5436.0 5448.3 5448.5 5450.2 5730.3 5890.4 5898.3 5898.4 5916.2 5382.4 5396.6 5410.9 5417.9 5422.9 5749.7 5753.3 5755.6 5764.3 5765.1 5609.0 5616.4 5616.6 5619.4 5621.1 5390.5 5408.4 5413.9 5414.5 5421.4 3873.1 4018.5 4043.5 4049.5 4182.4 5724.5 5758.3 5758.3 5763.0 5770.4 5563.6 5573.1 5582.6 5583.9 5586.1 5557.4 5589.5 5591.4 5594.0 5598.0 5482.1 5482.6 5497.3 5498.5 5498.6 5447.5 5621.6 5666.4 5682.2 5685.8 5468.4 5515.1 5528.8 5534.2 5551.4 18:30:16 INFO - PROCESS | 12452 | 18:30:16 INFO - PROCESS | 12452 | [#5] yui.html Cycles:180 Average:12682.13 Median:41800.79 stddev:14099.16 (33.7%) stddev-sans-first:14109.90 18:30:16 INFO - PROCESS | 12452 | Values: 679.3 682.8 738.9 741.8 800.7 12634.1 12794.7 12811.9 12844.4 12863.1 11965.2 12034.1 12056.9 12067.9 12068.9 655.3 795.3 813.3 831.7 834.2 809.1 822.6 825.6 828.2 828.3 870.0 876.0 876.2 876.6 876.8 689.2 842.6 851.2 853.5 854.0 621.7 623.9 625.5 626.7 627.0 12627.9 12667.7 12697.2 12715.4 12719.6 12220.9 12632.1 12824.4 12996.1 13019.3 10086.5 10143.4 10175.0 10252.9 10532.1 3406.1 3437.3 3462.4 3469.8 3548.6 41662.4 41824.6 41851.6 41992.0 42662.0 9719.8 9799.5 9847.9 10042.1 10068.1 18148.6 18149.9 18153.0 18179.6 18239.6 6771.5 6827.1 6894.8 7117.3 7276.5 3451.4 3463.3 3482.4 3491.6 3503.3 2717.6 2753.8 2753.9 2753.9 2761.9 448.3 453.3 461.2 463.9 464.5 550.7 624.1 629.9 630.6 633.9 8064.3 8156.3 8264.3 8290.9 8309.3 534.3 575.5 616.9 626.1 636.2 3647.4 3773.2 3921.7 3928.3 4008.2 48734.8 50101.0 50200.5 51099.7 51111.2 45575.0 45959.8 46136.0 46207.8 46387.8 41601.4 41777.0 41920.4 41950.4 42227.0 7524.6 7563.4 7643.5 7656.1 7744.7 30615.5 31239.0 31387.0 31579.0 31727.5 36440.8 39986.4 40531.0 40894.4 40930.6 10077.9 10078.8 10139.6 10177.4 10470.4 10476.2 10604.8 10640.7 10684.2 11945.9 11079.2 11215.8 11225.4 11249.7 11480.7 10754.2 10903.0 11064.6 11078.9 11488.3 10908.6 11012.8 11014.4 11326.3 11597.8 9590.9 9598.0 9626.5 9987.5 10244.7 9506.7 9659.7 9698.4 9712.1 9881.1 18:30:16 INFO - PROCESS | 12452 | -------- Summary: end -------- 18:30:16 INFO - PROCESS | 12452 | 18:30:17 INFO - TEST-INFO | 12452: exit 0 18:30:17 INFO - TEST-OK | dromaeo_css | took 1116372ms 18:30:17 INFO - TEST-START | kraken 18:30:17 INFO - operating with platform_type : linux_ 18:30:17 INFO - Initialising browser for kraken test... 18:30:17 INFO - TEST-INFO | started process 12637 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoGGMqt/profile http://localhost:40130/getInfo.html) 18:30:21 INFO - PROCESS | 12637 | __metrics Screen width/height:1600/1200 18:30:21 INFO - PROCESS | 12637 | colorDepth:24 18:30:21 INFO - PROCESS | 12637 | Browser inner width/height: 1024/697 18:30:21 INFO - PROCESS | 12637 | __metrics 18:30:22 ERROR - PROCESS | 12637 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 18:30:23 INFO - TEST-INFO | 12637: exit 0 18:30:23 INFO - Browser initialized. 18:30:23 INFO - Running cycle 1/1 for kraken test... 18:30:23 INFO - TEST-INFO | started process 12716 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoGGMqt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:30:35 INFO - PROCESS | 12716 | RSS: Main: 154509312 18:30:35 INFO - PROCESS | 12716 | 18:30:38 INFO - PROCESS | 12716 | Cycle 1(1): loaded http://localhost:40130/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40130/tests/kraken/driver.html?testName=audio-beat-detection) 18:30:38 INFO - PROCESS | 12716 | RSS: Main: 195407872 18:30:38 INFO - PROCESS | 12716 | 18:30:41 INFO - PROCESS | 12716 | Cycle 1(1): loaded http://localhost:40130/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40130/tests/kraken/driver.html?testName=audio-dft) 18:30:42 INFO - PROCESS | 12716 | RSS: Main: 185364480 18:30:42 INFO - PROCESS | 12716 | 18:30:45 INFO - PROCESS | 12716 | Cycle 1(1): loaded http://localhost:40130/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40130/tests/kraken/driver.html?testName=audio-fft) 18:30:45 INFO - PROCESS | 12716 | RSS: Main: 170409984 18:30:45 INFO - PROCESS | 12716 | 18:30:47 INFO - PROCESS | 12716 | Cycle 1(1): loaded http://localhost:40130/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40130/tests/kraken/driver.html?testName=audio-oscillator) 18:30:48 INFO - PROCESS | 12716 | RSS: Main: 171978752 18:30:48 INFO - PROCESS | 12716 | 18:30:50 INFO - PROCESS | 12716 | Cycle 1(1): loaded http://localhost:40130/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40130/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:30:51 INFO - PROCESS | 12716 | RSS: Main: 173973504 18:30:51 INFO - PROCESS | 12716 | 18:30:54 INFO - PROCESS | 12716 | Cycle 1(1): loaded http://localhost:40130/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40130/tests/kraken/driver.html?testName=imaging-darkroom) 18:30:54 INFO - PROCESS | 12716 | RSS: Main: 174305280 18:30:54 INFO - PROCESS | 12716 | 18:30:58 INFO - PROCESS | 12716 | Cycle 1(1): loaded http://localhost:40130/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40130/tests/kraken/driver.html?testName=imaging-desaturate) 18:30:58 INFO - PROCESS | 12716 | RSS: Main: 172134400 18:30:58 INFO - PROCESS | 12716 | 18:31:01 INFO - PROCESS | 12716 | Cycle 1(1): loaded http://localhost:40130/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40130/tests/kraken/driver.html?testName=json-parse-financial) 18:31:02 INFO - PROCESS | 12716 | RSS: Main: 172666880 18:31:02 INFO - PROCESS | 12716 | 18:31:04 INFO - PROCESS | 12716 | Cycle 1(1): loaded http://localhost:40130/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40130/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:31:04 INFO - PROCESS | 12716 | RSS: Main: 184639488 18:31:04 INFO - PROCESS | 12716 | 18:31:06 INFO - PROCESS | 12716 | Cycle 1(1): loaded http://localhost:40130/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40130/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:31:07 INFO - PROCESS | 12716 | RSS: Main: 183611392 18:31:07 INFO - PROCESS | 12716 | 18:31:09 INFO - PROCESS | 12716 | Cycle 1(1): loaded http://localhost:40130/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40130/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:31:09 INFO - PROCESS | 12716 | RSS: Main: 197083136 18:31:09 INFO - PROCESS | 12716 | 18:31:12 INFO - PROCESS | 12716 | Cycle 1(1): loaded http://localhost:40130/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40130/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:31:13 INFO - PROCESS | 12716 | RSS: Main: 202162176 18:31:13 INFO - PROCESS | 12716 | 18:31:15 INFO - PROCESS | 12716 | Cycle 1(1): loaded http://localhost:40130/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40130/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:31:16 INFO - PROCESS | 12716 | RSS: Main: 201084928 18:31:16 INFO - PROCESS | 12716 | 18:31:17 INFO - PROCESS | 12716 | Cycle 1(1): loaded http://localhost:40130/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40130/tests/kraken/driver.html?testName=ai-astar) 18:31:18 INFO - PROCESS | 12716 | RSS: Main: 263360512 18:31:18 INFO - PROCESS | 12716 | 18:31:18 INFO - PROCESS | 12716 | __start_tp_report 18:31:18 INFO - PROCESS | 12716 | _x_x_mozilla_page_load 18:31:18 INFO - PROCESS | 12716 | _x_x_mozilla_page_load_details 18:31:18 INFO - PROCESS | 12716 | |i|pagename|runs| 18:31:18 INFO - PROCESS | 12716 | |0;ai-astar;112;118;109;113;114;114;104;113;115;114 18:31:18 INFO - PROCESS | 12716 | |1;audio-beat-detection;156;129;157;176;133;155;157;132;177;133 18:31:18 INFO - PROCESS | 12716 | |2;audio-dft;162;162;161;162;161;162;161;161;162;162 18:31:18 INFO - PROCESS | 12716 | |3;audio-fft;74;74;105;103;73;74;76;113;99;74 18:31:18 INFO - PROCESS | 12716 | |4;audio-oscillator;96;95;149;95;95;94;137;95;94;137 18:31:18 INFO - PROCESS | 12716 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;118;117;116 18:31:18 INFO - PROCESS | 12716 | |6;imaging-darkroom;145;145;146;147;146;146;146;146;146;146 18:31:18 INFO - PROCESS | 12716 | |7;imaging-desaturate;95;96;95;96;95;95;95;96;95;95 18:31:18 INFO - PROCESS | 12716 | |8;json-parse-financial;67;67;66;66;65;65;66;74;63;63 18:31:18 INFO - PROCESS | 12716 | |9;json-stringify-tinderbox;64;63;63;63;64;63;65;63;64;63 18:31:18 INFO - PROCESS | 12716 | |10;stanford-crypto-aes;90;84;84;83;92;81;83;82;84;83 18:31:18 INFO - PROCESS | 12716 | |11;stanford-crypto-ccm;115;117;125;116;126;119;120;116;127;115 18:31:18 INFO - PROCESS | 12716 | |12;stanford-crypto-pbkdf2;157;138;146;149;144;135;155;140;143;142 18:31:18 INFO - PROCESS | 12716 | |13;stanford-crypto-sha256-iterative;69;69;67;67;70;71;68;68;68;67 18:31:18 INFO - PROCESS | 12716 | __end_tp_report 18:31:18 INFO - PROCESS | 12716 | __start_cc_report 18:31:18 INFO - PROCESS | 12716 | _x_x_mozilla_cycle_collect,1156 18:31:18 INFO - PROCESS | 12716 | __end_cc_report 18:31:18 INFO - PROCESS | 12716 | __startTimestamp1459560678224__endTimestamp 18:31:18 INFO - PROCESS | 12716 | 18:31:18 INFO - PROCESS | 12716 | ------- Summary: start ------- 18:31:18 INFO - PROCESS | 12716 | Number of tests: 14 18:31:18 INFO - PROCESS | 12716 | 18:31:18 INFO - PROCESS | 12716 | [#0] ai-astar Cycles:10 Average:112.60 Median:114.00 stddev:3.78 (3.3%) stddev-sans-first:4.00 18:31:18 INFO - PROCESS | 12716 | Values: 112.0 118.0 109.0 113.0 114.0 114.0 104.0 113.0 115.0 114.0 18:31:18 INFO - PROCESS | 12716 | 18:31:18 INFO - PROCESS | 12716 | [#1] audio-beat-detection Cycles:10 Average:150.50 Median:156.50 stddev:17.96 (11.5%) stddev-sans-first:18.94 18:31:18 INFO - PROCESS | 12716 | Values: 156.0 129.0 157.0 176.0 133.0 155.0 157.0 132.0 177.0 133.0 18:31:18 INFO - PROCESS | 12716 | 18:31:18 INFO - PROCESS | 12716 | [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:0.52 (0.3%) stddev-sans-first:0.53 18:31:18 INFO - PROCESS | 12716 | Values: 162.0 162.0 161.0 162.0 161.0 162.0 161.0 161.0 162.0 162.0 18:31:18 INFO - PROCESS | 12716 | 18:31:18 INFO - PROCESS | 12716 | [#3] audio-fft Cycles:10 Average:86.50 Median:74.00 stddev:16.30 (22.0%) stddev-sans-first:16.65 18:31:18 INFO - PROCESS | 12716 | Values: 74.0 74.0 105.0 103.0 73.0 74.0 76.0 113.0 99.0 74.0 18:31:18 INFO - PROCESS | 12716 | 18:31:18 INFO - PROCESS | 12716 | [#4] audio-oscillator Cycles:10 Average:108.70 Median:95.00 stddev:22.53 (23.7%) stddev-sans-first:23.43 18:31:18 INFO - PROCESS | 12716 | Values: 96.0 95.0 149.0 95.0 95.0 94.0 137.0 95.0 94.0 137.0 18:31:18 INFO - PROCESS | 12716 | 18:31:18 INFO - PROCESS | 12716 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 18:31:18 INFO - PROCESS | 12716 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 118.0 117.0 116.0 18:31:18 INFO - PROCESS | 12716 | 18:31:18 INFO - PROCESS | 12716 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.50 18:31:18 INFO - PROCESS | 12716 | Values: 145.0 145.0 146.0 147.0 146.0 146.0 146.0 146.0 146.0 146.0 18:31:18 INFO - PROCESS | 12716 | 18:31:18 INFO - PROCESS | 12716 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 18:31:18 INFO - PROCESS | 12716 | Values: 95.0 96.0 95.0 96.0 95.0 95.0 95.0 96.0 95.0 95.0 18:31:18 INFO - PROCESS | 12716 | 18:31:18 INFO - PROCESS | 12716 | [#8] json-parse-financial Cycles:10 Average:66.20 Median:66.00 stddev:3.08 (4.7%) stddev-sans-first:3.26 18:31:18 INFO - PROCESS | 12716 | Values: 67.0 67.0 66.0 66.0 65.0 65.0 66.0 74.0 63.0 63.0 18:31:18 INFO - PROCESS | 12716 | 18:31:18 INFO - PROCESS | 12716 | [#9] json-stringify-tinderbox Cycles:10 Average:63.50 Median:63.50 stddev:0.71 (1.1%) stddev-sans-first:0.73 18:31:18 INFO - PROCESS | 12716 | Values: 64.0 63.0 63.0 63.0 64.0 63.0 65.0 63.0 64.0 63.0 18:31:18 INFO - PROCESS | 12716 | 18:31:18 INFO - PROCESS | 12716 | [#10] stanford-crypto-aes Cycles:10 Average:84.60 Median:84.00 stddev:3.53 (4.2%) stddev-sans-first:3.16 18:31:18 INFO - PROCESS | 12716 | Values: 90.0 84.0 84.0 83.0 92.0 81.0 83.0 82.0 84.0 83.0 18:31:18 INFO - PROCESS | 12716 | 18:31:18 INFO - PROCESS | 12716 | [#11] stanford-crypto-ccm Cycles:10 Average:119.60 Median:119.50 stddev:4.72 (3.9%) stddev-sans-first:4.70 18:31:18 INFO - PROCESS | 12716 | Values: 115.0 117.0 125.0 116.0 126.0 119.0 120.0 116.0 127.0 115.0 18:31:18 INFO - PROCESS | 12716 | 18:31:18 INFO - PROCESS | 12716 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.90 Median:145.00 stddev:7.06 (4.9%) stddev-sans-first:5.98 18:31:18 INFO - PROCESS | 12716 | Values: 157.0 138.0 146.0 149.0 144.0 135.0 155.0 140.0 143.0 142.0 18:31:18 INFO - PROCESS | 12716 | 18:31:18 INFO - PROCESS | 12716 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.40 Median:68.50 stddev:1.35 (2.0%) stddev-sans-first:1.41 18:31:18 INFO - PROCESS | 12716 | Values: 69.0 69.0 67.0 67.0 70.0 71.0 68.0 68.0 68.0 67.0 18:31:18 INFO - PROCESS | 12716 | -------- Summary: end -------- 18:31:18 INFO - PROCESS | 12716 | 18:31:19 INFO - TEST-INFO | 12716: exit 0 18:31:19 INFO - TEST-OK | kraken | took 61941ms 18:31:19 INFO - SUITE-END | took 1178s 18:31:19 INFO - Completed test suite (00:19:38) 18:31:19 INFO - javascript benchmark 18:31:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2636.828606140601, 2716.130838131797, 2722.006467639312, 2730.7132751061126, 2766.11484325016, 4517.796699148538, 4607.401037865081, 4622.884427889305, 4656.976715116424, 4668.486466488688, 4607.516210797869, 4612.469565999911, 4664.813407463697, 4693.037927224919, 4734.076855013273, 4224.514180869209, 4227.471566054243, 4275.25183092959, 4299.8065087071, 4406.735595864242, 4329.870103896888, 4353.912921741579, 4365.497967733703, 4387.62705170061, 4407.250767369539, 4138.006878349204, 4209.3054645983375, 4234.428352172448, 4242.257604919127, 4304.0, 4246.299360605496, 4247.426597409341, 4262.893427664302, 4287.957120428819, 4308.159908817782, 4225.514065882432, 4226.323788193874, 4229.238737027334, 4270.957290427087, 4273.957260427387, 4436.889077773049, 4493.213687604656, 4510.819567217307, 4533.591976722111, 4585.105904348653, 4973.32860063894, 4974.651774375795, 4977.228529577885, 5003.17447621142, 5022.59819214462, 4989.101961646902, 4992.151334273146, 5000.324956130912, 5004.8999020019755, 5036.043151801183, 4627.953720462752, 4628.0281140960105, 4629.0279041401345, 4634.328022436728, 4707.223308154116, 5023.14606516893, 5034.0686972910125, 5053.292539044537, 5056.115179843513, 5108.0, 4830.516948305141, 4841.2496063110275, 4847.903041939141, 4848.03039392123, 4892.339534162842, 4848.369711937426, 4917.434495033117, 4939.209726443752, 5018.673786203885, 5045.899082018339, 4875.658703890694, 4888.340074089952, 4896.95103048972, 4896.975515122402, 4946.505349465025, 4875.853724388274, 4879.634027447955, 4884.5603895649565, 4889.584385327216, 4929.112759703288, 4124.13393187428, 4159.417681524589, 4185.434966279574, 4240.978795106004, 4267.4025636410925, 3666.9816650916573, 3671.6879065279218, 3681.963180368162, 3718.6095459976855, 3723.590405055442, 4294.484661840599, 4302.913941721148, 4304.913901721948, 4309.181255561433, 4344.869653910388, 4838.879028024257, 4928.507149285115, 4934.963657631937, 4995.400551933719, 5000.649954503223, 4245.214635292481, 4248.214080395137, 4254.936175957363, 4258.957410425856, 4272.636825869774, 4374.21264172452, 4440.62254708347, 4442.400275962768, 4483.910321793546, 4484.282514797616, 4596.954030459719, 4650.953490465052, 4688.413948256468, 4691.225947718588, 4694.201985662377, 4872.342233798534, 4876.487968763229, 4891.046245981999, 4897.46127925935, 4941.407031156285, 4588.0, 4635.281531362644, 4643.117807616542, 4662.976685116552, 4674.252119660838, 4859.586935110555, 4894.216925291937, 4919.311296418576, 4936.210206367107, 4968.453470118357, 4879.73161476108, 4922.852314430573, 4927.9507204927495, 4932.556069953722, 4943.802247910044, 4757.619390448686, 4781.641376896677, 4808.711477311373, 4811.711297322032, 4865.537773911473, 4815.783289751899, 4821.807127714852, 4845.1520983828395, 4849.878753031202, 4893.241547560134, 4762.809487620457, 4762.904741905073, 4764.547368000034, 4793.784279707491, 4793.904121917472, 4807.351007614067, 4859.4654587996, 4882.194437917704, 4925.16272233714, 4927.211646136601, 4743.146233677833, 4759.595434387978, 4762.738049407316, 4792.137415265286, 4806.47128815837], "unit": "score", "name": "dojo.html", "value": 4552.989415034933}, {"lowerIsBetter": false, "replicates": [533.6424595521, 535.2559941681064, 537.9004884096443, 548.7311217503424, 557.0585710149849, 26377.076802311898, 33930.66069339306, 34666.8266658667, 34700.182979872254, 34790.0, 37596.436053459154, 38047.61952380475, 38111.42832857509, 38136.80931595345, 38262.234755304875, 7427.517211381243, 7611.3910887128895, 7616.581088040156, 7617.314441700246, 7617.3525250353505, 7555.320021198091, 7679.155292917774, 7679.308862202401, 7683.923160768405, 7868.488548244374, 7843.33331666809, 7905.130435652074, 7925.603719814015, 7927.28654421102, 7928.127905930343, 7787.61061946906, 7801.687932482722, 7846.725364612211, 7873.921260787433, 7875.173106823787, 7733.7679869604, 7858.803529911798, 7876.606169691549, 7882.172371900925, 7883.487573307774, 38201.0, 38277.80861095677, 38296.234075318614, 38513.0, 38673.22653546942, 3319.4356959316974, 3708.8331025103935, 3764.1154328732728, 3844.9807750961068, 3959.3467077932105, 28528.857355713295, 28970.565441518393, 29251.0, 29441.411171776446, 30084.24789380261, 3429.240299773331, 3442.845071971767, 3494.947575786365, 3578.982105089484, 3614.6746792788776, 232489.0, 232514.8374258135, 232517.0, 232654.0, 233193.0, 41290.587094129274, 42021.78989105035, 52484.21273680898, 52752.736236318575, 52781.2082818758, 40895.591044089175, 40928.38607420891, 41054.79472602618, 41105.383419248734, 41130.79434602808, 13672.93163534176, 13874.098183618235, 13900.37448314808, 13906.721865562835, 13938.512152074629, 9931.65239216624, 9951.900480995097, 9956.452395118338, 9956.751081223027, 10071.59713611462, 14528.782068268985, 14581.125132492085, 14613.086345981603, 14637.341319640642, 14713.264336783119, 5599.468050535193, 5712.65724056558, 5748.7125643717645, 5901.76392944286, 5905.173275741399, 900.8603666431713, 901.9458832470073, 909.2226146644524, 964.609333220033, 1058.6506452870535, 26476.0, 26527.07155249557, 27080.0, 27118.86440567824, 27156.456870862472, 790.707438247852, 923.2567782934668, 958.1424624960621, 962.9903700963041, 981.6269817469316, 12583.433745481476, 12641.0, 12830.743385132431, 12878.871211287955, 12979.610611681665, 288118.0, 291148.0, 292633.0, 294370.0, 294973.0, 41177.0, 41367.379489307685, 41707.165856682695, 42332.153356932686, 42472.36291455631, 1068.1294744782977, 1244.5146392906593, 1252.1110011891476, 1258.7104965857905, 1263.3746295583744, 24069.51860962806, 25488.617670734584, 26798.464030719668, 26987.865060674572, 27113.322166945196, 35474.0, 35780.4632930501, 35803.641963580034, 35844.462333065545, 36419.63580364163, 163689.0, 167065.0, 176194.0, 178371.0, 179324.0, 31740.523892142097, 31782.0, 32281.838590806896, 32390.19024524406, 32672.34655306833, 39921.2015759689, 40117.19765604613, 40273.77809775269, 40774.0, 41096.0, 34545.30909381748, 34602.13494662553, 34773.304533908675, 34788.65211347854, 34791.4781278276, 33424.33151337008, 33780.324393512485, 34337.484937726455, 34398.82800585981, 34492.82753586216, 34222.14444638805, 34485.13787155341, 34751.0, 34871.65128348684, 34879.0, 29484.410311793214, 30584.08247752571, 30774.384512310076, 30809.0, 30847.84576077105, 24123.75876241215, 24410.633840492763, 24466.63300050465, 24936.750632494168, 24971.875140624907], "unit": "score", "name": "ext.html", "value": 16305.234963391356}, {"lowerIsBetter": false, "replicates": [348.34684965689326, 352.59275536755047, 353.71172494417067, 359.98020108894, 362.0748986339902, 15416.69166616667, 15991.360345586178, 16109.677806443879, 16806.243719032642, 16808.831911680878, 10241.28311018229, 10521.053105220528, 12773.872261277384, 15626.453074142379, 15656.921715391407, 4381.759003254828, 4616.053708989666, 4617.330487079372, 4619.145458090247, 4636.814527418899, 3376.206591451007, 3561.465780132975, 3605.4231322988326, 5183.999999999981, 5226.764795584208, 5172.586193104543, 5175.637705360627, 5185.170372740362, 5211.583073354142, 5218.712970786605, 4949.82675606352, 5169.922451163236, 5179.19722443022, 5278.0, 5289.233061206103, 5082.161443361841, 5102.770375333119, 5107.61692873036, 5159.509846564571, 5159.819406320761, 12049.879501204963, 12175.756484870253, 17223.655526889394, 17981.190846411944, 17983.64032719338, 1832.239620557467, 1919.4721451600922, 1949.3274820187012, 2209.3482422685347, 2211.977880221193, 8717.389782715212, 9515.714528564155, 12321.815172772416, 12616.0, 12887.806682899763, 1732.9913350433167, 1765.6910040742946, 1789.9552511187194, 1795.1203910083964, 1829.039754129093, 57591.0, 59950.0, 60400.69799651018, 61675.69162154206, 63201.36798632001, 9451.196648284973, 9455.621775128919, 9513.714588562354, 9587.568559414844, 9634.566444510014, 12882.871171288354, 12955.676108097374, 12986.870131298567, 13002.609921702364, 13015.154014988995, 7021.648917554102, 7056.470764692669, 7269.563826170447, 7329.617874190909, 7343.48595598303, 6963.651817409109, 6968.547044442095, 6978.337057979484, 7032.05067315916, 7043.0, 4084.36692312692, 4107.609777071173, 4141.0, 4189.2040512302565, 4237.300845360543, 1702.5318037539776, 1737.5916659584987, 1756.8418842304254, 1757.165346460421, 1791.578978939948, 824.6000689665508, 837.1795640272445, 923.2060428031887, 957.1529196661005, 974.2790335152079, 15624.687506250038, 15904.840951590568, 16008.0, 16134.75797863033, 16271.430499932445, 887.8046829697586, 897.9191872731485, 916.9449833010041, 920.9769755756159, 964.1081999150757, 9132.726018219464, 9186.173244408035, 9242.445453272825, 9357.39176953496, 9368.216611447493, 373045.0, 400393.0, 401280.0, 406104.0, 408791.0, 49434.752826235635, 58971.11543326853, 59238.70380648069, 68334.65832670804, 72998.63500682569, 864.1747131489412, 873.7946582553095, 885.0662551008747, 889.9332550058772, 896.4397251717677, 11435.714107147054, 14055.578332650037, 14166.433342666178, 14198.787018194942, 14317.85682143207, 28657.713422865505, 28677.569836452054, 29063.418731624824, 30077.0, 32209.0, 41522.169556608096, 41786.0, 41801.79099104485, 42026.159476810906, 42185.789071055675, 7489.962550187214, 7561.432892532972, 7676.923230767844, 7684.6157692116285, 7736.535807851547, 8594.398392112742, 11328.660140195807, 11674.70813229676, 12020.819687704867, 12338.50645974151, 10097.5456104474, 10411.843822342822, 10452.372857628567, 10488.737781555217, 10645.8935410648, 9970.0, 10016.449095299828, 10106.090451859369, 10114.494275286059, 10118.6458473956, 10563.894361056598, 10643.414612196404, 10802.67591972242, 10875.945620271848, 11032.117430605693, 7574.431917606312, 7602.885956710543, 7690.500117492345, 7710.961445192738, 7883.921160788548, 9329.300302477477, 10363.844542332023, 10429.895701042893, 10441.791164176826, 10502.947485262524], "unit": "score", "name": "jquery.html", "value": 7775.855952478679}, {"lowerIsBetter": false, "replicates": [1288.3107537467456, 1372.1492674541782, 1388.7361401333749, 1501.4219525482692, 1737.0185844997584, 6568.540202185843, 7155.105611798525, 7275.818104547389, 7294.088238970129, 7299.8540029199385, 7098.538594991322, 7263.455240856931, 7267.0, 7267.27327267273, 7270.563766174033, 1915.9233630654758, 2184.137265780016, 2240.955180896385, 2251.167068184766, 2271.46620544172, 2277.4534111813127, 2285.7828506291876, 2288.324944141474, 2288.3592594073684, 2289.347535952254, 2151.376100930736, 2219.056900817154, 2219.9889000554977, 2220.0675716199235, 2221.1670623516184, 2239.675247089163, 2254.0645632062674, 2261.6268315727884, 2278.40761402035, 2283.303592404316, 2180.5420861619077, 2190.9780902190932, 2200.5158865049825, 2200.878951657658, 2269.5687819314276, 7667.961660191719, 7748.573828439434, 7752.457327987043, 7758.650860711282, 7759.30166285037, 4338.934915976263, 4451.666125040635, 4462.419885414908, 4464.129494748526, 4465.799039043251, 2962.3630919352445, 3047.6495203051713, 3065.9846700766575, 3094.90715278542, 3107.5494053362363, 962.1244667352745, 967.4727273635885, 973.8198433289864, 999.4602914426201, 1035.8653375061194, 9866.950665246699, 9867.259955503367, 9868.703938881774, 9891.0, 9902.801943961153, 3985.282649123186, 4064.7967601620394, 4110.671146308288, 4134.545200027995, 4137.089840235143, 8437.029741579674, 8457.281131103926, 8464.492130472192, 8486.23623873842, 8500.064992850781, 3879.165979314461, 4362.498312694081, 4377.715448495837, 4387.298032314814, 4395.934060989088, 3509.175343794206, 3551.662592053751, 3552.0587044433246, 3970.7617542947514, 4136.110736191673, 3562.6437356264164, 3624.7643903146213, 3646.9635303647156, 3674.595794462607, 3691.90770230741, 1139.7948369293606, 1151.067635215478, 1159.09590519395, 1170.2919733561073, 1171.2211379432752, 1037.180627304436, 1038.6053299746047, 1183.9931316418588, 1230.028277660638, 1241.9130660853834, 7069.82325441868, 7275.67259473325, 7307.744228951961, 7327.926720732831, 7347.55914645123, 1048.1771809129796, 1049.7742985258205, 1065.2198754925003, 1068.3089924311485, 1079.4656644960637, 5644.689542075143, 5727.0, 5783.71081445926, 5785.913211301834, 5791.044477661138, 9053.728388148365, 9282.489463079595, 9393.060693930553, 9506.096920792514, 9522.85725712919, 9188.586513606904, 9308.208802251884, 9391.201747851372, 9410.341276110743, 9427.010163932826, 7175.425965922714, 7232.927670723226, 7296.452766042462, 7324.816879578053, 7418.36943859778, 6988.650567471708, 7022.262662420372, 7026.1217347831525, 7030.753923612649, 7076.256993015865, 8209.58952052383, 8284.420090593601, 8482.448640838325, 8489.278411335106, 8537.701180458655, 8070.152633973348, 8133.918660813553, 8141.837163256583, 8278.296344810758, 8280.089190189196, 6216.595921265103, 6364.268109167319, 6368.0, 6411.935880641134, 6425.06836508713, 6912.239653638197, 6912.619805910723, 6940.13248343957, 6944.548604340702, 6944.965275173592, 6205.689715514297, 6308.495320374451, 6333.081703153109, 6403.775867844603, 6442.291347951816, 6298.527610429144, 6322.652254126067, 6348.079528468438, 6370.108184854032, 6576.44100251484, 6714.83212919681, 6741.561798483083, 6753.0, 6759.763408280686, 6769.086173366532, 6082.057281121433, 6282.465990390685, 6282.905756413749, 6291.056341548804, 6304.842378940563, 6334.353068202208, 6358.650274234961, 6381.29805721361, 6388.233411990405, 6412.134361861089], "unit": "score", "name": "mootools.html", "value": 4317.682415862852}, {"lowerIsBetter": false, "replicates": [321.57061860032167, 321.6333379946861, 321.7217107202268, 327.97048265656093, 330.18444442227707, 5349.8127565535215, 5362.249285100089, 5390.568754499641, 5396.730163491829, 5417.756200970956, 5313.814016509423, 5335.226392173133, 5343.839684809453, 5353.0, 5354.0, 3968.583298753633, 4075.857344992926, 4163.479565054368, 4197.958020419803, 4205.957940420602, 4176.916461670765, 4188.958110418903, 4211.810468528908, 4217.873463796076, 4218.303979843322, 4169.770662613555, 4172.645325147366, 4173.6661067114555, 4181.0, 4182.121754431558, 3961.841526338943, 4058.228936502055, 4146.564610715892, 4151.356539736345, 4164.83340666373, 3688.3360995020885, 3692.8892133236045, 3696.5194524711883, 3700.2599480104086, 3705.7591256568235, 5093.032323858455, 5098.566621837148, 5100.719460429675, 5104.081265372231, 5104.846854594368, 4812.013537224861, 4822.541858523435, 4825.252085926687, 4825.782839772219, 4829.251466022772, 5608.0, 5625.156226566007, 5628.831135065954, 5629.774809007635, 5631.2397826293745, 4052.615001574846, 4061.1877624475223, 4064.2074795414906, 4065.125997910434, 4068.0643452005907, 5674.602777805555, 5914.349421563625, 5921.111833225008, 5921.141434491975, 5948.702564871783, 3935.9803200984384, 4026.979865100656, 4028.3957406389277, 4029.315016447211, 4036.919261614751, 4084.305668036441, 4088.7342322748927, 4088.7751173685137, 4089.5501494835544, 4090.3046482098116, 4683.695559788603, 4688.742119183477, 4690.835820746258, 4692.1084993851055, 4699.765011749399, 5574.721263936868, 5599.0, 5604.60767746262, 5621.381648018714, 5623.746931388097, 1483.391809358158, 1499.520153550875, 1501.129344979909, 1504.0749938787785, 1509.622594351412, 945.1871390604075, 988.471167925171, 1011.4184344002228, 1025.8102251083574, 1037.865077539915, 4833.951660483421, 4834.468208497063, 4841.733704646208, 4864.927026094611, 4881.096997055556, 5765.538756899438, 5769.942300577024, 5769.971150144306, 5774.797882074107, 5782.59521833476, 4857.635677324215, 4867.7322747249245, 4871.585915197177, 4878.341423907798, 4884.12085824555, 3047.8933237336587, 3099.0, 3103.069079276208, 3104.674009229044, 3105.4254962831496, 5423.050966080999, 5436.048691478975, 5448.318960129984, 5448.509634132947, 5450.209719590637, 5730.255066841284, 5890.3815099414805, 5898.3216930053595, 5898.380670029671, 5916.2013128228, 5382.41218840443, 5396.595255355864, 5410.945890541123, 5417.918731219113, 5422.918656220081, 5749.655020698771, 5753.338366087954, 5755.568332375173, 5764.250647415809, 5765.106408506688, 5609.046462101534, 5616.4383561645145, 5616.5787565931905, 5619.353774316006, 5621.128725047624, 5390.460953904735, 5408.405075441619, 5413.918791218056, 5414.485623865727, 5421.3765416975975, 3873.1091848874353, 4018.5378681452007, 4043.474348334698, 4049.4735684360844, 4182.393552934868, 5724.542036637143, 5758.309002919509, 5758.3090029196765, 5763.0, 5770.3652598215, 5563.638363506359, 5573.052581061311, 5582.581306401955, 5583.888322233452, 5586.13414920688, 5557.44425557441, 5589.496945274945, 5591.356993945748, 5594.049011667945, 5597.972010139923, 5482.095454250004, 5482.643628164156, 5497.257870187474, 5498.532624726943, 5498.642588231752, 5447.536959358499, 5621.55027597783, 5666.433356664301, 5682.204491371294, 5685.77256909719, 5468.425815289337, 5515.09001014828, 5528.806491772769, 5534.1975413564005, 5551.417101204315], "unit": "score", "name": "prototype.html", "value": 4226.930357204298}, {"lowerIsBetter": false, "replicates": [679.3444326225192, 682.8463595690969, 738.8596166728324, 741.8034220931453, 800.6797281087564, 12634.052446066537, 12794.744105117892, 12811.935940320309, 12844.422001009954, 12863.099583029192, 11965.22226055308, 12034.09744269179, 12056.879431205685, 12067.879321206785, 12068.939655301732, 655.3381085104055, 795.32397462157, 813.3127507256359, 831.6590198018813, 834.1616675241374, 809.0897740042452, 822.5722624235394, 825.5789547330844, 828.200786241277, 828.2918105020211, 870.0255713600744, 875.9912400875974, 876.1676407412951, 876.5836227791812, 876.7808047988003, 689.2074114768006, 842.6460886427715, 851.1573542193246, 853.5134973065356, 853.9871901921476, 621.7233331167632, 623.8939380305359, 625.4808508937571, 626.7023163997111, 627.0061951806392, 12627.93686031564, 12667.746645067047, 12697.238165710087, 12715.427805748763, 12719.618411447578, 12220.877791222063, 12632.11575189728, 12824.422900969386, 12996.090273680846, 13019.283939383331, 10086.495675216283, 10143.391396516232, 10175.0, 10252.94873525635, 10532.104771094466, 3406.131436483681, 3437.295354452331, 3462.3594634992605, 3469.809160496172, 3548.6451354864566, 41662.37506437406, 41824.58175418237, 41851.58148418507, 41992.0, 42661.99999999969, 9719.757006074904, 9799.510024498746, 9847.901520984842, 10042.146417554444, 10068.144207742424, 18148.63702725938, 18149.909250453664, 18153.0, 18179.63640727178, 18239.63520729578, 6771.52599318043, 6827.112475378169, 6894.758683446055, 7117.3238542338395, 7276.490645654753, 3451.447768357051, 3463.341965026637, 3482.3557641835837, 3491.633378495272, 3503.2993401319836, 2717.55160398532, 2753.8347699138117, 2753.8898444062015, 2753.8898444062415, 2761.8619069046867, 448.2827476038378, 453.2951260789504, 461.2044223714066, 463.87707257576767, 464.4844222912564, 550.7163810637525, 624.1168746224042, 629.8519847835755, 630.5523078614143, 633.8827316946288, 8064.274215320649, 8156.265936065783, 8264.256216940505, 8290.91409366958, 8309.335253179732, 534.286727219159, 575.4878158438993, 616.8827922694763, 626.1421852062704, 636.2365161805759, 3647.379945409287, 3773.1510410158044, 3921.745086569364, 3928.273269445162, 4008.198360327946, 48734.75632621814, 50101.0, 50200.49799502031, 51099.74450127726, 51111.23333150006, 45575.0, 45959.77020114878, 46136.0, 46207.76896115565, 46387.76806115948, 41601.37597936033, 41777.0, 41920.37119443211, 41950.37074443886, 42227.0, 7524.623768811647, 7563.394928405604, 7643.503172293783, 7656.081270247606, 7744.728934487266, 30615.54076688807, 31239.0, 31387.0, 31579.0, 31727.52408713825, 36440.81779591085, 39986.400203997546, 40531.0, 40894.38658420066, 40930.59069409268, 10077.949610251902, 10078.79842403133, 10139.645112421325, 10177.389356638625, 10470.371777693363, 10476.214283928888, 10604.840927385942, 10640.733981650521, 10684.198685098803, 11945.940270298594, 11079.169062320198, 11215.831762523405, 11225.4387280634, 11249.66251012471, 11480.655580332603, 10754.193435492525, 10903.0, 11064.612738554111, 11078.937552759195, 11488.253263537843, 10908.563657453931, 11012.834807478055, 11014.39420831862, 11326.32042077478, 11597.76804463923, 9590.856137157809, 9598.0, 9626.47054412014, 9987.450690212108, 10244.692659220234, 9506.667266645634, 9659.661911833053, 9698.440519527088, 9712.125908668253, 9881.110700037032], "unit": "score", "name": "yui.html", "value": 5930.860713067341}], "name": "dromaeo_css", "value": 6299.426762657586}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 118.0, 109.0, 113.0, 114.0, 114.0, 104.0, 113.0, 115.0, 114.0], "unit": "score", "name": "ai-astar", "value": 112.6}, {"lowerIsBetter": true, "replicates": [156.0, 129.0, 157.0, 176.0, 133.0, 155.0, 157.0, 132.0, 177.0, 133.0], "unit": "score", "name": "audio-beat-detection", "value": 150.5}, {"lowerIsBetter": true, "replicates": [162.0, 162.0, 161.0, 162.0, 161.0, 162.0, 161.0, 161.0, 162.0, 162.0], "unit": "score", "name": "audio-dft", "value": 161.6}, {"lowerIsBetter": true, "replicates": [74.0, 74.0, 105.0, 103.0, 73.0, 74.0, 76.0, 113.0, 99.0, 74.0], "unit": "score", "name": "audio-fft", "value": 86.5}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 149.0, 95.0, 95.0, 94.0, 137.0, 95.0, 94.0, 137.0], "unit": "score", "name": "audio-oscillator", "value": 108.7}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 116.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.0}, {"lowerIsBetter": true, "replicates": [145.0, 145.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.9}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 95.0, 96.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.3}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 66.0, 66.0, 65.0, 65.0, 66.0, 74.0, 63.0, 63.0], "unit": "score", "name": "json-parse-financial", "value": 66.2}, {"lowerIsBetter": true, "replicates": [64.0, 63.0, 63.0, 63.0, 64.0, 63.0, 65.0, 63.0, 64.0, 63.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 63.5}, {"lowerIsBetter": true, "replicates": [90.0, 84.0, 84.0, 83.0, 92.0, 81.0, 83.0, 82.0, 84.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.6}, {"lowerIsBetter": true, "replicates": [115.0, 117.0, 125.0, 116.0, 126.0, 119.0, 120.0, 116.0, 127.0, 115.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 119.6}, {"lowerIsBetter": true, "replicates": [157.0, 138.0, 146.0, 149.0, 144.0, 135.0, 155.0, 140.0, 143.0, 142.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 144.9}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 67.0, 67.0, 70.0, 71.0, 68.0, 68.0, 68.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.4}], "name": "kraken", "value": 1525.3}]} 18:31:19 INFO - Return code: 0 18:31:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 18:31:19 ERROR - # TBPL SUCCESS # 18:31:19 INFO - Running post-action listener: _resource_record_post_action 18:31:19 INFO - Running post-run listener: _resource_record_post_run 18:31:20 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 0; Write bytes: 528879616; Read time: 0; Write time: 759300 18:31:20 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 242892800; Read time: 0; Write time: 466632 18:31:20 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 0; Write bytes: 285388800; Read time: 0; Write time: 292424 18:31:20 INFO - Running post-run listener: _upload_blobber_files 18:31:20 INFO - Blob upload gear active. 18:31:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:31:20 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 18:31:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:31:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:31:21 INFO - (blobuploader) - INFO - Open directory for files ... 18:31:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 18:31:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:31:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:31:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 18:31:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:31:21 INFO - (blobuploader) - INFO - Done attempting. 18:31:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 18:31:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:31:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:31:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 18:31:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:31:22 INFO - (blobuploader) - INFO - Done attempting. 18:31:22 INFO - (blobuploader) - INFO - Iteration through files over. 18:31:22 INFO - Return code: 0 18:31:22 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:31:22 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:31:22 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4f31a440125e733847b534d0e3aba68cec29476d7f04b9ff8132793b5b3ce196617a74fcfb0b4bac9e96cd0ea5165eb0226b054f2b61ef7e71aacf5a440ca995", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/381c493f99753a801266eeb39884ceb7eb0f9166304c4c948bcd69db2196bb8c0e3dc6320bed44ededac46f5174600b7182fd06e697b185473e86a5380b1b5b6"} 18:31:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:31:22 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:31:22 INFO - Contents: 18:31:22 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4f31a440125e733847b534d0e3aba68cec29476d7f04b9ff8132793b5b3ce196617a74fcfb0b4bac9e96cd0ea5165eb0226b054f2b61ef7e71aacf5a440ca995", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/381c493f99753a801266eeb39884ceb7eb0f9166304c4c948bcd69db2196bb8c0e3dc6320bed44ededac46f5174600b7182fd06e697b185473e86a5380b1b5b6"} 18:31:22 INFO - Running post-run listener: copy_logs_to_upload_dir 18:31:22 INFO - Copying logs to upload dir... 18:31:22 INFO - mkdir: /builds/slave/test/build/upload/logs 18:31:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.140543 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-04-01 18:31:22.270868) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-01 18:31:22.274617) ========= 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=5bd038846534b2fdfa68eeae000001e2-1459559316.70669-633906442 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4f31a440125e733847b534d0e3aba68cec29476d7f04b9ff8132793b5b3ce196617a74fcfb0b4bac9e96cd0ea5165eb0226b054f2b61ef7e71aacf5a440ca995", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/381c493f99753a801266eeb39884ceb7eb0f9166304c4c948bcd69db2196bb8c0e3dc6320bed44ededac46f5174600b7182fd06e697b185473e86a5380b1b5b6"} build_url:https://queue.taskcluster.net/v1/task/ccpaxqcLQbOMDNmQGQ49FQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011204 build_url: 'https://queue.taskcluster.net/v1/task/ccpaxqcLQbOMDNmQGQ49FQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4f31a440125e733847b534d0e3aba68cec29476d7f04b9ff8132793b5b3ce196617a74fcfb0b4bac9e96cd0ea5165eb0226b054f2b61ef7e71aacf5a440ca995", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/381c493f99753a801266eeb39884ceb7eb0f9166304c4c948bcd69db2196bb8c0e3dc6320bed44ededac46f5174600b7182fd06e697b185473e86a5380b1b5b6"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-01 18:31:22.299902) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 18:31:22.300415) ========= 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=5bd038846534b2fdfa68eeae000001e2-1459559316.70669-633906442 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004477 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 18:31:22.382428) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-01 18:31:22.382724) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-01 18:31:22.382991) ========= ========= Total master_lag: 0.29 =========